builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-031 starttime: 1482463446.67 results: success (0) buildid: 20161222183754 builduid: dee82441c0744801b44dbb935098a21e revision: 2785aaf276ba29fb2e1f5607d90d441fee42efb4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 19:24:06.665978) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 19:24:06.666555) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 19:24:06.666841) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 19:24:06.686941) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 19:24:06.687224) ========= 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=db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-22 19:24:06-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 18.0M=0.001s 2016-12-22 19:24:07 (18.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.103547 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 19:24:06.810125) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 19:24:06.810424) ========= 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=db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013873 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 19:24:06.865118) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-22 19:24:06.865460) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2785aaf276ba29fb2e1f5607d90d441fee42efb4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 2785aaf276ba29fb2e1f5607d90d441fee42efb4 --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=db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-22 19:24:07,149 truncating revision to first 12 chars 2016-12-22 19:24:07,149 Setting DEBUG logging. 2016-12-22 19:24:07,149 attempt 1/10 2016-12-22 19:24:07,149 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2785aaf276ba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-22 19:24:09,028 unpacking tar archive at: mozilla-central-2785aaf276ba/testing/mozharness/ program finished with exit code 0 elapsedTime=2.173166 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-22 19:24:09.055326) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 19:24:09.055880) ========= script_repo_revision: 2785aaf276ba29fb2e1f5607d90d441fee42efb4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 19:24:09.057067) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 19:24:09.057572) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 19:24:09.069784) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-12-22 19:24:09.070138) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:24:09 INFO - MultiFileLogger online at 20161222 19:24:09 in /builds/slave/test 19:24:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 19:24:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:24:09 INFO - {'append_to_log': False, 19:24:09 INFO - 'base_work_dir': '/builds/slave/test', 19:24:09 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 19:24:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:24:09 INFO - 'branch': 'Firefox-Non-PGO', 19:24:09 INFO - 'buildbot_json_path': 'buildprops.json', 19:24:09 INFO - 'config_files': ('talos/linux_config.py',), 19:24:09 INFO - 'default_actions': ('clobber', 19:24:09 INFO - 'read-buildbot-config', 19:24:09 INFO - 'download-and-extract', 19:24:09 INFO - 'populate-webroot', 19:24:09 INFO - 'create-virtualenv', 19:24:09 INFO - 'install', 19:24:09 INFO - 'run-tests'), 19:24:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:24:09 INFO - 'download_minidump_stackwalk': True, 19:24:09 INFO - 'download_symbols': 'ondemand', 19:24:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:24:09 INFO - 'tooltool.py': '/tools/tooltool.py', 19:24:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:24:09 INFO - '/tools/misc-python/virtualenv.py')}, 19:24:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:24:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:24:09 INFO - 'installer_path': 'installer.exe', 19:24:09 INFO - 'log_level': 'info', 19:24:09 INFO - 'log_name': 'talos', 19:24:09 INFO - 'log_to_console': True, 19:24:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:24:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:24:09 INFO - 'opt_config_files': (), 19:24:09 INFO - 'pip_index': False, 19:24:09 INFO - 'sps_profile': False, 19:24:09 INFO - 'sps_profile_interval': 0, 19:24:09 INFO - 'suite': 'dromaeojs-e10s', 19:24:09 INFO - 'system_bits': '32', 19:24:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:24:09 INFO - 'title': 'talos-linux64-ix-031', 19:24:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:24:09 INFO - 'use_talos_json': True, 19:24:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:24:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:24:09 INFO - 'work_dir': 'build'} 19:24:09 INFO - [mozharness: 2016-12-23 03:24:09.458731Z] Running clobber step. 19:24:09 INFO - Running pre-action listener: _resource_record_pre_action 19:24:09 INFO - Running main action method: clobber 19:24:09 INFO - rmtree: /builds/slave/test/build 19:24:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:24:09 INFO - Running post-action listener: _resource_record_post_action 19:24:09 INFO - [mozharness: 2016-12-23 03:24:09.928247Z] Finished clobber step (success) 19:24:09 INFO - [mozharness: 2016-12-23 03:24:09.928347Z] Running read-buildbot-config step. 19:24:09 INFO - Running pre-action listener: _resource_record_pre_action 19:24:09 INFO - Running main action method: read_buildbot_config 19:24:09 INFO - Using buildbot properties: 19:24:09 INFO - { 19:24:09 INFO - "project": "", 19:24:09 INFO - "product": "firefox", 19:24:09 INFO - "script_repo_revision": "production", 19:24:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:24:09 INFO - "repository": "", 19:24:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 19:24:09 INFO - "buildid": "20161222183754", 19:24:09 INFO - "pgo_build": "False", 19:24:09 INFO - "basedir": "/builds/slave/test", 19:24:09 INFO - "buildnumber": 615, 19:24:09 INFO - "slavename": "talos-linux64-ix-031", 19:24:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:24:09 INFO - "platform": "ubuntu64_hw", 19:24:09 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 19:24:09 INFO - "branch": "mozilla-central", 19:24:09 INFO - "repo_path": "mozilla-central", 19:24:09 INFO - "revision": "2785aaf276ba29fb2e1f5607d90d441fee42efb4", 19:24:09 INFO - "stage_platform": "linux64", 19:24:09 INFO - "builduid": "dee82441c0744801b44dbb935098a21e", 19:24:09 INFO - "slavebuilddir": "test" 19:24:09 INFO - } 19:24:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/KGZCcvIuSgW3n5hv2REF3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 19:24:09 INFO - Running post-action listener: _resource_record_post_action 19:24:09 INFO - [mozharness: 2016-12-23 03:24:09.930798Z] Finished read-buildbot-config step (success) 19:24:09 INFO - [mozharness: 2016-12-23 03:24:09.930887Z] Running download-and-extract step. 19:24:09 INFO - Running pre-action listener: _resource_record_pre_action 19:24:09 INFO - Running main action method: download_and_extract 19:24:09 INFO - mkdir: /builds/slave/test/build/tests 19:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:09 INFO - trying https://queue.taskcluster.net/v1/task/KGZCcvIuSgW3n5hv2REF3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 19:24:09 INFO - Downloading https://queue.taskcluster.net/v1/task/KGZCcvIuSgW3n5hv2REF3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 19:24:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KGZCcvIuSgW3n5hv2REF3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:24:10 INFO - Downloaded 1361 bytes. 19:24:10 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 19:24:10 INFO - Using the following test package requirements: 19:24:10 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 19:24:10 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:24:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:24:10 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:24:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:24:10 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:24:10 INFO - u'jsshell-linux-x86_64.zip'], 19:24:10 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:24:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:24:10 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 19:24:10 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:24:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:24:10 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:24:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:24:10 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:24:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:24:10 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:24:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:24:10 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:24:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KGZCcvIuSgW3n5hv2REF3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 19:24:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KGZCcvIuSgW3n5hv2REF3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:24:10 INFO - Fetch https://queue.taskcluster.net/v1/task/KGZCcvIuSgW3n5hv2REF3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:24:11 INFO - Expected file size: 20236300 19:24:11 INFO - Obtained file size: 20236300 19:24:15 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:24:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KGZCcvIuSgW3n5hv2REF3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 19:24:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KGZCcvIuSgW3n5hv2REF3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:24:15 INFO - Fetch https://queue.taskcluster.net/v1/task/KGZCcvIuSgW3n5hv2REF3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:24:16 INFO - Expected file size: 20236300 19:24:16 INFO - Obtained file size: 20236300 19:24:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KGZCcvIuSgW3n5hv2REF3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 19:24:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KGZCcvIuSgW3n5hv2REF3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:24:20 INFO - Fetch https://queue.taskcluster.net/v1/task/KGZCcvIuSgW3n5hv2REF3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 19:24:21 INFO - Expected file size: 14409776 19:24:21 INFO - Obtained file size: 14409776 19:24:21 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')]} 19:24:21 INFO - trying https://queue.taskcluster.net/v1/task/KGZCcvIuSgW3n5hv2REF3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:24:21 INFO - Downloading https://queue.taskcluster.net/v1/task/KGZCcvIuSgW3n5hv2REF3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:24:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KGZCcvIuSgW3n5hv2REF3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:24:22 INFO - Downloaded 55926542 bytes. 19:24:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KGZCcvIuSgW3n5hv2REF3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:24:22 INFO - mkdir: /builds/slave/test/properties 19:24:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:24:22 INFO - Writing to file /builds/slave/test/properties/build_url 19:24:22 INFO - Contents: 19:24:22 INFO - build_url:https://queue.taskcluster.net/v1/task/KGZCcvIuSgW3n5hv2REF3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:24:23 INFO - Running post-action listener: _resource_record_post_action 19:24:23 INFO - Running post-action listener: set_extra_try_arguments 19:24:23 INFO - [mozharness: 2016-12-23 03:24:23.128822Z] Finished download-and-extract step (success) 19:24:23 INFO - [mozharness: 2016-12-23 03:24:23.129050Z] Running populate-webroot step. 19:24:23 INFO - Running pre-action listener: _resource_record_pre_action 19:24:23 INFO - Running main action method: populate_webroot 19:24:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:24:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:24:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:24:23 INFO - '--tppagecycles', 19:24:23 INFO - '7'], 19:24:23 INFO - 'tests': ['tsvgm']}}, 19:24:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:24:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:24:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:24:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:24:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:24:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:24:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:24:23 INFO - 'talos_options': ['--disable-e10s'], 19:24:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:24:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:24:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:24:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:24:23 INFO - 'talos_options': ['--disable-e10s'], 19:24:23 INFO - 'tests': ['damp', 'tps']}, 19:24:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:24:23 INFO - 'tests': ['damp', 'tps']}, 19:24:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:24:23 INFO - 'tests': ['dromaeo_dom']}, 19:24:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:24:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:24:23 INFO - 'tests': ['basic_compositor_video']}, 19:24:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:24:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:24:23 INFO - 'tests': ['a11yr', 19:24:23 INFO - 'ts_paint', 19:24:23 INFO - 'tpaint', 19:24:23 INFO - 'sessionrestore', 19:24:23 INFO - 'sessionrestore_no_auto_restore', 19:24:23 INFO - 'tabpaint']}, 19:24:23 INFO - 'other-e10s': {'tests': ['a11yr', 19:24:23 INFO - 'ts_paint', 19:24:23 INFO - 'tpaint', 19:24:23 INFO - 'sessionrestore', 19:24:23 INFO - 'sessionrestore_no_auto_restore', 19:24:23 INFO - 'tabpaint']}, 19:24:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:24:23 INFO - 'ts_paint', 19:24:23 INFO - 'tpaint', 19:24:23 INFO - 'sessionrestore', 19:24:23 INFO - 'sessionrestore_no_auto_restore', 19:24:23 INFO - 'tabpaint']}, 19:24:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:24:23 INFO - 'ts_paint', 19:24:23 INFO - 'tpaint', 19:24:23 INFO - 'sessionrestore', 19:24:23 INFO - 'sessionrestore_no_auto_restore', 19:24:23 INFO - 'tabpaint']}, 19:24:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:24:23 INFO - 'tests': ['a11yr', 19:24:23 INFO - 'ts_paint', 19:24:23 INFO - 'tpaint', 19:24:23 INFO - 'sessionrestore', 19:24:23 INFO - 'sessionrestore_no_auto_restore', 19:24:23 INFO - 'tabpaint']}, 19:24:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:24:23 INFO - 'tests': ['a11yr', 19:24:23 INFO - 'ts_paint', 19:24:23 INFO - 'tpaint', 19:24:23 INFO - 'sessionrestore', 19:24:23 INFO - 'sessionrestore_no_auto_restore', 19:24:23 INFO - 'tabpaint']}, 19:24:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:24:23 INFO - 'tests': ['tsvgx', 19:24:23 INFO - 'tsvgr_opacity', 19:24:23 INFO - 'tart', 19:24:23 INFO - 'tscrollx', 19:24:23 INFO - 'cart', 19:24:23 INFO - 'tsvg_static']}, 19:24:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:24:23 INFO - 'tsvgr_opacity', 19:24:23 INFO - 'tart', 19:24:23 INFO - 'tscrollx', 19:24:23 INFO - 'cart', 19:24:23 INFO - 'tsvg_static']}, 19:24:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:24:23 INFO - 'talos_options': ['--disable-e10s'], 19:24:23 INFO - 'tests': ['tp5o']}, 19:24:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:24:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:24:23 INFO - 'talos_options': ['--disable-e10s', 19:24:23 INFO - '--xperf_path', 19:24:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:24:23 INFO - 'tests': ['tp5n']}, 19:24:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:24:23 INFO - 'talos_options': ['--xperf_path', 19:24:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:24:23 INFO - 'tests': ['tp5n']}}, 19:24:23 INFO - 'talos.zip': {'path': '', 19:24:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:24:23 INFO - Running post-action listener: _resource_record_post_action 19:24:23 INFO - [mozharness: 2016-12-23 03:24:23.144825Z] Finished populate-webroot step (success) 19:24:23 INFO - [mozharness: 2016-12-23 03:24:23.144914Z] Running create-virtualenv step. 19:24:23 INFO - Running pre-action listener: _resource_record_pre_action 19:24:23 INFO - Running main action method: create_virtualenv 19:24:23 INFO - Creating virtualenv /builds/slave/test/build/venv 19:24:23 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:24:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:24:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:24:23 INFO - Using real prefix '/usr' 19:24:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:24:23 INFO - Installing distribute.............................................................................................................................................................................................done. 19:24:25 INFO - Installing pip.................done. 19:24:25 INFO - Return code: 0 19:24:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:24:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:24:25 INFO - Reading from file tmpfile_stdout 19:24:25 INFO - Output received: 19:24:25 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 19:24:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2278820>, '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 0x2279520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22799b0>, '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': 'db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:24:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:24:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:24:25 INFO - Using env: {'DISPLAY': ':0', 19:24:25 INFO - 'HOME': '/home/cltbld', 19:24:25 INFO - 'LANG': 'en_US.UTF-8', 19:24:25 INFO - 'LANGUAGE': 'en_US:en', 19:24:25 INFO - 'LOGNAME': 'cltbld', 19:24:25 INFO - 'MAIL': '/var/mail/cltbld', 19:24:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:25 INFO - 'MOZ_NO_REMOTE': '1', 19:24:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:25 INFO - 'NO_EM_RESTART': '1', 19:24:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:25 INFO - 'PWD': '/builds/slave/test', 19:24:25 INFO - 'SHELL': '/bin/bash', 19:24:25 INFO - 'SHLVL': '1', 19:24:25 INFO - 'TERM': 'linux', 19:24:25 INFO - 'TMOUT': '86400', 19:24:25 INFO - 'USER': 'cltbld', 19:24:25 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560', 19:24:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:25 INFO - '_': '/tools/buildbot/bin/python'} 19:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:24:26 INFO - Cleaning up... 19:24:26 INFO - Return code: 0 19:24:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2278820>, '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 0x2279520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22799b0>, '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': 'db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:24:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:24:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:24:26 INFO - Using env: {'DISPLAY': ':0', 19:24:26 INFO - 'HOME': '/home/cltbld', 19:24:26 INFO - 'LANG': 'en_US.UTF-8', 19:24:26 INFO - 'LANGUAGE': 'en_US:en', 19:24:26 INFO - 'LOGNAME': 'cltbld', 19:24:26 INFO - 'MAIL': '/var/mail/cltbld', 19:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:26 INFO - 'MOZ_NO_REMOTE': '1', 19:24:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:26 INFO - 'NO_EM_RESTART': '1', 19:24:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:26 INFO - 'PWD': '/builds/slave/test', 19:24:26 INFO - 'SHELL': '/bin/bash', 19:24:26 INFO - 'SHLVL': '1', 19:24:26 INFO - 'TERM': 'linux', 19:24:26 INFO - 'TMOUT': '86400', 19:24:26 INFO - 'USER': 'cltbld', 19:24:26 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560', 19:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:26 INFO - '_': '/tools/buildbot/bin/python'} 19:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:26 INFO - Downloading/unpacking psutil>=3.1.1 19:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:24:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:24:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:24:28 INFO - Installing collected packages: psutil 19:24:28 INFO - Running setup.py install for psutil 19:24:28 INFO - building 'psutil._psutil_linux' extension 19:24:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:24:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:24:28 INFO - building 'psutil._psutil_posix' extension 19:24:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:24:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:24:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:24:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:24:28 INFO - Successfully installed psutil 19:24:28 INFO - Cleaning up... 19:24:29 INFO - Return code: 0 19:24:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:24:29 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')]} 19:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:29 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')]} 19:24:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:29 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 0x1f091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2278820>, '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 0x2279520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22799b0>, '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': 'db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:24:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:24:29 INFO - Using env: {'DISPLAY': ':0', 19:24:29 INFO - 'HOME': '/home/cltbld', 19:24:29 INFO - 'LANG': 'en_US.UTF-8', 19:24:29 INFO - 'LANGUAGE': 'en_US:en', 19:24:29 INFO - 'LOGNAME': 'cltbld', 19:24:29 INFO - 'MAIL': '/var/mail/cltbld', 19:24:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:29 INFO - 'MOZ_NO_REMOTE': '1', 19:24:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:29 INFO - 'NO_EM_RESTART': '1', 19:24:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:29 INFO - 'PWD': '/builds/slave/test', 19:24:29 INFO - 'SHELL': '/bin/bash', 19:24:29 INFO - 'SHLVL': '1', 19:24:29 INFO - 'TERM': 'linux', 19:24:29 INFO - 'TMOUT': '86400', 19:24:29 INFO - 'USER': 'cltbld', 19:24:29 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560', 19:24:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:29 INFO - '_': '/tools/buildbot/bin/python'} 19:24:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:24:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:24:31 INFO - Installing collected packages: mozsystemmonitor 19:24:31 INFO - Running setup.py install for mozsystemmonitor 19:24:31 INFO - Successfully installed mozsystemmonitor 19:24:31 INFO - Cleaning up... 19:24:31 INFO - Return code: 0 19:24:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2278820>, '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 0x2279520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22799b0>, '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': 'db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:24:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:24:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:24:31 INFO - Using env: {'DISPLAY': ':0', 19:24:31 INFO - 'HOME': '/home/cltbld', 19:24:31 INFO - 'LANG': 'en_US.UTF-8', 19:24:31 INFO - 'LANGUAGE': 'en_US:en', 19:24:31 INFO - 'LOGNAME': 'cltbld', 19:24:31 INFO - 'MAIL': '/var/mail/cltbld', 19:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:31 INFO - 'MOZ_NO_REMOTE': '1', 19:24:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:31 INFO - 'NO_EM_RESTART': '1', 19:24:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:31 INFO - 'PWD': '/builds/slave/test', 19:24:31 INFO - 'SHELL': '/bin/bash', 19:24:31 INFO - 'SHLVL': '1', 19:24:31 INFO - 'TERM': 'linux', 19:24:31 INFO - 'TMOUT': '86400', 19:24:31 INFO - 'USER': 'cltbld', 19:24:31 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560', 19:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:31 INFO - '_': '/tools/buildbot/bin/python'} 19:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:31 INFO - Downloading/unpacking jsonschema==2.5.1 19:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:24:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:33 INFO - Downloading functools32-3.2.3-2.tar.gz 19:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:24:33 INFO - warning: no files found matching '*.txt' 19:24:33 INFO - no previously-included directories found matching 'build' 19:24:33 INFO - no previously-included directories found matching 'dist' 19:24:33 INFO - no previously-included directories found matching '.git*' 19:24:33 INFO - Installing collected packages: jsonschema, functools32 19:24:34 INFO - Running setup.py install for functools32 19:24:34 INFO - warning: no files found matching '*.txt' 19:24:34 INFO - no previously-included directories found matching 'build' 19:24:34 INFO - no previously-included directories found matching 'dist' 19:24:34 INFO - no previously-included directories found matching '.git*' 19:24:34 INFO - Successfully installed jsonschema functools32 19:24:34 INFO - Cleaning up... 19:24:34 INFO - Return code: 0 19:24:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:24: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')]} 19:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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')]} 19:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:34 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 0x1f091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2278820>, '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 0x2279520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22799b0>, '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': 'db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:24:34 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 19:24:34 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 19:24:34 INFO - Using env: {'DISPLAY': ':0', 19:24:34 INFO - 'HOME': '/home/cltbld', 19:24:34 INFO - 'LANG': 'en_US.UTF-8', 19:24:34 INFO - 'LANGUAGE': 'en_US:en', 19:24:34 INFO - 'LOGNAME': 'cltbld', 19:24:34 INFO - 'MAIL': '/var/mail/cltbld', 19:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:34 INFO - 'MOZ_NO_REMOTE': '1', 19:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:34 INFO - 'NO_EM_RESTART': '1', 19:24:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:34 INFO - 'PWD': '/builds/slave/test', 19:24:34 INFO - 'SHELL': '/bin/bash', 19:24:34 INFO - 'SHLVL': '1', 19:24:34 INFO - 'TERM': 'linux', 19:24:34 INFO - 'TMOUT': '86400', 19:24:34 INFO - 'USER': 'cltbld', 19:24:34 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560', 19:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:34 INFO - '_': '/tools/buildbot/bin/python'} 19:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:24:34 INFO - Cleaning up... 19:24:34 INFO - Return code: 0 19:24:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:24: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')]} 19:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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')]} 19:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:34 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 0x1f091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2278820>, '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 0x2279520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22799b0>, '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': 'db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:24:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:24:34 INFO - Using env: {'DISPLAY': ':0', 19:24:34 INFO - 'HOME': '/home/cltbld', 19:24:34 INFO - 'LANG': 'en_US.UTF-8', 19:24:34 INFO - 'LANGUAGE': 'en_US:en', 19:24:34 INFO - 'LOGNAME': 'cltbld', 19:24:34 INFO - 'MAIL': '/var/mail/cltbld', 19:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:34 INFO - 'MOZ_NO_REMOTE': '1', 19:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:34 INFO - 'NO_EM_RESTART': '1', 19:24:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:34 INFO - 'PWD': '/builds/slave/test', 19:24:34 INFO - 'SHELL': '/bin/bash', 19:24:34 INFO - 'SHLVL': '1', 19:24:34 INFO - 'TERM': 'linux', 19:24:34 INFO - 'TMOUT': '86400', 19:24:34 INFO - 'USER': 'cltbld', 19:24:34 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560', 19:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:34 INFO - '_': '/tools/buildbot/bin/python'} 19:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:34 INFO - Downloading/unpacking blobuploader==1.2.4 19:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:36 INFO - Downloading blobuploader-1.2.4.tar.gz 19:24:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:24:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:24:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:37 INFO - Downloading docopt-0.6.1.tar.gz 19:24:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:24:37 INFO - Installing collected packages: blobuploader, requests, docopt 19:24:37 INFO - Running setup.py install for blobuploader 19:24:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:24:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:24:37 INFO - Running setup.py install for requests 19:24:37 INFO - Running setup.py install for docopt 19:24:37 INFO - Successfully installed blobuploader requests docopt 19:24:37 INFO - Cleaning up... 19:24:37 INFO - Return code: 0 19:24:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:38 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 0x1f091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2278820>, '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 0x2279520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22799b0>, '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': 'db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:24:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:24:38 INFO - Using env: {'DISPLAY': ':0', 19:24:38 INFO - 'HOME': '/home/cltbld', 19:24:38 INFO - 'LANG': 'en_US.UTF-8', 19:24:38 INFO - 'LANGUAGE': 'en_US:en', 19:24:38 INFO - 'LOGNAME': 'cltbld', 19:24:38 INFO - 'MAIL': '/var/mail/cltbld', 19:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:38 INFO - 'MOZ_NO_REMOTE': '1', 19:24:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:38 INFO - 'NO_EM_RESTART': '1', 19:24:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:38 INFO - 'PWD': '/builds/slave/test', 19:24:38 INFO - 'SHELL': '/bin/bash', 19:24:38 INFO - 'SHLVL': '1', 19:24:38 INFO - 'TERM': 'linux', 19:24:38 INFO - 'TMOUT': '86400', 19:24:38 INFO - 'USER': 'cltbld', 19:24:38 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560', 19:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:38 INFO - '_': '/tools/buildbot/bin/python'} 19:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:24:38 INFO - Running setup.py (path:/tmp/pip-P2idw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:24:38 INFO - Running setup.py (path:/tmp/pip-0ysJ2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:24:38 INFO - Running setup.py (path:/tmp/pip-NQNUwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:24:38 INFO - Running setup.py (path:/tmp/pip-60GiH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:24:38 INFO - Running setup.py (path:/tmp/pip-E4JZeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:24:38 INFO - Running setup.py (path:/tmp/pip-y3eBHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:24:38 INFO - Running setup.py (path:/tmp/pip-9KYLda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:24:38 INFO - Running setup.py (path:/tmp/pip-TukfOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:24:38 INFO - Running setup.py (path:/tmp/pip-a5D55A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:24:38 INFO - Running setup.py (path:/tmp/pip-CdbTx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:24:38 INFO - Running setup.py (path:/tmp/pip-1bOxeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:24:38 INFO - Running setup.py (path:/tmp/pip-nOA6xG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:24:39 INFO - Running setup.py (path:/tmp/pip-F_z7EE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:24:39 INFO - Running setup.py (path:/tmp/pip-LsXqtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:24:39 INFO - Running setup.py (path:/tmp/pip-jr28RO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:24:39 INFO - Running setup.py (path:/tmp/pip-Hg0x6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:24:39 INFO - Running setup.py (path:/tmp/pip-cV0wsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:24:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:24:39 INFO - Running setup.py install for manifestparser 19:24:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:24:39 INFO - Running setup.py install for mozcrash 19:24:39 INFO - Running setup.py install for mozdebug 19:24:39 INFO - Running setup.py install for mozdevice 19:24:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:24:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:24:39 INFO - Running setup.py install for mozfile 19:24:39 INFO - Running setup.py install for mozhttpd 19:24:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:24:40 INFO - Running setup.py install for mozinfo 19:24:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:24:40 INFO - Running setup.py install for mozInstall 19:24:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:24:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:24:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:24:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:24:40 INFO - Running setup.py install for mozleak 19:24:40 INFO - Running setup.py install for mozlog 19:24:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:24:40 INFO - Running setup.py install for moznetwork 19:24:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:24:40 INFO - Running setup.py install for mozprocess 19:24:40 INFO - Running setup.py install for mozprofile 19:24:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:24:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:24:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:24:40 INFO - Running setup.py install for mozrunner 19:24:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:24:40 INFO - Running setup.py install for mozscreenshot 19:24:41 INFO - Running setup.py install for moztest 19:24:41 INFO - Running setup.py install for mozversion 19:24:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:24:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:24:41 INFO - Cleaning up... 19:24:41 INFO - Return code: 0 19:24:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:41 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 0x1f091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2278820>, '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 0x2279520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22799b0>, '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': 'db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:24:41 INFO - Using env: {'DISPLAY': ':0', 19:24:41 INFO - 'HOME': '/home/cltbld', 19:24:41 INFO - 'LANG': 'en_US.UTF-8', 19:24:41 INFO - 'LANGUAGE': 'en_US:en', 19:24:41 INFO - 'LOGNAME': 'cltbld', 19:24:41 INFO - 'MAIL': '/var/mail/cltbld', 19:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:41 INFO - 'MOZ_NO_REMOTE': '1', 19:24:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:41 INFO - 'NO_EM_RESTART': '1', 19:24:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:41 INFO - 'PWD': '/builds/slave/test', 19:24:41 INFO - 'SHELL': '/bin/bash', 19:24:41 INFO - 'SHLVL': '1', 19:24:41 INFO - 'TERM': 'linux', 19:24:41 INFO - 'TMOUT': '86400', 19:24:41 INFO - 'USER': 'cltbld', 19:24:41 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560', 19:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:41 INFO - '_': '/tools/buildbot/bin/python'} 19:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:24:41 INFO - Running setup.py (path:/tmp/pip-KI8Lqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:24:41 INFO - Running setup.py (path:/tmp/pip-j3xLTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:24:41 INFO - Running setup.py (path:/tmp/pip-xcyKhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:24:41 INFO - Running setup.py (path:/tmp/pip-anSU8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:24:41 INFO - Running setup.py (path:/tmp/pip-PQ9Ucp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:24:41 INFO - Running setup.py (path:/tmp/pip-9PmsS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:24:41 INFO - Running setup.py (path:/tmp/pip-ujpRo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:24:41 INFO - Running setup.py (path:/tmp/pip-yWDPTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:24:42 INFO - Running setup.py (path:/tmp/pip-b4denz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:24:42 INFO - Running setup.py (path:/tmp/pip-pJTo3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:24:42 INFO - Running setup.py (path:/tmp/pip-TRJmuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:24:42 INFO - Running setup.py (path:/tmp/pip-HVAmJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:24:42 INFO - Running setup.py (path:/tmp/pip-KNpODE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:24:42 INFO - Running setup.py (path:/tmp/pip-NiKhb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:24:42 INFO - Running setup.py (path:/tmp/pip-Q8K9tg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:24:42 INFO - Running setup.py (path:/tmp/pip-UQ6F7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:24:42 INFO - Running setup.py (path:/tmp/pip-XWBxmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:24:42 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:24:42 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:24:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:24:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:44 INFO - Downloading blessings-1.6.tar.gz 19:24:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:24:44 INFO - Installing collected packages: blessings 19:24:44 INFO - Running setup.py install for blessings 19:24:44 INFO - Successfully installed blessings 19:24:44 INFO - Cleaning up... 19:24:44 INFO - Return code: 0 19:24:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:24:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:24:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:24:45 INFO - Reading from file tmpfile_stdout 19:24:45 INFO - Current package versions: 19:24:45 INFO - argparse == 1.2.1 19:24:45 INFO - blessings == 1.6 19:24:45 INFO - blobuploader == 1.2.4 19:24:45 INFO - docopt == 0.6.1 19:24:45 INFO - functools32 == 3.2.3-2 19:24:45 INFO - jsonschema == 2.5.1 19:24:45 INFO - manifestparser == 1.1 19:24:45 INFO - mozInstall == 1.12 19:24:45 INFO - mozcrash == 1.0 19:24:45 INFO - mozdebug == 0.1 19:24:45 INFO - mozdevice == 0.49 19:24:45 INFO - mozfile == 1.2 19:24:45 INFO - mozhttpd == 0.7 19:24:45 INFO - mozinfo == 0.9 19:24:45 INFO - mozleak == 0.1 19:24:45 INFO - mozlog == 3.4 19:24:45 INFO - moznetwork == 0.27 19:24:45 INFO - mozprocess == 0.23 19:24:45 INFO - mozprofile == 0.28 19:24:45 INFO - mozrunner == 6.13 19:24:45 INFO - mozscreenshot == 0.1 19:24:45 INFO - mozsystemmonitor == 0.3 19:24:45 INFO - moztest == 0.7 19:24:45 INFO - mozversion == 1.4 19:24:45 INFO - psutil == 3.1.1 19:24:45 INFO - requests == 1.2.3 19:24:45 INFO - wsgiref == 0.1.2 19:24:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:24: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')]} 19:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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')]} 19:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:45 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 0x1f091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2278820>, '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 0x2279520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22799b0>, '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': 'db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:24:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:24:45 INFO - Using env: {'DISPLAY': ':0', 19:24:45 INFO - 'HOME': '/home/cltbld', 19:24:45 INFO - 'LANG': 'en_US.UTF-8', 19:24:45 INFO - 'LANGUAGE': 'en_US:en', 19:24:45 INFO - 'LOGNAME': 'cltbld', 19:24:45 INFO - 'MAIL': '/var/mail/cltbld', 19:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:45 INFO - 'MOZ_NO_REMOTE': '1', 19:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:45 INFO - 'NO_EM_RESTART': '1', 19:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:45 INFO - 'PWD': '/builds/slave/test', 19:24:45 INFO - 'SHELL': '/bin/bash', 19:24:45 INFO - 'SHLVL': '1', 19:24:45 INFO - 'TERM': 'linux', 19:24:45 INFO - 'TMOUT': '86400', 19:24:45 INFO - 'USER': 'cltbld', 19:24:45 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560', 19:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:45 INFO - '_': '/tools/buildbot/bin/python'} 19:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:24:45 INFO - Cleaning up... 19:24:45 INFO - Return code: 0 19:24:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:24: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')]} 19:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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')]} 19:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2278820>, '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 0x2279520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22799b0>, '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': 'db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:24: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', 'jsonschema'] in /builds/slave/test/build 19:24: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 jsonschema 19:24:45 INFO - Using env: {'DISPLAY': ':0', 19:24:45 INFO - 'HOME': '/home/cltbld', 19:24:45 INFO - 'LANG': 'en_US.UTF-8', 19:24:45 INFO - 'LANGUAGE': 'en_US:en', 19:24:45 INFO - 'LOGNAME': 'cltbld', 19:24:45 INFO - 'MAIL': '/var/mail/cltbld', 19:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:45 INFO - 'MOZ_NO_REMOTE': '1', 19:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:45 INFO - 'NO_EM_RESTART': '1', 19:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:45 INFO - 'PWD': '/builds/slave/test', 19:24:45 INFO - 'SHELL': '/bin/bash', 19:24:45 INFO - 'SHLVL': '1', 19:24:45 INFO - 'TERM': 'linux', 19:24:45 INFO - 'TMOUT': '86400', 19:24:45 INFO - 'USER': 'cltbld', 19:24:45 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560', 19:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:45 INFO - '_': '/tools/buildbot/bin/python'} 19:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:24:45 INFO - Cleaning up... 19:24:45 INFO - Return code: 0 19:24:45 INFO - Running post-action listener: _resource_record_post_action 19:24:45 INFO - Running post-action listener: _start_resource_monitoring 19:24:45 INFO - Starting resource monitoring. 19:24:45 INFO - [mozharness: 2016-12-23 03:24:45.638795Z] Finished create-virtualenv step (success) 19:24:45 INFO - [mozharness: 2016-12-23 03:24:45.639264Z] Running install step. 19:24:45 INFO - Running pre-action listener: _resource_record_pre_action 19:24:45 INFO - Running main action method: install 19:24:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:24:45 INFO - Reading from file tmpfile_stdout 19:24:45 INFO - Detecting whether we're running mozinstall >=1.0... 19:24:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:24:45 INFO - Reading from file tmpfile_stdout 19:24:45 INFO - Output received: 19:24:45 INFO - Usage: mozinstall [options] installer 19:24:45 INFO - Options: 19:24:45 INFO - -h, --help show this help message and exit 19:24:45 INFO - -d DEST, --destination=DEST 19:24:45 INFO - Directory to install application into. [default: 19:24:45 INFO - "/builds/slave/test"] 19:24:45 INFO - --app=APP Application being installed. [default: firefox] 19:24:45 INFO - mkdir: /builds/slave/test/build/application 19:24:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:25:02 INFO - Reading from file tmpfile_stdout 19:25:02 INFO - Output received: 19:25:02 INFO - /builds/slave/test/build/application/firefox/firefox 19:25:02 INFO - Running post-action listener: _resource_record_post_action 19:25:02 INFO - [mozharness: 2016-12-23 03:25:02.135487Z] Finished install step (success) 19:25:02 INFO - [mozharness: 2016-12-23 03:25:02.135733Z] Running run-tests step. 19:25:02 INFO - Running pre-action listener: _resource_record_pre_action 19:25:02 INFO - Running main action method: run_tests 19:25:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:25:02 INFO - Python 2.7.3 19:25:02 INFO - Return code: 0 19:25:02 INFO - grabbing minidump binary from tooltool 19:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:25:02 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2278820>, '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 0x2279520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22799b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:25:02 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:25:02 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:25:02 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:25:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:25:02 INFO - Return code: 0 19:25:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:25:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:25:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:25:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:25:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:25:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KGZCcvIuSgW3n5hv2REF3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KGZCcvIuSgW3n5hv2REF3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:25:02 INFO - Using env: {'DISPLAY': ':0', 19:25:02 INFO - 'HOME': '/home/cltbld', 19:25:02 INFO - 'LANG': 'en_US.UTF-8', 19:25:02 INFO - 'LANGUAGE': 'en_US:en', 19:25:02 INFO - 'LOGNAME': 'cltbld', 19:25:02 INFO - 'MAIL': '/var/mail/cltbld', 19:25:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:25:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:02 INFO - 'MOZ_NO_REMOTE': '1', 19:25:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:25:02 INFO - 'NO_EM_RESTART': '1', 19:25:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:02 INFO - 'PWD': '/builds/slave/test', 19:25:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:25:02 INFO - 'SHELL': '/bin/bash', 19:25:02 INFO - 'SHLVL': '1', 19:25:02 INFO - 'TERM': 'linux', 19:25:02 INFO - 'TMOUT': '86400', 19:25:02 INFO - 'USER': 'cltbld', 19:25:02 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560', 19:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:02 INFO - '_': '/tools/buildbot/bin/python'} 19:25:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KGZCcvIuSgW3n5hv2REF3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:25:02 INFO - mozversion application_buildid: 20161222183754 19:25:02 INFO - mozversion application_changeset: 2785aaf276ba29fb2e1f5607d90d441fee42efb4 19:25:02 INFO - mozversion application_display_name: Nightly 19:25:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:25:02 INFO - mozversion application_name: Firefox 19:25:02 INFO - mozversion application_remotingname: firefox 19:25:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:25:02 INFO - mozversion application_vendor: Mozilla 19:25:02 INFO - mozversion application_version: 53.0a1 19:25:02 INFO - mozversion platform_buildid: 20161222183754 19:25:02 INFO - mozversion platform_changeset: 2785aaf276ba29fb2e1f5607d90d441fee42efb4 19:25:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:25:02 INFO - mozversion platform_version: 53.0a1 19:25:02 INFO - using testdate: 1482463502 19:25:02 INFO - actual date: 1482463502 19:25:02 INFO - starting webserver on 'localhost:38710' 19:25:02 INFO - SUITE-START | Running 2 tests 19:25:02 INFO - TEST-START | dromaeo_css 19:25:02 INFO - operating with platform_type : linux_ 19:25:02 INFO - Initialising browser for dromaeo_css test... 19:25:02 INFO - TEST-INFO | started process 7815 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBn_kyZ/profile http://localhost:38710/getInfo.html) 19:25:02 INFO - PROCESS | 7815 | 1482463502923 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4979 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3825 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2829 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 19:25:05 INFO - PROCESS | 7815 | JavaScript error: chrome://global/content/browser-content.js, line 1772: ReferenceError: event is not defined 19:25:06 INFO - PROCESS | 7815 | JavaScript error: chrome://global/content/browser-content.js, line 1772: ReferenceError: event is not defined 19:25:06 INFO - PROCESS | 7815 | JavaScript error: chrome://global/content/browser-content.js, line 1772: ReferenceError: event is not defined 19:25:06 INFO - PROCESS | 7815 | __metrics Screen width/height:1600/1200 19:25:06 INFO - PROCESS | 7815 | colorDepth:24 19:25:06 INFO - PROCESS | 7815 | Browser inner width/height: 1024/697 19:25:06 INFO - PROCESS | 7815 | __metrics 19:25:07 ERROR - PROCESS | 7815 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3247: TypeError: this.tabs is undefined 19:25:08 INFO - TEST-INFO | 7815: exit 0 19:25:08 INFO - Browser initialized. 19:25:08 INFO - Running cycle 1/1 for dromaeo_css test... 19:25:08 INFO - TEST-INFO | started process 7935 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBn_kyZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:25:20 INFO - PROCESS | 7935 | RSS: Main: 158572544 19:25:20 INFO - PROCESS | 7935 | 19:26:10 INFO - PROCESS | 7935 | 1482463570019 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:28:22 INFO - PROCESS | 7935 | Cycle 1(1): loaded http://localhost:38710/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38710/tests/dromaeo/cssquery-ext.html) 19:28:25 INFO - PROCESS | 7935 | RSS: Main: 164892672 19:28:25 INFO - PROCESS | 7935 | 19:30:08 INFO - PROCESS | 7935 | ************************* 19:30:08 INFO - PROCESS | 7935 | A coding exception was thrown and uncaught in a Task. 19:30:08 INFO - PROCESS | 7935 | 19:30:08 INFO - PROCESS | 7935 | Full message: ReferenceError: fetch is not defined 19:30:08 INFO - PROCESS | 7935 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 19:30:08 INFO - PROCESS | 7935 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 19:30:08 INFO - PROCESS | 7935 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 19:30:08 INFO - PROCESS | 7935 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 19:30:08 INFO - PROCESS | 7935 | TaskImpl@resource://gre/modules/Task.jsm:277:3 19:30:08 INFO - PROCESS | 7935 | asyncFunction@resource://gre/modules/Task.jsm:252:14 19:30:08 INFO - PROCESS | 7935 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 19:30:08 INFO - PROCESS | 7935 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 19:30:08 INFO - PROCESS | 7935 | TaskImpl@resource://gre/modules/Task.jsm:277:3 19:30:08 INFO - PROCESS | 7935 | asyncFunction@resource://gre/modules/Task.jsm:252:14 19:30:08 INFO - PROCESS | 7935 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 19:30:08 INFO - PROCESS | 7935 | 19:30:08 INFO - PROCESS | 7935 | ************************* 19:31:27 INFO - PROCESS | 7935 | Cycle 1(1): loaded http://localhost:38710/tests/dromaeo/cssquery-ext.html (next: http://localhost:38710/tests/dromaeo/cssquery-jquery.html) 19:31:28 INFO - PROCESS | 7935 | RSS: Main: 162242560 19:31:28 INFO - PROCESS | 7935 | 19:34:30 INFO - PROCESS | 7935 | Cycle 1(1): loaded http://localhost:38710/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38710/tests/dromaeo/cssquery-mootools.html) 19:34:31 INFO - PROCESS | 7935 | RSS: Main: 167915520 19:34:31 INFO - PROCESS | 7935 | 19:37:33 INFO - PROCESS | 7935 | Cycle 1(1): loaded http://localhost:38710/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38710/tests/dromaeo/cssquery-prototype.html) 19:37:34 INFO - PROCESS | 7935 | RSS: Main: 161738752 19:37:34 INFO - PROCESS | 7935 | 19:40:37 INFO - PROCESS | 7935 | Cycle 1(1): loaded http://localhost:38710/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38710/tests/dromaeo/cssquery-yui.html) 19:40:37 INFO - PROCESS | 7935 | RSS: Main: 165601280 19:40:37 INFO - PROCESS | 7935 | 19:43:40 INFO - PROCESS | 7935 | Cycle 1(1): loaded http://localhost:38710/tests/dromaeo/cssquery-yui.html (next: http://localhost:38710/tests/dromaeo/cssquery-dojo.html) 19:43:40 INFO - PROCESS | 7935 | RSS: Main: 166252544 19:43:40 INFO - PROCESS | 7935 | 19:43:40 INFO - PROCESS | 7935 | __start_tp_report 19:43:40 INFO - PROCESS | 7935 | _x_x_mozilla_page_load 19:43:40 INFO - PROCESS | 7935 | _x_x_mozilla_page_load_details 19:43:40 INFO - PROCESS | 7935 | |i|pagename|runs| 19:43:40 INFO - PROCESS | 7935 | |0;dojo.html;2581.6127580862867;2595.3771094937215;2611.569091099969;2630.631711560381;2647.444036752282;4595.448546174455;4704.3413922050895;4731.4795372509;4739.549742774435;4747.311639812234;4662.696924699901;4681.344611754357;4694.647901407391;4703.294505824119;4713.9057218855605;4307.461567304087;4333.155034768213;4415.337699345092;4454.665900057493;4484.125595508877;4388.07850351425;4429.977850110745;4440.8001639926115;4487.416635837337;4503.076869241798;4248.383984322256;4253.064325848309;4253.128108737701;4410.095930334273;4416.3596278539435;4267.0825772459075;4297.247981603207;4305.052888364586;4309.418228539138;4318.676099292534;4269.850555230552;4312.719673221262;4321.178975994582;4364.454443194601;4370.6940514164025;4634.119517291738;4644.140833945731;4652.302154676791;4665.346851440801;4715.033418149305;4883.413990321184;4895.2167653175675;5002.374703162105;5008.1486147355035;5013.598912087061;5031.899362012739;5035.773390197413;5068.138416469209;5079.060373830816;5138.537531622172;4709;4728.030753695484;4751.83368582098;4760.476347601761;4782.665213435096;4965.503449655005;5146.614003949719;5184.844454666366;5195.558377537876;5232.189010703347;4768.3085952536685;4908.460069392364;4924.556789888928;4940.530649588283;5014.272930425068;4945.406551213805;4988.925166122511;5037.748112594356;5047.16721740916;5051.974740126276;4966.553010229024;4993.950060499421;5025.974870125699;5054.873628159326;5063.822766203165;4853.247746599282;4924.3105965164905;4945.480724523945;5000.62495312853;5055.34280543527;4158.9376159357635;4180.811863466151;4199.811008504625;4225;4244.342126970325;3631.128529153037;3645.0522864055006;3670.596234414212;3674.834632441493;3706.369917114097;4258.510271318776;4293.742375457483;4406.449193850769;4410.889727756832;4438.045820148619;5018.2974383586325;5020.497950205024;5045.596352291808;5049;5123.820666276662;4399.5160532341415;4406.691531592822;4420.359047938031;4422.557744225552;4461.665375096816;4404.713693609905;4493.213687604656;4522.728636281834;4524.7511386873375;4525.185466616041;4702.988857395745;4730.266808644666;4740.6681532292405;4740.88147796294;4790.94599188178;5053.570446512088;5073.467285934924;5082.440931497458;5095.592352611856;5136.486351364833;4773.260144677581;4796.25658023007;4800.615950724004;4803.831865884677;4843.176659967884;4897.608191344612;4926.950730492649;4974.527419895104;4990.6007519397635;5013.899722005466;5046.369203849519;5048.545630893237;5051.974740126276;5056.443791182894;5100.285959965682;4794.041191761592;4825.927611085766;4908.631852610997;4919.4834542373965;4940.851774446773;4799.808007679654;4846.418429788448;4857.198562237191;4883.949950760603;4897.118518666674;4795.904081918272;4797.592204662643;4797.760111994457;4817.879553011203;4835.44392394865;4904.828331008398;4923.310736496965;4928.852134435972;4933.827316043921;4935.284383764262;4761.928571071506;4763.476017637988;4805.543473370024;4815.6147508198555;4818.277258411266 19:43:40 INFO - PROCESS | 7935 | |1;ext.html;525.3118414876511;526.2369564132009;534.6391185949483;537.8440252326826;553.5792797473919;35379.46930796037;39671.40492892609;39711;39783.204335913266;39838.40242396359;39644.60355396445;40193.19613607726;40224.59775402245;40243;40273;7448.143463501712;7658.540487570764;7687;9275.675351362705;9676.854847177297;9627.663031793889;9673.322867399285;9716.854247186262;9722.368046077017;9740.220782337396;9669.516524173798;9718.61125554977;9752.268579856503;9756.170725488342;9760.658376956808;9658.468784216866;9689.467079310634;9712.223022158245;9714.174295184917;9721.465319407429;9296.953515232448;9415.811683766355;9441.244700424018;9443.291753118476;9453;34759.4786078209;35030.29939401223;35139.82430087833;35211.647883521095;35324.116897077525;2910.3742695320607;3177.126290270171;3509.3332266869215;3610;3621.8913432597064;26145;26359.868200658875;26612;26749.465010699678;26813.597796033075;2992.07245753817;3149.6220453545493;3183.2041989502623;3217.2439476722952;3220.211048293183;265039;265147;265783;265926;266580;47872.760636196595;47896.66015127017;48079.34571777114;48406.528857449804;48460;49576.752116239906;50115.24827127596;50353.74823125861;50434.24348634773;50445.49554504481;14110.223937683526;14296.499622513162;14311.928440357731;14358;14365;9625.470599116976;9889.406635601887;10492.21308401873;10497.737556560995;10542.841857372145;15927.522174334788;16016.599585010235;16042.679146417006;16095.517134485985;16154.353825847069;6457.61254324742;6563.638999855054;6569.343065693488;6846.144231971004;6864.38220560142;850.9829803403898;908.0454620129242;914.3736540469799;919.7102912582515;939.8214339275515;27132.59301110485;28350.43299134047;28377.29056773556;28516.857415713202;28533.144005679864;937.8780758501351;944.428620684476;982.6757170133982;990.3562684255292;1022.5807418958192;14356.641083972985;15000.699986000438;15071.171085590398;15233.314500847488;15340.769888451681;380754;564957;581773;582913;584345;43741.562584374384;44386.55613443889;45460.77269613697;45542.54457455383;45554;1200.7538454616608;1207.975840483203;1209.3832145605804;1212.8362671039297;1240.3922078181627;25082.37294067663;25446.74553254444;26015.479690406464;26495.470090598465;26520.602190967536;38406.23187536289;38419.6158038416;38440.03899902525;38547.03632409212;38624.42063368995;345253;347062;348472;349657;350189;23909;23963.52072958496;24427.51144977055;24560.877195613906;25339.746602534477;37277.25445491129;37400.812995934844;38091.2381752369;38347.616523834404;38711;32734.836325818218;33154.668453316124;33190;33420.49869251915;33481.33037339191;32854.83572582122;32935.34129317448;33285;33575.32849342951;34048.65951340455;32493;32748.672513274563;32754.181145471553;32773.508397374535;35482.11294717653;26825.329366765985;27886.721132789226;30656.540151898185;30863.845680771454;30989.380212396078;23277.418064547845;23298.417539561648;23576.17483388073;23899.220155968527;23924 19:43:40 INFO - PROCESS | 7935 | |2;jquery.html;370.26317627920446;378.5325123472511;385.09637334497876;396.1838612458338;402.24378169042194;15622.687546249068;16530.42143524977;16758.413455529073;16804.075775832323;16854.157292135405;15782.763258551131;15932.601684957883;16368.672626547463;16500.75248871265;17041.82958170418;4449.688521803467;4756.90486190276;4759.428868535763;4760.047990401916;4763.452202996647;4685.69542979707;4745.454272758625;5226.08543504887;5477.643953143033;5513.58648101394;5546.278983732109;5556.055470570012;5560.805371811987;5562.610617256793;5564.666120032811;5397.62216644835;5559;5560.888782224373;5603.467670571289;5605.887882242373;5352.384475785257;5405.729713514309;5413;5427.891442171134;5438.3473983121885;12374.938125309405;12526.498940042478;12664.68338291541;12671.873281267162;13944.790828137484;1918.2039453626728;1933.796951320105;1981.0787983587556;2127.8936053197276;2274.9886250568643;8384.958075209646;8547.658093676246;8652.134786521361;8844.867326990101;8940.910590894073;1691.940782072634;1718.9484315470556;1737.6785294720517;1751.4570483150137;1794.488570757341;62443.6877815608;63357.366426335604;63683.36316636821;64636.3536364635;64717.676411618115;9179.31155163352;9296.907030929604;9460.763480913032;9531.428114313163;9593.568289426992;12325.445354959049;12396.938015310046;12411.255324680547;12415.068869834618;12450.937745311216;6891.517593768388;7016.333448322402;7079.504434689522;7136;7293.817654558572;7017.4035207006955;7019.92980070203;7092.787216383516;7185.928140718631;7252.456065795086;3774.50931378919;3910.7262491625315;3925.1953349563273;3983.46223259862;4346.956930242781;1563.0465416096172;1577.7081239970641;1586.2544604036084;1624.740041593363;1668;864.7103220421229;874.6020560644891;897.9942464439739;911.5032307392487;920.6317473010849;16527.173641317888;16541;17027.148642567823;17393.478195654152;17725.252585849215;819.2585709932521;820.429801288099;852.7058164933088;903.584351198443;922.6032805893531;9116.453012819253;9496.810063798823;9598.232141428669;9655.324127311022;9769.609215631437;321218;335674;342631;343530;345417;66611.66694166596;66882.62995290812;69114.65442672755;72451;74149.62925185339;920.9585568649427;946.6733976778;952.7522844060455;987.244757760314;1001;14810.407583696531;15392.769108463159;15677.686446271238;16161.191940403169;16183;34803;34982;35155;35173;35889.28221435609;48937.2659410102;49080.7601781015;49282.26076608925;49824.75087624539;50289.98260104405;7478.102627684712;7544.321011109027;7735.071791385069;7736.7678969631;7748.57382843949;7329.74345897891;10182.338148020355;11167.664970050912;11210.103191744804;11992.220505667105;8771.517566533646;8788.648454061766;8878.156575125353;9289.396189247676;9314.416549186519;8741.519216443157;8837.248833849195;9045;9051.954740226256;9847.655332063343;9489.288303377136;9503.762405939908;9510.95244523773;9772.706818795448;9924.553395097382;7339.77980660581;7372.48392612512;7416.44376671741;7507.249275072449;7532.244537410585;7103.893441598277;9337.393069450463;9412.105849944244;9477.668281610111;9809.901900981184 19:43:40 INFO - PROCESS | 7935 | |3;mootools.html;1396.6787638843066;1409.3023953143195;1553.386412367115;1728.0582082764884;1729.7405389191626;6371;6543.869122617545;7176.856462870739;7609.201033891445;7636.350910172635;7160.391366733821;7426.591537465437;7435.5538667679975;7585.1656317805;7588.962055189731;2149.398168512815;2187.7812218778076;2192.736871575405;2193.144673577306;2196.3959911024435;2148.258850696507;2172.9891350543226;2197.7142971413696;2202.6475763877784;2205.426589086833;2143.089187095486;2157.2773121004484;2164.437246315961;2169.978300217001;2185.25701261571;2112.588045331161;2113.8731676099405;2119.6608542633103;2137.187868609934;2138.8182004529713;2127.5532138250987;2166.447555873258;2177.9782202177935;2179.106566307806;2186.2457452178974;7424.368928641072;7527.47307688462;7589.089309282866;7601.885971710429;7607.771766847003;4498.640108791289;4609.539046095397;4619.676622636417;4620.768961551943;4623.653226008063;2785.7214278572183;2819.182437093261;2924.897628583011;2941.2205765472168;3012.0963710886645;808.7533302342783;873.5413907698446;877.9341549383757;895.5835536475505;896.1531352871539;9610;9770.706878793648;9789.90210097897;9802.117809397118;9812.705618831375;4081.8163182656854;4120.237756015087;4186.748795072244;4236.703430759817;4351.26028575143;8541.188587084218;8566.3146948244;8573.871391929126;8577.785555361166;8591.613377398033;4515.864524064284;4562.110388474216;4569.520200378979;4572.0627271409285;4576.473705523841;3636.127329440915;3729.086373838427;4162.771047592411;4221.767802770877;4226.4505614270565;3548.8935331940083;3563.6792688658147;3621.492990981265;3634.3094811986166;3687.612800655946;1194.6714653470192;1207.8053548364526;1211.9515219391126;1212.9575464858688;1218.4943248551929;821.7493664432286;835.4861760017545;839.1734141870253;865.4763867859854;879.1077056787366;4641.582257596832;4853.369062021915;4882.389701287339;4883.975580122076;4900.313956046157;409.53926832313647;859.2524503681836;917.605429665237;935.9719208423758;945.2768631996528;3300.372929143503;3321.451960426551;3351.614564325085;3353.6311005789344;3439.8968030959113;8969.416987895765;9199.954000229956;9305.906940930505;9309.767255818659;9311.90688093124;9146.496942668084;9223.76940576491;9229.169374756304;9230.353875228804;9238.722838314861;6950.235474097845;7027.754028608974;7028.894566581505;7142.92857071433;7155.499115061895;4741.146593613183;4825.420949485943;4837.7097374157665;4870.439899411472;4923.926141107958;8468.957655211685;8486.830263394573;8495;8514.10601886793;8575.871361929701;7966.482178658369;8341.624626891926;8365.749027529184;8521.147885211678;8649.783755406164;5864.912026319694;6034.849128771641;6523.64119973406;6616.536842420985;6628.436582890508;7076.858462830817;7281.089863767029;7319.487635865438;7341.119065712149;7413.703451862081;6546.410823025951;6857.588544687334;6878.449724021966;6886.208086070166;6960.4779641526075;6658.533902626963;6659.167604049494;6692.364225398579;6743.629100399525;6975.895361569479;5478.096114141122;5643.266375371176;5718.628289161191;5719.714014299351;5723.370429252695;4367.475902891673;4382.408374869352;4389.23188442015;4391.912161756811;4426.203283409017;4366.628836548929;4423.933640995452;4426.800793964344;4436.9334459983775;4525.140223357552 19:43:40 INFO - PROCESS | 7935 | |4;prototype.html;340.6678488473738;343.1712414518937;351.91905861651804;355.03784743345534;356.94288913773795;4801.783919723612;4836.17784976554;4868.415790105183;4871.318015477831;4884.951150488494;4792.520747925215;4806;4821.397325334333;4822.252550854623;4836.758162091899;3734.9439758403646;3797.449369841371;3804.8097595120134;3880.3791393377064;3933.6656384207377;3899.083715326896;3900.4344370066324;3901.7463864848696;3924.136689928211;3947.059440716656;3895.337792575269;3897.3179693553516;3919.8628048018327;3925.2738243425056;3934.957236332374;3594.8202589870402;3743.681787048077;3886.514185726784;3952.940705889414;3957.2876882161054;3302.3065156317202;3304.5538852254876;3313.1385839681616;3314.105191598279;3317.8506967186536;4721.881952951169;4728.810847566093;4762.166620841339;4772.141014617368;4785.808567657289;4244.61798438139;4257;4262.6376757975295;4284.67864910133;4288;4978.626603004789;5054.1407960646775;5061.392632884041;5073.239014147871;5078.61910356721;3578.35589593873;3587.1749497615697;3598.874039408608;3601.477785721082;3608.278344331118;5279.973600131974;5306.469353064663;5331.653442526263;5351.759170837322;5362.943122420261;3543.3799085159994;3602.955143008498;3611.0972256935765;3650.7261955353456;3678.503402040744;3655.0314166745834;3705.8517659293866;3707.369747142938;3712.3317802795755;3742.3450896093077;4271.3341796699315;4274;4276.636485898671;4286.164197981364;4296.742195468282;4899.902001960012;5090.389153301628;5103.438621751604;5111.361079865017;5130.640855140105;1256.7863463211277;1259.4521383198337;1271.6139408045276;1273.9745205095846;1276.9297688627214;824.443722112234;854.7734850264685;862.3877047296489;863.494855509534;865.8008658008694;4439.689221754446;4509.368688383629;4514.796834142471;4516.841910533116;4536.523665015192;5231.482869967743;5236.947630523646;5262.631615786935;5264.789408423697;5303.28405665238;4533.52397998212;4541.72749635023;4546.65900057497;4563.429571303587;4564.3838081859185;2602.2323414592743;2700.554408522572;2708.390612112298;2729.959050614242;2739.369944912681;4810.6427850353775;4813.446453657874;4822.468204192756;4829.468758436569;4875.805887350706;5116.283720279164;5240.213967904845;5261.316028916293;5271.5255626992985;5296.25852380667;4720.583824852531;4776.853555146739;4837.637177211724;4869.245266983623;4878.146324393217;5158.845234642967;5160.071187186192;5173.198154286091;5181.186584695477;5181.948180518147;4903.632227582874;5075.187969924795;5088.949110508996;5114.872128196825;5125.282460455464;4939.876503087452;4956.603471722326;4969.329140566122;4972.453030166751;4985.407588054264;3679.2825399048;3689.409694448875;3694.464302676043;3714.0900479382726;3721.5348081489815;5086.82073703935;5313.442088580643;5335.466453354634;5338.706371149624;5339.519443250126;5105.591552675852;5118.74406279692;5119.257707632298;5119.564836988898;5133.6919784813035;5112.437631860566;5121.181980397055;5133.512316329943;5150.201718733602;5173.22401639757;4940.2079982417;4947.455779864284;5010.799568017239;5044.54599086084;5070.771815268248;4983.875403114951;5120.283160357628;5124.333836601367;5138.76875540609;5147.6911385317;5004.1492946198505;5012.749362531786;5025.84922452327;5036.345275114211;5066.746662666778 19:43:40 INFO - PROCESS | 7935 | |5;yui.html;689.5242282824851;697.9302069793018;700.1038670501758;705.8588282343533;722.4942540221845;11518.884811151896;12471.688207794821;12485.126041177109;12512.249265044104;12520.499180032788;12578.245305281689;12620.747585048317;12665.113442059059;12713.618591442248;12719.42762575684;678.993210067898;694.2432748304348;808.4542933519865;824.7855557555049;827.7185756842672;800.3517151107592;825.475822852487;827.1108558299821;829.0797215091244;836.3100442135233;863.1023735315265;865.7792262972933;866.0213958227195;866.9306455483546;868.5006121480143;847.3009766942236;855.1405837133641;855.3371137368558;855.9486430814171;856.6830272799042;627.6861569215392;632.1276638239246;632.2097378277153;632.5382470796344;634.3402861024529;12024.579139730155;12030.699232519257;12031.51873925042;12099.153059285854;12368.257904525757;12022.458989345501;12098;12202.816957745552;12448.315342656151;13825.861741382558;11713.70715732105;11754.97925621192;11830.112741544419;11952;12138.635840924786;4208;4227.577242275778;4248.4052232687445;4248.426462427564;4282.464691913511;62598.37401625971;65520.67239663819;65563.67218163927;66715;68530.31469685289;10251.923548027498;10401.219908506891;10406.167506599606;10489.423081730578;10500.369977801356;18278.908605456887;18383.72424413635;18448.26206951707;18495.075246237633;18626.25494980213;6271.811845644638;6518;6533.542652014314;6558.344165583403;6723.294054124344;3462.8441720122655;3472.097254713742;3502.6322236164838;3541.6281290464644;3560.857565697343;2876.3528206153446;2908.3746994396306;2932.4281765056035;2933.48663983802;3201.135693362779;537.7338217582321;547.9342478902478;554.3154204557369;568.377626498983;568.5110804707948;455.9931601025987;577.4398833131855;598.9161517387569;599.6045797040763;630.7350912616712;7993.160718124629;8002.998126171143;8063.4355595108955;8079.5960201989665;8329.791755206046;604.4378727783115;613.5427612412349;624.3849807939176;627.4102343796816;631.3970158498623;3954.8813535593404;3957.5053118360206;4073.307537718595;4170.332746760504;4277.636400905895;51643.22535161975;53941.73029134829;59651.40348596458;61693.38306616876;66275.66862165755;26340;36117.63882361143;52012;52159.73920130451;53668.463315366345;46857.531424685316;47721.28418073732;47918.28122578164;49434.752826235635;49553.25670114951;8147.14454982242;8557.48655080697;8561.91438085636;8706.956465217634;8837;34933.30133397267;34993.12517186989;35056.29887402289;35423.64576354204;35809.82095089508;42774;43498;46934;47384;49056.264156036974;11186.216964812385;11321.830172547583;11545.538178472767;11877.46551405206;12250.326232057323;12692.555760548337;13483.865161348262;13583.728325433634;13954.372053257424;14651.92674036623;11512.654620361403;11601.883981160081;11665.88334116648;11870.525178992744;11884.76230475403;11812.70468238301;11890.28658280506;12428.56500022495;12469;13060.281684507443;11282.266652667551;11420.714482138013;11605.187636865337;11629.476673549541;11816.70458238551;10041;10141.594336226763;10279.794404111726;10727.088197503299;10764;9065.320100992583;9808.9019109808;10063.647772327933;10202.897971020195;10254.6410875619 19:43:40 INFO - PROCESS | 7935 | __end_tp_report 19:43:40 INFO - PROCESS | 7935 | __start_cc_report 19:43:40 INFO - PROCESS | 7935 | _x_x_mozilla_cycle_collect,334 19:43:40 INFO - PROCESS | 7935 | __end_cc_report 19:43:40 INFO - PROCESS | 7935 | __startTimestamp1482464620836__endTimestamp 19:43:40 INFO - PROCESS | 7935 | 19:43:40 INFO - PROCESS | 7935 | ------- Summary: start ------- 19:43:40 INFO - PROCESS | 7935 | Number of tests: 6 19:43:40 INFO - PROCESS | 7935 | 19:43:40 INFO - PROCESS | 7935 | [#0] dojo.html Cycles:165 Average:4648.49 Median:4782.67 stddev:488.20 (10.2%) stddev-sans-first:461.99 19:43:40 INFO - PROCESS | 7935 | Values: 2581.6 2595.4 2611.6 2630.6 2647.4 4595.4 4704.3 4731.5 4739.5 4747.3 4662.7 4681.3 4694.6 4703.3 4713.9 4307.5 4333.2 4415.3 4454.7 4484.1 4388.1 4430.0 4440.8 4487.4 4503.1 4248.4 4253.1 4253.1 4410.1 4416.4 4267.1 4297.2 4305.1 4309.4 4318.7 4269.9 4312.7 4321.2 4364.5 4370.7 4634.1 4644.1 4652.3 4665.3 4715.0 4883.4 4895.2 5002.4 5008.1 5013.6 5031.9 5035.8 5068.1 5079.1 5138.5 4709.0 4728.0 4751.8 4760.5 4782.7 4965.5 5146.6 5184.8 5195.6 5232.2 4768.3 4908.5 4924.6 4940.5 5014.3 4945.4 4988.9 5037.7 5047.2 5052.0 4966.6 4994.0 5026.0 5054.9 5063.8 4853.2 4924.3 4945.5 5000.6 5055.3 4158.9 4180.8 4199.8 4225.0 4244.3 3631.1 3645.1 3670.6 3674.8 3706.4 4258.5 4293.7 4406.4 4410.9 4438.0 5018.3 5020.5 5045.6 5049.0 5123.8 4399.5 4406.7 4420.4 4422.6 4461.7 4404.7 4493.2 4522.7 4524.8 4525.2 4703.0 4730.3 4740.7 4740.9 4790.9 5053.6 5073.5 5082.4 5095.6 5136.5 4773.3 4796.3 4800.6 4803.8 4843.2 4897.6 4927.0 4974.5 4990.6 5013.9 5046.4 5048.5 5052.0 5056.4 5100.3 4794.0 4825.9 4908.6 4919.5 4940.9 4799.8 4846.4 4857.2 4883.9 4897.1 4795.9 4797.6 4797.8 4817.9 4835.4 4904.8 4923.3 4928.9 4933.8 4935.3 4761.9 4763.5 4805.5 4815.6 4818.3 19:43:40 INFO - PROCESS | 7935 | 19:43:40 INFO - PROCESS | 7935 | [#1] ext.html Cycles:180 Average:51769.78 Median:35351.79 stddev:107670.80 (304.6%) stddev-sans-first:107904.10 19:43:40 INFO - PROCESS | 7935 | Values: 525.3 526.2 534.6 537.8 553.6 35379.5 39671.4 39711.0 39783.2 39838.4 39644.6 40193.2 40224.6 40243.0 40273.0 7448.1 7658.5 7687.0 9275.7 9676.9 9627.7 9673.3 9716.9 9722.4 9740.2 9669.5 9718.6 9752.3 9756.2 9760.7 9658.5 9689.5 9712.2 9714.2 9721.5 9297.0 9415.8 9441.2 9443.3 9453.0 34759.5 35030.3 35139.8 35211.6 35324.1 2910.4 3177.1 3509.3 3610.0 3621.9 26145.0 26359.9 26612.0 26749.5 26813.6 2992.1 3149.6 3183.2 3217.2 3220.2 265039.0 265147.0 265783.0 265926.0 266580.0 47872.8 47896.7 48079.3 48406.5 48460.0 49576.8 50115.2 50353.7 50434.2 50445.5 14110.2 14296.5 14311.9 14358.0 14365.0 9625.5 9889.4 10492.2 10497.7 10542.8 15927.5 16016.6 16042.7 16095.5 16154.4 6457.6 6563.6 6569.3 6846.1 6864.4 851.0 908.0 914.4 919.7 939.8 27132.6 28350.4 28377.3 28516.9 28533.1 937.9 944.4 982.7 990.4 1022.6 14356.6 15000.7 15071.2 15233.3 15340.8 380754.0 564957.0 581773.0 582913.0 584345.0 43741.6 44386.6 45460.8 45542.5 45554.0 1200.8 1208.0 1209.4 1212.8 1240.4 25082.4 25446.7 26015.5 26495.5 26520.6 38406.2 38419.6 38440.0 38547.0 38624.4 345253.0 347062.0 348472.0 349657.0 350189.0 23909.0 23963.5 24427.5 24560.9 25339.7 37277.3 37400.8 38091.2 38347.6 38711.0 32734.8 33154.7 33190.0 33420.5 33481.3 32854.8 32935.3 33285.0 33575.3 34048.7 32493.0 32748.7 32754.2 32773.5 35482.1 26825.3 27886.7 30656.5 30863.8 30989.4 23277.4 23298.4 23576.2 23899.2 23924.0 19:43:40 INFO - PROCESS | 7935 | 19:43:40 INFO - PROCESS | 7935 | [#2] jquery.html Cycles:180 Average:21934.01 Median:5529.93 stddev:55912.84 (1011.1%) stddev-sans-first:56046.25 19:43:40 INFO - PROCESS | 7935 | Values: 370.3 378.5 385.1 396.2 402.2 15622.7 16530.4 16758.4 16804.1 16854.2 15782.8 15932.6 16368.7 16500.8 17041.8 4449.7 4756.9 4759.4 4760.0 4763.5 4685.7 4745.5 5226.1 5477.6 5513.6 5546.3 5556.1 5560.8 5562.6 5564.7 5397.6 5559.0 5560.9 5603.5 5605.9 5352.4 5405.7 5413.0 5427.9 5438.3 12374.9 12526.5 12664.7 12671.9 13944.8 1918.2 1933.8 1981.1 2127.9 2275.0 8385.0 8547.7 8652.1 8844.9 8940.9 1691.9 1718.9 1737.7 1751.5 1794.5 62443.7 63357.4 63683.4 64636.4 64717.7 9179.3 9296.9 9460.8 9531.4 9593.6 12325.4 12396.9 12411.3 12415.1 12450.9 6891.5 7016.3 7079.5 7136.0 7293.8 7017.4 7019.9 7092.8 7185.9 7252.5 3774.5 3910.7 3925.2 3983.5 4347.0 1563.0 1577.7 1586.3 1624.7 1668.0 864.7 874.6 898.0 911.5 920.6 16527.2 16541.0 17027.1 17393.5 17725.3 819.3 820.4 852.7 903.6 922.6 9116.5 9496.8 9598.2 9655.3 9769.6 321218.0 335674.0 342631.0 343530.0 345417.0 66611.7 66882.6 69114.7 72451.0 74149.6 921.0 946.7 952.8 987.2 1001.0 14810.4 15392.8 15677.7 16161.2 16183.0 34803.0 34982.0 35155.0 35173.0 35889.3 48937.3 49080.8 49282.3 49824.8 50290.0 7478.1 7544.3 7735.1 7736.8 7748.6 7329.7 10182.3 11167.7 11210.1 11992.2 8771.5 8788.6 8878.2 9289.4 9314.4 8741.5 8837.2 9045.0 9052.0 9847.7 9489.3 9503.8 9511.0 9772.7 9924.6 7339.8 7372.5 7416.4 7507.2 7532.2 7103.9 9337.4 9412.1 9477.7 9809.9 19:43:40 INFO - PROCESS | 7935 | 19:43:40 INFO - PROCESS | 7935 | [#3] mootools.html Cycles:180 Average:4928.85 Median:5201.01 stddev:2694.58 (51.8%) stddev-sans-first:2689.06 19:43:40 INFO - PROCESS | 7935 | Values: 1396.7 1409.3 1553.4 1728.1 1729.7 6371.0 6543.9 7176.9 7609.2 7636.4 7160.4 7426.6 7435.6 7585.2 7589.0 2149.4 2187.8 2192.7 2193.1 2196.4 2148.3 2173.0 2197.7 2202.6 2205.4 2143.1 2157.3 2164.4 2170.0 2185.3 2112.6 2113.9 2119.7 2137.2 2138.8 2127.6 2166.4 2178.0 2179.1 2186.2 7424.4 7527.5 7589.1 7601.9 7607.8 4498.6 4609.5 4619.7 4620.8 4623.7 2785.7 2819.2 2924.9 2941.2 3012.1 808.8 873.5 877.9 895.6 896.2 9610.0 9770.7 9789.9 9802.1 9812.7 4081.8 4120.2 4186.7 4236.7 4351.3 8541.2 8566.3 8573.9 8577.8 8591.6 4515.9 4562.1 4569.5 4572.1 4576.5 3636.1 3729.1 4162.8 4221.8 4226.5 3548.9 3563.7 3621.5 3634.3 3687.6 1194.7 1207.8 1212.0 1213.0 1218.5 821.7 835.5 839.2 865.5 879.1 4641.6 4853.4 4882.4 4884.0 4900.3 409.5 859.3 917.6 936.0 945.3 3300.4 3321.5 3351.6 3353.6 3439.9 8969.4 9200.0 9305.9 9309.8 9311.9 9146.5 9223.8 9229.2 9230.4 9238.7 6950.2 7027.8 7028.9 7142.9 7155.5 4741.1 4825.4 4837.7 4870.4 4923.9 8469.0 8486.8 8495.0 8514.1 8575.9 7966.5 8341.6 8365.7 8521.1 8649.8 5864.9 6034.8 6523.6 6616.5 6628.4 7076.9 7281.1 7319.5 7341.1 7413.7 6546.4 6857.6 6878.4 6886.2 6960.5 6658.5 6659.2 6692.4 6743.6 6975.9 5478.1 5643.3 5718.6 5719.7 5723.4 4367.5 4382.4 4389.2 4391.9 4426.2 4366.6 4423.9 4426.8 4436.9 4525.1 19:43:40 INFO - PROCESS | 7935 | 19:43:40 INFO - PROCESS | 7935 | [#4] prototype.html Cycles:180 Average:4224.01 Median:4812.04 stddev:1225.19 (25.5%) stddev-sans-first:1193.45 19:43:40 INFO - PROCESS | 7935 | Values: 340.7 343.2 351.9 355.0 356.9 4801.8 4836.2 4868.4 4871.3 4885.0 4792.5 4806.0 4821.4 4822.3 4836.8 3734.9 3797.4 3804.8 3880.4 3933.7 3899.1 3900.4 3901.7 3924.1 3947.1 3895.3 3897.3 3919.9 3925.3 3935.0 3594.8 3743.7 3886.5 3952.9 3957.3 3302.3 3304.6 3313.1 3314.1 3317.9 4721.9 4728.8 4762.2 4772.1 4785.8 4244.6 4257.0 4262.6 4284.7 4288.0 4978.6 5054.1 5061.4 5073.2 5078.6 3578.4 3587.2 3598.9 3601.5 3608.3 5280.0 5306.5 5331.7 5351.8 5362.9 3543.4 3603.0 3611.1 3650.7 3678.5 3655.0 3705.9 3707.4 3712.3 3742.3 4271.3 4274.0 4276.6 4286.2 4296.7 4899.9 5090.4 5103.4 5111.4 5130.6 1256.8 1259.5 1271.6 1274.0 1276.9 824.4 854.8 862.4 863.5 865.8 4439.7 4509.4 4514.8 4516.8 4536.5 5231.5 5236.9 5262.6 5264.8 5303.3 4533.5 4541.7 4546.7 4563.4 4564.4 2602.2 2700.6 2708.4 2730.0 2739.4 4810.6 4813.4 4822.5 4829.5 4875.8 5116.3 5240.2 5261.3 5271.5 5296.3 4720.6 4776.9 4837.6 4869.2 4878.1 5158.8 5160.1 5173.2 5181.2 5181.9 4903.6 5075.2 5088.9 5114.9 5125.3 4939.9 4956.6 4969.3 4972.5 4985.4 3679.3 3689.4 3694.5 3714.1 3721.5 5086.8 5313.4 5335.5 5338.7 5339.5 5105.6 5118.7 5119.3 5119.6 5133.7 5112.4 5121.2 5133.5 5150.2 5173.2 4940.2 4947.5 5010.8 5044.5 5070.8 4983.9 5120.3 5124.3 5138.8 5147.7 5004.1 5012.7 5025.8 5036.3 5066.7 19:43:40 INFO - PROCESS | 7935 | 19:43:40 INFO - PROCESS | 7935 | [#5] yui.html Cycles:180 Average:14273.05 Median:4237.99 stddev:17219.62 (406.3%) stddev-sans-first:17237.71 19:43:40 INFO - PROCESS | 7935 | Values: 689.5 697.9 700.1 705.9 722.5 11518.9 12471.7 12485.1 12512.2 12520.5 12578.2 12620.7 12665.1 12713.6 12719.4 679.0 694.2 808.5 824.8 827.7 800.4 825.5 827.1 829.1 836.3 863.1 865.8 866.0 866.9 868.5 847.3 855.1 855.3 855.9 856.7 627.7 632.1 632.2 632.5 634.3 12024.6 12030.7 12031.5 12099.2 12368.3 12022.5 12098.0 12202.8 12448.3 13825.9 11713.7 11755.0 11830.1 11952.0 12138.6 4208.0 4227.6 4248.4 4248.4 4282.5 62598.4 65520.7 65563.7 66715.0 68530.3 10251.9 10401.2 10406.2 10489.4 10500.4 18278.9 18383.7 18448.3 18495.1 18626.3 6271.8 6518.0 6533.5 6558.3 6723.3 3462.8 3472.1 3502.6 3541.6 3560.9 2876.4 2908.4 2932.4 2933.5 3201.1 537.7 547.9 554.3 568.4 568.5 456.0 577.4 598.9 599.6 630.7 7993.2 8003.0 8063.4 8079.6 8329.8 604.4 613.5 624.4 627.4 631.4 3954.9 3957.5 4073.3 4170.3 4277.6 51643.2 53941.7 59651.4 61693.4 66275.7 26340.0 36117.6 52012.0 52159.7 53668.5 46857.5 47721.3 47918.3 49434.8 49553.3 8147.1 8557.5 8561.9 8707.0 8837.0 34933.3 34993.1 35056.3 35423.6 35809.8 42774.0 43498.0 46934.0 47384.0 49056.3 11186.2 11321.8 11545.5 11877.5 12250.3 12692.6 13483.9 13583.7 13954.4 14651.9 11512.7 11601.9 11665.9 11870.5 11884.8 11812.7 11890.3 12428.6 12469.0 13060.3 11282.3 11420.7 11605.2 11629.5 11816.7 10041.0 10141.6 10279.8 10727.1 10764.0 9065.3 9808.9 10063.6 10202.9 10254.6 19:43:40 INFO - PROCESS | 7935 | -------- Summary: end -------- 19:43:40 INFO - PROCESS | 7935 | 19:43:41 INFO - TEST-INFO | 7935: exit 0 19:43:41 INFO - TEST-OK | dromaeo_css | took 1119234ms 19:43:41 INFO - TEST-START | kraken 19:43:41 INFO - operating with platform_type : linux_ 19:43:41 INFO - Initialising browser for kraken test... 19:43:41 INFO - TEST-INFO | started process 8293 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKLTpQi/profile http://localhost:38710/getInfo.html) 19:43:42 INFO - PROCESS | 8293 | 1482464622160 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4979 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3825 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2829 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 19:43:44 INFO - PROCESS | 8293 | JavaScript error: chrome://global/content/browser-content.js, line 1772: ReferenceError: event is not defined 19:43:45 INFO - PROCESS | 8293 | JavaScript error: chrome://global/content/browser-content.js, line 1772: ReferenceError: event is not defined 19:43:45 INFO - PROCESS | 8293 | JavaScript error: chrome://global/content/browser-content.js, line 1772: ReferenceError: event is not defined 19:43:46 INFO - PROCESS | 8293 | __metrics Screen width/height:1600/1200 19:43:46 INFO - PROCESS | 8293 | colorDepth:24 19:43:46 INFO - PROCESS | 8293 | Browser inner width/height: 1024/697 19:43:46 INFO - PROCESS | 8293 | __metrics 19:43:46 ERROR - PROCESS | 8293 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3247: TypeError: this.tabs is undefined 19:43:47 INFO - TEST-INFO | 8293: exit 0 19:43:47 INFO - Browser initialized. 19:43:47 INFO - Running cycle 1/1 for kraken test... 19:43:47 INFO - TEST-INFO | started process 8416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKLTpQi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:43:59 INFO - PROCESS | 8416 | RSS: Main: 158789632 19:43:59 INFO - PROCESS | 8416 | 19:44:02 INFO - PROCESS | 8416 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38710/tests/kraken/driver.html?testName=audio-beat-detection) 19:44:03 INFO - PROCESS | 8416 | RSS: Main: 164450304 19:44:03 INFO - PROCESS | 8416 | 19:44:06 INFO - PROCESS | 8416 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38710/tests/kraken/driver.html?testName=audio-dft) 19:44:06 INFO - PROCESS | 8416 | RSS: Main: 162783232 19:44:06 INFO - PROCESS | 8416 | 19:44:09 INFO - PROCESS | 8416 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38710/tests/kraken/driver.html?testName=audio-fft) 19:44:10 INFO - PROCESS | 8416 | RSS: Main: 159305728 19:44:10 INFO - PROCESS | 8416 | 19:44:12 INFO - PROCESS | 8416 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38710/tests/kraken/driver.html?testName=audio-oscillator) 19:44:13 INFO - PROCESS | 8416 | RSS: Main: 159850496 19:44:13 INFO - PROCESS | 8416 | 19:44:15 INFO - PROCESS | 8416 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38710/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:44:16 INFO - PROCESS | 8416 | RSS: Main: 159825920 19:44:16 INFO - PROCESS | 8416 | 19:44:19 INFO - PROCESS | 8416 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38710/tests/kraken/driver.html?testName=imaging-darkroom) 19:44:19 INFO - PROCESS | 8416 | RSS: Main: 164147200 19:44:19 INFO - PROCESS | 8416 | 19:44:23 INFO - PROCESS | 8416 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38710/tests/kraken/driver.html?testName=imaging-desaturate) 19:44:24 INFO - PROCESS | 8416 | RSS: Main: 162131968 19:44:24 INFO - PROCESS | 8416 | 19:44:27 INFO - PROCESS | 8416 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38710/tests/kraken/driver.html?testName=json-parse-financial) 19:44:27 INFO - PROCESS | 8416 | RSS: Main: 162967552 19:44:27 INFO - PROCESS | 8416 | 19:44:29 INFO - PROCESS | 8416 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38710/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:44:30 INFO - PROCESS | 8416 | RSS: Main: 162979840 19:44:30 INFO - PROCESS | 8416 | 19:44:31 INFO - PROCESS | 8416 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38710/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:44:32 INFO - PROCESS | 8416 | RSS: Main: 163024896 19:44:32 INFO - PROCESS | 8416 | 19:44:34 INFO - PROCESS | 8416 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38710/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:44:35 INFO - PROCESS | 8416 | RSS: Main: 163246080 19:44:35 INFO - PROCESS | 8416 | 19:44:38 INFO - PROCESS | 8416 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38710/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:44:39 INFO - PROCESS | 8416 | RSS: Main: 163835904 19:44:39 INFO - PROCESS | 8416 | 19:44:41 INFO - PROCESS | 8416 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38710/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:44:42 INFO - PROCESS | 8416 | RSS: Main: 165896192 19:44:42 INFO - PROCESS | 8416 | 19:44:44 INFO - PROCESS | 8416 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38710/tests/kraken/driver.html?testName=ai-astar) 19:44:44 INFO - PROCESS | 8416 | RSS: Main: 165289984 19:44:44 INFO - PROCESS | 8416 | 19:44:44 INFO - PROCESS | 8416 | __start_tp_report 19:44:44 INFO - PROCESS | 8416 | _x_x_mozilla_page_load 19:44:44 INFO - PROCESS | 8416 | _x_x_mozilla_page_load_details 19:44:44 INFO - PROCESS | 8416 | |i|pagename|runs| 19:44:44 INFO - PROCESS | 8416 | |0;ai-astar;106;115;114;114;117;116;116;115;115;115 19:44:44 INFO - PROCESS | 8416 | |1;audio-beat-detection;162;132;130;180;128;128;141;133;155;127 19:44:44 INFO - PROCESS | 8416 | |2;audio-dft;162;169;174;165;162;163;162;162;164;167 19:44:44 INFO - PROCESS | 8416 | |3;audio-fft;77;78;80;114;81;81;79;81;99;79 19:44:44 INFO - PROCESS | 8416 | |4;audio-oscillator;85;84;113;85;85;85;106;85;84;102 19:44:44 INFO - PROCESS | 8416 | |5;imaging-gaussian-blur;117;118;118;117;119;118;119;118;118;118 19:44:44 INFO - PROCESS | 8416 | |6;imaging-darkroom;151;150;151;150;150;152;151;153;151;150 19:44:44 INFO - PROCESS | 8416 | |7;imaging-desaturate;96;96;95;96;96;96;96;97;96;96 19:44:44 INFO - PROCESS | 8416 | |8;json-parse-financial;65;65;65;66;66;66;65;67;65;65 19:44:44 INFO - PROCESS | 8416 | |9;json-stringify-tinderbox;68;68;67;67;67;69;68;67;67;67 19:44:44 INFO - PROCESS | 8416 | |10;stanford-crypto-aes;86;86;86;85;85;91;85;85;86;86 19:44:44 INFO - PROCESS | 8416 | |11;stanford-crypto-ccm;136;136;136;138;137;136;135;134;180;134 19:44:44 INFO - PROCESS | 8416 | |12;stanford-crypto-pbkdf2;178;175;174;179;175;175;178;177;178;182 19:44:44 INFO - PROCESS | 8416 | |13;stanford-crypto-sha256-iterative;74;68;69;67;69;67;68;67;69;67 19:44:44 INFO - PROCESS | 8416 | __end_tp_report 19:44:44 INFO - PROCESS | 8416 | __start_cc_report 19:44:44 INFO - PROCESS | 8416 | _x_x_mozilla_cycle_collect,817 19:44:44 INFO - PROCESS | 8416 | __end_cc_report 19:44:44 INFO - PROCESS | 8416 | __startTimestamp1482464684642__endTimestamp 19:44:44 INFO - PROCESS | 8416 | 19:44:44 INFO - PROCESS | 8416 | ------- Summary: start ------- 19:44:44 INFO - PROCESS | 8416 | Number of tests: 14 19:44:44 INFO - PROCESS | 8416 | 19:44:44 INFO - PROCESS | 8416 | [#0] ai-astar Cycles:10 Average:114.30 Median:115.00 stddev:3.06 (2.7%) stddev-sans-first:0.97 19:44:44 INFO - PROCESS | 8416 | Values: 106.0 115.0 114.0 114.0 117.0 116.0 116.0 115.0 115.0 115.0 19:44:44 INFO - PROCESS | 8416 | 19:44:44 INFO - PROCESS | 8416 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:137.00 stddev:18.12 (13.2%) stddev-sans-first:17.65 19:44:44 INFO - PROCESS | 8416 | Values: 162.0 132.0 130.0 180.0 128.0 128.0 141.0 133.0 155.0 127.0 19:44:44 INFO - PROCESS | 8416 | 19:44:44 INFO - PROCESS | 8416 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.50 stddev:3.97 (2.4%) stddev-sans-first:4.06 19:44:44 INFO - PROCESS | 8416 | Values: 162.0 169.0 174.0 165.0 162.0 163.0 162.0 162.0 164.0 167.0 19:44:44 INFO - PROCESS | 8416 | 19:44:44 INFO - PROCESS | 8416 | [#3] audio-fft Cycles:10 Average:84.90 Median:80.50 stddev:11.99 (14.9%) stddev-sans-first:12.38 19:44:44 INFO - PROCESS | 8416 | Values: 77.0 78.0 80.0 114.0 81.0 81.0 79.0 81.0 99.0 79.0 19:44:44 INFO - PROCESS | 8416 | 19:44:44 INFO - PROCESS | 8416 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:85.00 stddev:11.09 (13.0%) stddev-sans-first:11.52 19:44:44 INFO - PROCESS | 8416 | Values: 85.0 84.0 113.0 85.0 85.0 85.0 106.0 85.0 84.0 102.0 19:44:44 INFO - PROCESS | 8416 | 19:44:44 INFO - PROCESS | 8416 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 19:44:44 INFO - PROCESS | 8416 | Values: 117.0 118.0 118.0 117.0 119.0 118.0 119.0 118.0 118.0 118.0 19:44:44 INFO - PROCESS | 8416 | 19:44:44 INFO - PROCESS | 8416 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:151.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 19:44:44 INFO - PROCESS | 8416 | Values: 151.0 150.0 151.0 150.0 150.0 152.0 151.0 153.0 151.0 150.0 19:44:44 INFO - PROCESS | 8416 | 19:44:44 INFO - PROCESS | 8416 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 19:44:44 INFO - PROCESS | 8416 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 19:44:44 INFO - PROCESS | 8416 | 19:44:44 INFO - PROCESS | 8416 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:65.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 19:44:44 INFO - PROCESS | 8416 | Values: 65.0 65.0 65.0 66.0 66.0 66.0 65.0 67.0 65.0 65.0 19:44:44 INFO - PROCESS | 8416 | 19:44:44 INFO - PROCESS | 8416 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 19:44:44 INFO - PROCESS | 8416 | Values: 68.0 68.0 67.0 67.0 67.0 69.0 68.0 67.0 67.0 67.0 19:44:44 INFO - PROCESS | 8416 | 19:44:44 INFO - PROCESS | 8416 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.00 stddev:1.79 (2.1%) stddev-sans-first:1.90 19:44:44 INFO - PROCESS | 8416 | Values: 86.0 86.0 86.0 85.0 85.0 91.0 85.0 85.0 86.0 86.0 19:44:44 INFO - PROCESS | 8416 | 19:44:44 INFO - PROCESS | 8416 | [#11] stanford-crypto-ccm Cycles:10 Average:140.20 Median:136.00 stddev:14.04 (10.3%) stddev-sans-first:14.81 19:44:44 INFO - PROCESS | 8416 | Values: 136.0 136.0 136.0 138.0 137.0 136.0 135.0 134.0 180.0 134.0 19:44:44 INFO - PROCESS | 8416 | 19:44:44 INFO - PROCESS | 8416 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.10 Median:178.00 stddev:2.42 (1.4%) stddev-sans-first:2.55 19:44:44 INFO - PROCESS | 8416 | Values: 178.0 175.0 174.0 179.0 175.0 175.0 178.0 177.0 178.0 182.0 19:44:44 INFO - PROCESS | 8416 | 19:44:44 INFO - PROCESS | 8416 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:2.12 (3.1%) stddev-sans-first:0.93 19:44:44 INFO - PROCESS | 8416 | Values: 74.0 68.0 69.0 67.0 69.0 67.0 68.0 67.0 69.0 67.0 19:44:44 INFO - PROCESS | 8416 | -------- Summary: end -------- 19:44:44 INFO - PROCESS | 8416 | 19:44:45 INFO - TEST-INFO | 8416: exit 0 19:44:45 INFO - TEST-OK | kraken | took 64195ms 19:44:45 INFO - SUITE-END | took 1183s 19:44:46 INFO - Completed test suite (00:19:43) 19:44:46 INFO - javascript benchmark 19:44:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6279.911988616996, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2581.6127580862867, 2595.3771094937215, 2611.569091099969, 2630.631711560381, 2647.444036752282, 4595.448546174455, 4704.3413922050895, 4731.4795372509, 4739.549742774435, 4747.311639812234, 4662.696924699901, 4681.344611754357, 4694.647901407391, 4703.294505824119, 4713.9057218855605, 4307.461567304087, 4333.155034768213, 4415.337699345092, 4454.665900057493, 4484.125595508877, 4388.07850351425, 4429.977850110745, 4440.8001639926115, 4487.416635837337, 4503.076869241798, 4248.383984322256, 4253.064325848309, 4253.128108737701, 4410.095930334273, 4416.3596278539435, 4267.0825772459075, 4297.247981603207, 4305.052888364586, 4309.418228539138, 4318.676099292534, 4269.850555230552, 4312.719673221262, 4321.178975994582, 4364.454443194601, 4370.6940514164025, 4634.119517291738, 4644.140833945731, 4652.302154676791, 4665.346851440801, 4715.033418149305, 4883.413990321184, 4895.2167653175675, 5002.374703162105, 5008.1486147355035, 5013.598912087061, 5031.899362012739, 5035.773390197413, 5068.138416469209, 5079.060373830816, 5138.537531622172, 4709.0, 4728.030753695484, 4751.83368582098, 4760.476347601761, 4782.665213435096, 4965.503449655005, 5146.614003949719, 5184.844454666366, 5195.558377537876, 5232.189010703347, 4768.3085952536685, 4908.460069392364, 4924.556789888928, 4940.530649588283, 5014.272930425068, 4945.406551213805, 4988.925166122511, 5037.748112594356, 5047.16721740916, 5051.974740126276, 4966.553010229024, 4993.950060499421, 5025.974870125699, 5054.873628159326, 5063.822766203165, 4853.247746599282, 4924.3105965164905, 4945.480724523945, 5000.62495312853, 5055.34280543527, 4158.9376159357635, 4180.811863466151, 4199.811008504625, 4225.0, 4244.342126970325, 3631.128529153037, 3645.0522864055006, 3670.596234414212, 3674.834632441493, 3706.369917114097, 4258.510271318776, 4293.742375457483, 4406.449193850769, 4410.889727756832, 4438.045820148619, 5018.2974383586325, 5020.497950205024, 5045.596352291808, 5049.0, 5123.820666276662, 4399.5160532341415, 4406.691531592822, 4420.359047938031, 4422.557744225552, 4461.665375096816, 4404.713693609905, 4493.213687604656, 4522.728636281834, 4524.7511386873375, 4525.185466616041, 4702.988857395745, 4730.266808644666, 4740.6681532292405, 4740.88147796294, 4790.94599188178, 5053.570446512088, 5073.467285934924, 5082.440931497458, 5095.592352611856, 5136.486351364833, 4773.260144677581, 4796.25658023007, 4800.615950724004, 4803.831865884677, 4843.176659967884, 4897.608191344612, 4926.950730492649, 4974.527419895104, 4990.6007519397635, 5013.899722005466, 5046.369203849519, 5048.545630893237, 5051.974740126276, 5056.443791182894, 5100.285959965682, 4794.041191761592, 4825.927611085766, 4908.631852610997, 4919.4834542373965, 4940.851774446773, 4799.808007679654, 4846.418429788448, 4857.198562237191, 4883.949950760603, 4897.118518666674, 4795.904081918272, 4797.592204662643, 4797.760111994457, 4817.879553011203, 4835.44392394865, 4904.828331008398, 4923.310736496965, 4928.852134435972, 4933.827316043921, 4935.284383764262, 4761.928571071506, 4763.476017637988, 4805.543473370024, 4815.6147508198555, 4818.277258411266], "value": 4617.035559173278, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [525.3118414876511, 526.2369564132009, 534.6391185949483, 537.8440252326826, 553.5792797473919, 35379.46930796037, 39671.40492892609, 39711.0, 39783.204335913266, 39838.40242396359, 39644.60355396445, 40193.19613607726, 40224.59775402245, 40243.0, 40273.0, 7448.143463501712, 7658.540487570764, 7687.0, 9275.675351362705, 9676.854847177297, 9627.663031793889, 9673.322867399285, 9716.854247186262, 9722.368046077017, 9740.220782337396, 9669.516524173798, 9718.61125554977, 9752.268579856503, 9756.170725488342, 9760.658376956808, 9658.468784216866, 9689.467079310634, 9712.223022158245, 9714.174295184917, 9721.465319407429, 9296.953515232448, 9415.811683766355, 9441.244700424018, 9443.291753118476, 9453.0, 34759.4786078209, 35030.29939401223, 35139.82430087833, 35211.647883521095, 35324.116897077525, 2910.3742695320607, 3177.126290270171, 3509.3332266869215, 3610.0, 3621.8913432597064, 26145.0, 26359.868200658875, 26612.0, 26749.465010699678, 26813.597796033075, 2992.07245753817, 3149.6220453545493, 3183.2041989502623, 3217.2439476722952, 3220.211048293183, 265039.0, 265147.0, 265783.0, 265926.0, 266580.0, 47872.760636196595, 47896.66015127017, 48079.34571777114, 48406.528857449804, 48460.0, 49576.752116239906, 50115.24827127596, 50353.74823125861, 50434.24348634773, 50445.49554504481, 14110.223937683526, 14296.499622513162, 14311.928440357731, 14358.0, 14365.0, 9625.470599116976, 9889.406635601887, 10492.21308401873, 10497.737556560995, 10542.841857372145, 15927.522174334788, 16016.599585010235, 16042.679146417006, 16095.517134485985, 16154.353825847069, 6457.61254324742, 6563.638999855054, 6569.343065693488, 6846.144231971004, 6864.38220560142, 850.9829803403898, 908.0454620129242, 914.3736540469799, 919.7102912582515, 939.8214339275515, 27132.59301110485, 28350.43299134047, 28377.29056773556, 28516.857415713202, 28533.144005679864, 937.8780758501351, 944.428620684476, 982.6757170133982, 990.3562684255292, 1022.5807418958192, 14356.641083972985, 15000.699986000438, 15071.171085590398, 15233.314500847488, 15340.769888451681, 380754.0, 564957.0, 581773.0, 582913.0, 584345.0, 43741.562584374384, 44386.55613443889, 45460.77269613697, 45542.54457455383, 45554.0, 1200.7538454616608, 1207.975840483203, 1209.3832145605804, 1212.8362671039297, 1240.3922078181627, 25082.37294067663, 25446.74553254444, 26015.479690406464, 26495.470090598465, 26520.602190967536, 38406.23187536289, 38419.6158038416, 38440.03899902525, 38547.03632409212, 38624.42063368995, 345253.0, 347062.0, 348472.0, 349657.0, 350189.0, 23909.0, 23963.52072958496, 24427.51144977055, 24560.877195613906, 25339.746602534477, 37277.25445491129, 37400.812995934844, 38091.2381752369, 38347.616523834404, 38711.0, 32734.836325818218, 33154.668453316124, 33190.0, 33420.49869251915, 33481.33037339191, 32854.83572582122, 32935.34129317448, 33285.0, 33575.32849342951, 34048.65951340455, 32493.0, 32748.672513274563, 32754.181145471553, 32773.508397374535, 35482.11294717653, 26825.329366765985, 27886.721132789226, 30656.540151898185, 30863.845680771454, 30989.380212396078, 23277.418064547845, 23298.417539561648, 23576.17483388073, 23899.220155968527, 23924.0], "value": 17481.406967359882, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.26317627920446, 378.5325123472511, 385.09637334497876, 396.1838612458338, 402.24378169042194, 15622.687546249068, 16530.42143524977, 16758.413455529073, 16804.075775832323, 16854.157292135405, 15782.763258551131, 15932.601684957883, 16368.672626547463, 16500.75248871265, 17041.82958170418, 4449.688521803467, 4756.90486190276, 4759.428868535763, 4760.047990401916, 4763.452202996647, 4685.69542979707, 4745.454272758625, 5226.08543504887, 5477.643953143033, 5513.58648101394, 5546.278983732109, 5556.055470570012, 5560.805371811987, 5562.610617256793, 5564.666120032811, 5397.62216644835, 5559.0, 5560.888782224373, 5603.467670571289, 5605.887882242373, 5352.384475785257, 5405.729713514309, 5413.0, 5427.891442171134, 5438.3473983121885, 12374.938125309405, 12526.498940042478, 12664.68338291541, 12671.873281267162, 13944.790828137484, 1918.2039453626728, 1933.796951320105, 1981.0787983587556, 2127.8936053197276, 2274.9886250568643, 8384.958075209646, 8547.658093676246, 8652.134786521361, 8844.867326990101, 8940.910590894073, 1691.940782072634, 1718.9484315470556, 1737.6785294720517, 1751.4570483150137, 1794.488570757341, 62443.6877815608, 63357.366426335604, 63683.36316636821, 64636.3536364635, 64717.676411618115, 9179.31155163352, 9296.907030929604, 9460.763480913032, 9531.428114313163, 9593.568289426992, 12325.445354959049, 12396.938015310046, 12411.255324680547, 12415.068869834618, 12450.937745311216, 6891.517593768388, 7016.333448322402, 7079.504434689522, 7136.0, 7293.817654558572, 7017.4035207006955, 7019.92980070203, 7092.787216383516, 7185.928140718631, 7252.456065795086, 3774.50931378919, 3910.7262491625315, 3925.1953349563273, 3983.46223259862, 4346.956930242781, 1563.0465416096172, 1577.7081239970641, 1586.2544604036084, 1624.740041593363, 1668.0, 864.7103220421229, 874.6020560644891, 897.9942464439739, 911.5032307392487, 920.6317473010849, 16527.173641317888, 16541.0, 17027.148642567823, 17393.478195654152, 17725.252585849215, 819.2585709932521, 820.429801288099, 852.7058164933088, 903.584351198443, 922.6032805893531, 9116.453012819253, 9496.810063798823, 9598.232141428669, 9655.324127311022, 9769.609215631437, 321218.0, 335674.0, 342631.0, 343530.0, 345417.0, 66611.66694166596, 66882.62995290812, 69114.65442672755, 72451.0, 74149.62925185339, 920.9585568649427, 946.6733976778, 952.7522844060455, 987.244757760314, 1001.0, 14810.407583696531, 15392.769108463159, 15677.686446271238, 16161.191940403169, 16183.0, 34803.0, 34982.0, 35155.0, 35173.0, 35889.28221435609, 48937.2659410102, 49080.7601781015, 49282.26076608925, 49824.75087624539, 50289.98260104405, 7478.102627684712, 7544.321011109027, 7735.071791385069, 7736.7678969631, 7748.57382843949, 7329.74345897891, 10182.338148020355, 11167.664970050912, 11210.103191744804, 11992.220505667105, 8771.517566533646, 8788.648454061766, 8878.156575125353, 9289.396189247676, 9314.416549186519, 8741.519216443157, 8837.248833849195, 9045.0, 9051.954740226256, 9847.655332063343, 9489.288303377136, 9503.762405939908, 9510.95244523773, 9772.706818795448, 9924.553395097382, 7339.77980660581, 7372.48392612512, 7416.44376671741, 7507.249275072449, 7532.244537410585, 7103.893441598277, 9337.393069450463, 9412.105849944244, 9477.668281610111, 9809.901900981184], "value": 7800.3460571954465, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1396.6787638843066, 1409.3023953143195, 1553.386412367115, 1728.0582082764884, 1729.7405389191626, 6371.0, 6543.869122617545, 7176.856462870739, 7609.201033891445, 7636.350910172635, 7160.391366733821, 7426.591537465437, 7435.5538667679975, 7585.1656317805, 7588.962055189731, 2149.398168512815, 2187.7812218778076, 2192.736871575405, 2193.144673577306, 2196.3959911024435, 2148.258850696507, 2172.9891350543226, 2197.7142971413696, 2202.6475763877784, 2205.426589086833, 2143.089187095486, 2157.2773121004484, 2164.437246315961, 2169.978300217001, 2185.25701261571, 2112.588045331161, 2113.8731676099405, 2119.6608542633103, 2137.187868609934, 2138.8182004529713, 2127.5532138250987, 2166.447555873258, 2177.9782202177935, 2179.106566307806, 2186.2457452178974, 7424.368928641072, 7527.47307688462, 7589.089309282866, 7601.885971710429, 7607.771766847003, 4498.640108791289, 4609.539046095397, 4619.676622636417, 4620.768961551943, 4623.653226008063, 2785.7214278572183, 2819.182437093261, 2924.897628583011, 2941.2205765472168, 3012.0963710886645, 808.7533302342783, 873.5413907698446, 877.9341549383757, 895.5835536475505, 896.1531352871539, 9610.0, 9770.706878793648, 9789.90210097897, 9802.117809397118, 9812.705618831375, 4081.8163182656854, 4120.237756015087, 4186.748795072244, 4236.703430759817, 4351.26028575143, 8541.188587084218, 8566.3146948244, 8573.871391929126, 8577.785555361166, 8591.613377398033, 4515.864524064284, 4562.110388474216, 4569.520200378979, 4572.0627271409285, 4576.473705523841, 3636.127329440915, 3729.086373838427, 4162.771047592411, 4221.767802770877, 4226.4505614270565, 3548.8935331940083, 3563.6792688658147, 3621.492990981265, 3634.3094811986166, 3687.612800655946, 1194.6714653470192, 1207.8053548364526, 1211.9515219391126, 1212.9575464858688, 1218.4943248551929, 821.7493664432286, 835.4861760017545, 839.1734141870253, 865.4763867859854, 879.1077056787366, 4641.582257596832, 4853.369062021915, 4882.389701287339, 4883.975580122076, 4900.313956046157, 409.53926832313647, 859.2524503681836, 917.605429665237, 935.9719208423758, 945.2768631996528, 3300.372929143503, 3321.451960426551, 3351.614564325085, 3353.6311005789344, 3439.8968030959113, 8969.416987895765, 9199.954000229956, 9305.906940930505, 9309.767255818659, 9311.90688093124, 9146.496942668084, 9223.76940576491, 9229.169374756304, 9230.353875228804, 9238.722838314861, 6950.235474097845, 7027.754028608974, 7028.894566581505, 7142.92857071433, 7155.499115061895, 4741.146593613183, 4825.420949485943, 4837.7097374157665, 4870.439899411472, 4923.926141107958, 8468.957655211685, 8486.830263394573, 8495.0, 8514.10601886793, 8575.871361929701, 7966.482178658369, 8341.624626891926, 8365.749027529184, 8521.147885211678, 8649.783755406164, 5864.912026319694, 6034.849128771641, 6523.64119973406, 6616.536842420985, 6628.436582890508, 7076.858462830817, 7281.089863767029, 7319.487635865438, 7341.119065712149, 7413.703451862081, 6546.410823025951, 6857.588544687334, 6878.449724021966, 6886.208086070166, 6960.4779641526075, 6658.533902626963, 6659.167604049494, 6692.364225398579, 6743.629100399525, 6975.895361569479, 5478.096114141122, 5643.266375371176, 5718.628289161191, 5719.714014299351, 5723.370429252695, 4367.475902891673, 4382.408374869352, 4389.23188442015, 4391.912161756811, 4426.203283409017, 4366.628836548929, 4423.933640995452, 4426.800793964344, 4436.9334459983775, 4525.140223357552], "value": 4010.2633242663746, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.6678488473738, 343.1712414518937, 351.91905861651804, 355.03784743345534, 356.94288913773795, 4801.783919723612, 4836.17784976554, 4868.415790105183, 4871.318015477831, 4884.951150488494, 4792.520747925215, 4806.0, 4821.397325334333, 4822.252550854623, 4836.758162091899, 3734.9439758403646, 3797.449369841371, 3804.8097595120134, 3880.3791393377064, 3933.6656384207377, 3899.083715326896, 3900.4344370066324, 3901.7463864848696, 3924.136689928211, 3947.059440716656, 3895.337792575269, 3897.3179693553516, 3919.8628048018327, 3925.2738243425056, 3934.957236332374, 3594.8202589870402, 3743.681787048077, 3886.514185726784, 3952.940705889414, 3957.2876882161054, 3302.3065156317202, 3304.5538852254876, 3313.1385839681616, 3314.105191598279, 3317.8506967186536, 4721.881952951169, 4728.810847566093, 4762.166620841339, 4772.141014617368, 4785.808567657289, 4244.61798438139, 4257.0, 4262.6376757975295, 4284.67864910133, 4288.0, 4978.626603004789, 5054.1407960646775, 5061.392632884041, 5073.239014147871, 5078.61910356721, 3578.35589593873, 3587.1749497615697, 3598.874039408608, 3601.477785721082, 3608.278344331118, 5279.973600131974, 5306.469353064663, 5331.653442526263, 5351.759170837322, 5362.943122420261, 3543.3799085159994, 3602.955143008498, 3611.0972256935765, 3650.7261955353456, 3678.503402040744, 3655.0314166745834, 3705.8517659293866, 3707.369747142938, 3712.3317802795755, 3742.3450896093077, 4271.3341796699315, 4274.0, 4276.636485898671, 4286.164197981364, 4296.742195468282, 4899.902001960012, 5090.389153301628, 5103.438621751604, 5111.361079865017, 5130.640855140105, 1256.7863463211277, 1259.4521383198337, 1271.6139408045276, 1273.9745205095846, 1276.9297688627214, 824.443722112234, 854.7734850264685, 862.3877047296489, 863.494855509534, 865.8008658008694, 4439.689221754446, 4509.368688383629, 4514.796834142471, 4516.841910533116, 4536.523665015192, 5231.482869967743, 5236.947630523646, 5262.631615786935, 5264.789408423697, 5303.28405665238, 4533.52397998212, 4541.72749635023, 4546.65900057497, 4563.429571303587, 4564.3838081859185, 2602.2323414592743, 2700.554408522572, 2708.390612112298, 2729.959050614242, 2739.369944912681, 4810.6427850353775, 4813.446453657874, 4822.468204192756, 4829.468758436569, 4875.805887350706, 5116.283720279164, 5240.213967904845, 5261.316028916293, 5271.5255626992985, 5296.25852380667, 4720.583824852531, 4776.853555146739, 4837.637177211724, 4869.245266983623, 4878.146324393217, 5158.845234642967, 5160.071187186192, 5173.198154286091, 5181.186584695477, 5181.948180518147, 4903.632227582874, 5075.187969924795, 5088.949110508996, 5114.872128196825, 5125.282460455464, 4939.876503087452, 4956.603471722326, 4969.329140566122, 4972.453030166751, 4985.407588054264, 3679.2825399048, 3689.409694448875, 3694.464302676043, 3714.0900479382726, 3721.5348081489815, 5086.82073703935, 5313.442088580643, 5335.466453354634, 5338.706371149624, 5339.519443250126, 5105.591552675852, 5118.74406279692, 5119.257707632298, 5119.564836988898, 5133.6919784813035, 5112.437631860566, 5121.181980397055, 5133.512316329943, 5150.201718733602, 5173.22401639757, 4940.2079982417, 4947.455779864284, 5010.799568017239, 5044.54599086084, 5070.771815268248, 4983.875403114951, 5120.283160357628, 5124.333836601367, 5138.76875540609, 5147.6911385317, 5004.1492946198505, 5012.749362531786, 5025.84922452327, 5036.345275114211, 5066.746662666778], "value": 3845.3658386221127, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.5242282824851, 697.9302069793018, 700.1038670501758, 705.8588282343533, 722.4942540221845, 11518.884811151896, 12471.688207794821, 12485.126041177109, 12512.249265044104, 12520.499180032788, 12578.245305281689, 12620.747585048317, 12665.113442059059, 12713.618591442248, 12719.42762575684, 678.993210067898, 694.2432748304348, 808.4542933519865, 824.7855557555049, 827.7185756842672, 800.3517151107592, 825.475822852487, 827.1108558299821, 829.0797215091244, 836.3100442135233, 863.1023735315265, 865.7792262972933, 866.0213958227195, 866.9306455483546, 868.5006121480143, 847.3009766942236, 855.1405837133641, 855.3371137368558, 855.9486430814171, 856.6830272799042, 627.6861569215392, 632.1276638239246, 632.2097378277153, 632.5382470796344, 634.3402861024529, 12024.579139730155, 12030.699232519257, 12031.51873925042, 12099.153059285854, 12368.257904525757, 12022.458989345501, 12098.0, 12202.816957745552, 12448.315342656151, 13825.861741382558, 11713.70715732105, 11754.97925621192, 11830.112741544419, 11952.0, 12138.635840924786, 4208.0, 4227.577242275778, 4248.4052232687445, 4248.426462427564, 4282.464691913511, 62598.37401625971, 65520.67239663819, 65563.67218163927, 66715.0, 68530.31469685289, 10251.923548027498, 10401.219908506891, 10406.167506599606, 10489.423081730578, 10500.369977801356, 18278.908605456887, 18383.72424413635, 18448.26206951707, 18495.075246237633, 18626.25494980213, 6271.811845644638, 6518.0, 6533.542652014314, 6558.344165583403, 6723.294054124344, 3462.8441720122655, 3472.097254713742, 3502.6322236164838, 3541.6281290464644, 3560.857565697343, 2876.3528206153446, 2908.3746994396306, 2932.4281765056035, 2933.48663983802, 3201.135693362779, 537.7338217582321, 547.9342478902478, 554.3154204557369, 568.377626498983, 568.5110804707948, 455.9931601025987, 577.4398833131855, 598.9161517387569, 599.6045797040763, 630.7350912616712, 7993.160718124629, 8002.998126171143, 8063.4355595108955, 8079.5960201989665, 8329.791755206046, 604.4378727783115, 613.5427612412349, 624.3849807939176, 627.4102343796816, 631.3970158498623, 3954.8813535593404, 3957.5053118360206, 4073.307537718595, 4170.332746760504, 4277.636400905895, 51643.22535161975, 53941.73029134829, 59651.40348596458, 61693.38306616876, 66275.66862165755, 26340.0, 36117.63882361143, 52012.0, 52159.73920130451, 53668.463315366345, 46857.531424685316, 47721.28418073732, 47918.28122578164, 49434.752826235635, 49553.25670114951, 8147.14454982242, 8557.48655080697, 8561.91438085636, 8706.956465217634, 8837.0, 34933.30133397267, 34993.12517186989, 35056.29887402289, 35423.64576354204, 35809.82095089508, 42774.0, 43498.0, 46934.0, 47384.0, 49056.264156036974, 11186.216964812385, 11321.830172547583, 11545.538178472767, 11877.46551405206, 12250.326232057323, 12692.555760548337, 13483.865161348262, 13583.728325433634, 13954.372053257424, 14651.92674036623, 11512.654620361403, 11601.883981160081, 11665.88334116648, 11870.525178992744, 11884.76230475403, 11812.70468238301, 11890.28658280506, 12428.56500022495, 12469.0, 13060.281684507443, 11282.266652667551, 11420.714482138013, 11605.187636865337, 11629.476673549541, 11816.70458238551, 10041.0, 10141.594336226763, 10279.794404111726, 10727.088197503299, 10764.0, 9065.320100992583, 9808.9019109808, 10063.647772327933, 10202.897971020195, 10254.6410875619], "value": 6316.95377714482, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1566.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 114.0, 114.0, 117.0, 116.0, 116.0, 115.0, 115.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 132.0, 130.0, 180.0, 128.0, 128.0, 141.0, 133.0, 155.0, 127.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 169.0, 174.0, 165.0, 162.0, 163.0, 162.0, 162.0, 164.0, 167.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 80.0, 114.0, 81.0, 81.0, 79.0, 81.0, 99.0, 79.0], "value": 84.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 113.0, 85.0, 85.0, 85.0, 106.0, 85.0, 84.0, 102.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 119.0, 118.0, 119.0, 118.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 150.0, 150.0, 152.0, 151.0, 153.0, 151.0, 150.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 66.0, 66.0, 65.0, 67.0, 65.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 67.0, 67.0, 69.0, 68.0, 67.0, 67.0, 67.0], "value": 67.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 85.0, 85.0, 91.0, 85.0, 85.0, 86.0, 86.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 136.0, 136.0, 138.0, 137.0, 136.0, 135.0, 134.0, 180.0, 134.0], "value": 140.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 175.0, 174.0, 179.0, 175.0, 175.0, 178.0, 177.0, 178.0, 182.0], "value": 177.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 68.0, 69.0, 67.0, 69.0, 67.0, 68.0, 67.0, 69.0, 67.0], "value": 68.5, "unit": "score"}]}]} 19:44:46 INFO - Return code: 0 19:44:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:44:46 ERROR - # TBPL SUCCESS # 19:44:46 INFO - Running post-action listener: _resource_record_post_action 19:44:46 INFO - [mozharness: 2016-12-23 03:44:46.420019Z] Finished run-tests step (success) 19:44:46 INFO - Running post-run listener: _resource_record_post_run 19:44:46 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407052288; Read time: 20; Write time: 226316 19:44:46 INFO - TinderboxPrint: CPU usage
13.5% 19:44:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 19:44:46 INFO - TinderboxPrint: I/O write bytes / time
407,052,288 / 226,316 19:44:46 INFO - TinderboxPrint: CPU idle
8,281.1 (86.5%) 19:44:46 INFO - TinderboxPrint: CPU user
1,233.8 (12.9%) 19:44:46 INFO - TinderboxPrint: Swap in / out
0 / 0 19:44:46 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110653440; Read time: 0; Write time: 58004 19:44:46 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 295501824; Read time: 0; Write time: 168284 19:44:47 INFO - Running post-run listener: _upload_blobber_files 19:44:47 INFO - Blob upload gear active. 19:44:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:44:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:44:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:44:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:44:47 INFO - (blobuploader) - INFO - Open directory for files ... 19:44:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:44:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:44:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:44:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:44:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:44:48 INFO - (blobuploader) - INFO - Done attempting. 19:44:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:44:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:44:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:44:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:44:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:44:51 INFO - (blobuploader) - INFO - Done attempting. 19:44:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:44:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:44:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:44:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:44:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:44:52 INFO - (blobuploader) - INFO - Done attempting. 19:44:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:44:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:44:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:44:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:44:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:44:52 INFO - (blobuploader) - INFO - Done attempting. 19:44:52 INFO - (blobuploader) - INFO - Iteration through files over. 19:44:52 INFO - Return code: 0 19:44:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:44:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:44:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f6b3ffce0a3b2e01af686fdd0f00a60aadc3fbd7ad15175d0b24a6e13f5279fea2f335819ac206d185825300d433ac7df272dfc48f6c3091b0fbdd7b798ca3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f32666f2df19be014d122c578366ee9cf3c74b4c4fe6ccc54c7fd2e51089f8253134809044cab583619eacb41a49ddb6f5c2608000c9b2573bc16be3a1e42c88", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6d5502f1e89124da52c828864a68ec19f786ddb8c16a9b736621651f7b5846136ba84cb2d9b1e055ec6a6cbdee73115ddacd1a533f138d66e29d56fbff0b092", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c778e427354379e5c3ecbd61714a4446d642526d12f5d6c1f5e9eff9e6942ff5341b804e9d32874ff96b8e020c09bc5b158c1d15e906f75e1a4821903ec17e3b"} 19:44:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:44:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:44:52 INFO - Contents: 19:44:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f6b3ffce0a3b2e01af686fdd0f00a60aadc3fbd7ad15175d0b24a6e13f5279fea2f335819ac206d185825300d433ac7df272dfc48f6c3091b0fbdd7b798ca3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f32666f2df19be014d122c578366ee9cf3c74b4c4fe6ccc54c7fd2e51089f8253134809044cab583619eacb41a49ddb6f5c2608000c9b2573bc16be3a1e42c88", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6d5502f1e89124da52c828864a68ec19f786ddb8c16a9b736621651f7b5846136ba84cb2d9b1e055ec6a6cbdee73115ddacd1a533f138d66e29d56fbff0b092", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c778e427354379e5c3ecbd61714a4446d642526d12f5d6c1f5e9eff9e6942ff5341b804e9d32874ff96b8e020c09bc5b158c1d15e906f75e1a4821903ec17e3b"} 19:44:52 INFO - Running post-run listener: copy_logs_to_upload_dir 19:44:52 INFO - Copying logs to upload dir... 19:44:52 INFO - mkdir: /builds/slave/test/build/upload/logs 19:44:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.715529 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-12-22 19:44:52.808385) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 19:44:52.811900) ========= 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=db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560 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/Firefox-Non-PGO/sha512/0f6b3ffce0a3b2e01af686fdd0f00a60aadc3fbd7ad15175d0b24a6e13f5279fea2f335819ac206d185825300d433ac7df272dfc48f6c3091b0fbdd7b798ca3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f32666f2df19be014d122c578366ee9cf3c74b4c4fe6ccc54c7fd2e51089f8253134809044cab583619eacb41a49ddb6f5c2608000c9b2573bc16be3a1e42c88", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6d5502f1e89124da52c828864a68ec19f786ddb8c16a9b736621651f7b5846136ba84cb2d9b1e055ec6a6cbdee73115ddacd1a533f138d66e29d56fbff0b092", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c778e427354379e5c3ecbd61714a4446d642526d12f5d6c1f5e9eff9e6942ff5341b804e9d32874ff96b8e020c09bc5b158c1d15e906f75e1a4821903ec17e3b"} build_url:https://queue.taskcluster.net/v1/task/KGZCcvIuSgW3n5hv2REF3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011355 build_url: 'https://queue.taskcluster.net/v1/task/KGZCcvIuSgW3n5hv2REF3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f6b3ffce0a3b2e01af686fdd0f00a60aadc3fbd7ad15175d0b24a6e13f5279fea2f335819ac206d185825300d433ac7df272dfc48f6c3091b0fbdd7b798ca3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f32666f2df19be014d122c578366ee9cf3c74b4c4fe6ccc54c7fd2e51089f8253134809044cab583619eacb41a49ddb6f5c2608000c9b2573bc16be3a1e42c88", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6d5502f1e89124da52c828864a68ec19f786ddb8c16a9b736621651f7b5846136ba84cb2d9b1e055ec6a6cbdee73115ddacd1a533f138d66e29d56fbff0b092", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c778e427354379e5c3ecbd61714a4446d642526d12f5d6c1f5e9eff9e6942ff5341b804e9d32874ff96b8e020c09bc5b158c1d15e906f75e1a4821903ec17e3b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 19:44:52.838445) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 19:44:52.838823) ========= 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=db0483c52d987ecb441a263b000001ad-1482461185.472944-1044926560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 19:44:52.923026) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 19:44:52.923813) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 19:44:52.924553) ========= ========= Total master_lag: 0.19 =========