builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-012 starttime: 1482124405.64 results: success (0) buildid: 20161218202235 builduid: 38c573c1c3354e26a9b52bb4cdca09db revision: a61af3f4bc6ee9fc425239806bdf988c65c1e81f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-18 21:13:25.643119) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-18 21:13:25.643533) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-18 21:13:25.643804) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-18 21:13:25.659211) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 21:13:25.659469) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-18 21:13:25-- 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% 46.4M=0s 2016-12-18 21:13:26 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.105325 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 21:13:25.780670) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 21:13:25.780966) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019079 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 21:13:25.831125) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-18 21:13:25.831447) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a61af3f4bc6ee9fc425239806bdf988c65c1e81f --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 a61af3f4bc6ee9fc425239806bdf988c65c1e81f --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=2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-18 21:13:26,207 truncating revision to first 12 chars 2016-12-18 21:13:26,207 Setting DEBUG logging. 2016-12-18 21:13:26,207 attempt 1/10 2016-12-18 21:13:26,208 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a61af3f4bc6e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-18 21:13:27,439 unpacking tar archive at: mozilla-central-a61af3f4bc6e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.538415 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-18 21:13:27.383018) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-18 21:13:27.383370) ========= script_repo_revision: a61af3f4bc6ee9fc425239806bdf988c65c1e81f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-18 21:13:27.383756) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-18 21:13:27.384036) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-18 21:13:27.393557) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-12-18 21:13:27.393889) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:13:27 INFO - MultiFileLogger online at 20161218 21:13:27 in /builds/slave/test 21:13:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 21:13:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:13:27 INFO - {'append_to_log': False, 21:13:27 INFO - 'base_work_dir': '/builds/slave/test', 21:13:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 21:13:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:13:27 INFO - 'branch': 'Firefox-Non-PGO', 21:13:27 INFO - 'buildbot_json_path': 'buildprops.json', 21:13:27 INFO - 'config_files': ('talos/linux_config.py',), 21:13:27 INFO - 'default_actions': ('clobber', 21:13:27 INFO - 'read-buildbot-config', 21:13:27 INFO - 'download-and-extract', 21:13:27 INFO - 'populate-webroot', 21:13:27 INFO - 'create-virtualenv', 21:13:27 INFO - 'install', 21:13:27 INFO - 'run-tests'), 21:13:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:13:27 INFO - 'download_minidump_stackwalk': True, 21:13:27 INFO - 'download_symbols': 'ondemand', 21:13:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:13:27 INFO - 'tooltool.py': '/tools/tooltool.py', 21:13:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:13:27 INFO - '/tools/misc-python/virtualenv.py')}, 21:13:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:13:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:13:27 INFO - 'installer_path': 'installer.exe', 21:13:27 INFO - 'log_level': 'info', 21:13:27 INFO - 'log_name': 'talos', 21:13:27 INFO - 'log_to_console': True, 21:13:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:13:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:13:27 INFO - 'opt_config_files': (), 21:13:27 INFO - 'pip_index': False, 21:13:27 INFO - 'sps_profile': False, 21:13:27 INFO - 'sps_profile_interval': 0, 21:13:27 INFO - 'suite': 'dromaeojs', 21:13:27 INFO - 'system_bits': '32', 21:13:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:13:27 INFO - 'title': 'talos-linux64-ix-012', 21:13:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:13:27 INFO - 'use_talos_json': True, 21:13:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:13:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:13:27 INFO - 'work_dir': 'build'} 21:13:27 INFO - [mozharness: 2016-12-19 05:13:27.868712Z] Running clobber step. 21:13:27 INFO - Running pre-action listener: _resource_record_pre_action 21:13:27 INFO - Running main action method: clobber 21:13:27 INFO - rmtree: /builds/slave/test/build 21:13:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:13:28 INFO - Running post-action listener: _resource_record_post_action 21:13:28 INFO - [mozharness: 2016-12-19 05:13:28.846683Z] Finished clobber step (success) 21:13:28 INFO - [mozharness: 2016-12-19 05:13:28.846783Z] Running read-buildbot-config step. 21:13:28 INFO - Running pre-action listener: _resource_record_pre_action 21:13:28 INFO - Running main action method: read_buildbot_config 21:13:28 INFO - Using buildbot properties: 21:13:28 INFO - { 21:13:28 INFO - "project": "", 21:13:28 INFO - "product": "firefox", 21:13:28 INFO - "script_repo_revision": "production", 21:13:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 21:13:28 INFO - "repository": "", 21:13:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 21:13:28 INFO - "buildid": "20161218202235", 21:13:28 INFO - "pgo_build": "False", 21:13:28 INFO - "basedir": "/builds/slave/test", 21:13:28 INFO - "buildnumber": 882, 21:13:28 INFO - "slavename": "talos-linux64-ix-012", 21:13:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:13:28 INFO - "platform": "ubuntu64_hw", 21:13:28 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 21:13:28 INFO - "branch": "mozilla-central", 21:13:28 INFO - "repo_path": "mozilla-central", 21:13:28 INFO - "revision": "a61af3f4bc6ee9fc425239806bdf988c65c1e81f", 21:13:28 INFO - "stage_platform": "linux64", 21:13:28 INFO - "builduid": "38c573c1c3354e26a9b52bb4cdca09db", 21:13:28 INFO - "slavebuilddir": "test" 21:13:28 INFO - } 21:13:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/MwmZEgytS2OCviwCAt76pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 21:13:28 INFO - Running post-action listener: _resource_record_post_action 21:13:28 INFO - [mozharness: 2016-12-19 05:13:28.849242Z] Finished read-buildbot-config step (success) 21:13:28 INFO - [mozharness: 2016-12-19 05:13:28.849332Z] Running download-and-extract step. 21:13:28 INFO - Running pre-action listener: _resource_record_pre_action 21:13:28 INFO - Running main action method: download_and_extract 21:13:28 INFO - mkdir: /builds/slave/test/build/tests 21:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:28 INFO - trying https://queue.taskcluster.net/v1/task/MwmZEgytS2OCviwCAt76pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 21:13:28 INFO - Downloading https://queue.taskcluster.net/v1/task/MwmZEgytS2OCviwCAt76pA/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 21:13:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MwmZEgytS2OCviwCAt76pA/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 21:13:29 INFO - Downloaded 1361 bytes. 21:13:29 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 21:13:29 INFO - Using the following test package requirements: 21:13:29 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 21:13:29 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:13:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:13:29 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:13:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:13:29 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:13:29 INFO - u'jsshell-linux-x86_64.zip'], 21:13:29 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:13:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:13:29 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 21:13:29 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:13:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:13:29 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:13:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:13:29 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:13:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:13:29 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:13:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:13:29 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:13:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MwmZEgytS2OCviwCAt76pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 21:13:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MwmZEgytS2OCviwCAt76pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:13:29 INFO - Fetch https://queue.taskcluster.net/v1/task/MwmZEgytS2OCviwCAt76pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:13:30 INFO - Expected file size: 20257475 21:13:30 INFO - Obtained file size: 20257475 21:13:34 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 21:13:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MwmZEgytS2OCviwCAt76pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 21:13:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MwmZEgytS2OCviwCAt76pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:13:34 INFO - Fetch https://queue.taskcluster.net/v1/task/MwmZEgytS2OCviwCAt76pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:13:35 INFO - Expected file size: 20257475 21:13:35 INFO - Obtained file size: 20257475 21:13:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MwmZEgytS2OCviwCAt76pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 21:13:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MwmZEgytS2OCviwCAt76pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:13:39 INFO - Fetch https://queue.taskcluster.net/v1/task/MwmZEgytS2OCviwCAt76pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:13:41 INFO - Expected file size: 14409734 21:13:41 INFO - Obtained file size: 14409734 21:13: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')]} 21:13:41 INFO - trying https://queue.taskcluster.net/v1/task/MwmZEgytS2OCviwCAt76pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 21:13:41 INFO - Downloading https://queue.taskcluster.net/v1/task/MwmZEgytS2OCviwCAt76pA/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 21:13:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MwmZEgytS2OCviwCAt76pA/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 21:13:43 INFO - Downloaded 55626570 bytes. 21:13:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MwmZEgytS2OCviwCAt76pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 21:13:43 INFO - mkdir: /builds/slave/test/properties 21:13:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:13:43 INFO - Writing to file /builds/slave/test/properties/build_url 21:13:43 INFO - Contents: 21:13:43 INFO - build_url:https://queue.taskcluster.net/v1/task/MwmZEgytS2OCviwCAt76pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 21:13:44 INFO - Running post-action listener: _resource_record_post_action 21:13:44 INFO - Running post-action listener: set_extra_try_arguments 21:13:44 INFO - [mozharness: 2016-12-19 05:13:44.661264Z] Finished download-and-extract step (success) 21:13:44 INFO - [mozharness: 2016-12-19 05:13:44.661492Z] Running populate-webroot step. 21:13:44 INFO - Running pre-action listener: _resource_record_pre_action 21:13:44 INFO - Running main action method: populate_webroot 21:13:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:13:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:13:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:13:44 INFO - '--tppagecycles', 21:13:44 INFO - '7'], 21:13:44 INFO - 'tests': ['tsvgm']}}, 21:13:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:13:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:13:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:13:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:13:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:13:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:13:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:13:44 INFO - 'talos_options': ['--disable-e10s'], 21:13:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:13:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:13:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:13:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:13:44 INFO - 'talos_options': ['--disable-e10s'], 21:13:44 INFO - 'tests': ['damp', 'tps']}, 21:13:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:13:44 INFO - 'tests': ['damp', 'tps']}, 21:13:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:13:44 INFO - 'tests': ['dromaeo_dom']}, 21:13:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:13:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:13:44 INFO - 'tests': ['basic_compositor_video']}, 21:13:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:13:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:13:44 INFO - 'tests': ['a11yr', 21:13:44 INFO - 'ts_paint', 21:13:44 INFO - 'tpaint', 21:13:44 INFO - 'sessionrestore', 21:13:44 INFO - 'sessionrestore_no_auto_restore', 21:13:44 INFO - 'tabpaint']}, 21:13:44 INFO - 'other-e10s': {'tests': ['a11yr', 21:13:44 INFO - 'ts_paint', 21:13:44 INFO - 'tpaint', 21:13:44 INFO - 'sessionrestore', 21:13:44 INFO - 'sessionrestore_no_auto_restore', 21:13:44 INFO - 'tabpaint']}, 21:13:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:13:44 INFO - 'ts_paint', 21:13:44 INFO - 'tpaint', 21:13:44 INFO - 'sessionrestore', 21:13:44 INFO - 'sessionrestore_no_auto_restore', 21:13:44 INFO - 'tabpaint']}, 21:13:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:13:44 INFO - 'ts_paint', 21:13:44 INFO - 'tpaint', 21:13:44 INFO - 'sessionrestore', 21:13:44 INFO - 'sessionrestore_no_auto_restore', 21:13:44 INFO - 'tabpaint']}, 21:13:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:13:44 INFO - 'tests': ['a11yr', 21:13:44 INFO - 'ts_paint', 21:13:44 INFO - 'tpaint', 21:13:44 INFO - 'sessionrestore', 21:13:44 INFO - 'sessionrestore_no_auto_restore', 21:13:44 INFO - 'tabpaint']}, 21:13:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:13:44 INFO - 'tests': ['a11yr', 21:13:44 INFO - 'ts_paint', 21:13:44 INFO - 'tpaint', 21:13:44 INFO - 'sessionrestore', 21:13:44 INFO - 'sessionrestore_no_auto_restore', 21:13:44 INFO - 'tabpaint']}, 21:13:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:13:44 INFO - 'tests': ['tsvgx', 21:13:44 INFO - 'tsvgr_opacity', 21:13:44 INFO - 'tart', 21:13:44 INFO - 'tscrollx', 21:13:44 INFO - 'cart', 21:13:44 INFO - 'tsvg_static']}, 21:13:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:13:44 INFO - 'tsvgr_opacity', 21:13:44 INFO - 'tart', 21:13:44 INFO - 'tscrollx', 21:13:44 INFO - 'cart', 21:13:44 INFO - 'tsvg_static']}, 21:13:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:13:44 INFO - 'talos_options': ['--disable-e10s'], 21:13:44 INFO - 'tests': ['tp5o']}, 21:13:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:13:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:13:44 INFO - 'talos_options': ['--disable-e10s', 21:13:44 INFO - '--xperf_path', 21:13:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:13:44 INFO - 'tests': ['tp5n']}, 21:13:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:13:44 INFO - 'talos_options': ['--xperf_path', 21:13:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:13:44 INFO - 'tests': ['tp5n']}}, 21:13:44 INFO - 'talos.zip': {'path': '', 21:13:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:13:44 INFO - Running post-action listener: _resource_record_post_action 21:13:44 INFO - [mozharness: 2016-12-19 05:13:44.683751Z] Finished populate-webroot step (success) 21:13:44 INFO - [mozharness: 2016-12-19 05:13:44.683840Z] Running create-virtualenv step. 21:13:44 INFO - Running pre-action listener: _resource_record_pre_action 21:13:44 INFO - Running main action method: create_virtualenv 21:13:44 INFO - Creating virtualenv /builds/slave/test/build/venv 21:13:44 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 21:13:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:13:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:13:44 INFO - Using real prefix '/usr' 21:13:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:13:45 INFO - Installing distribute.............................................................................................................................................................................................done. 21:13:47 INFO - Installing pip.................done. 21:13:47 INFO - Return code: 0 21:13:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:13:47 INFO - Reading from file tmpfile_stdout 21:13:47 INFO - Output received: 21:13:47 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) 21:13:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1448850>, '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 0x13bd6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bdb60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372', '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 21:13:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:13:47 INFO - Using env: {'DISPLAY': ':0', 21:13:47 INFO - 'HOME': '/home/cltbld', 21:13:47 INFO - 'LANG': 'en_US.UTF-8', 21:13:47 INFO - 'LANGUAGE': 'en_US:en', 21:13:47 INFO - 'LOGNAME': 'cltbld', 21:13:47 INFO - 'MAIL': '/var/mail/cltbld', 21:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:47 INFO - 'MOZ_NO_REMOTE': '1', 21:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:47 INFO - 'NO_EM_RESTART': '1', 21:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:47 INFO - 'PWD': '/builds/slave/test', 21:13:47 INFO - 'SHELL': '/bin/bash', 21:13:47 INFO - 'SHLVL': '1', 21:13:47 INFO - 'TERM': 'linux', 21:13:47 INFO - 'TMOUT': '86400', 21:13:47 INFO - 'USER': 'cltbld', 21:13:47 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372', 21:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:47 INFO - '_': '/tools/buildbot/bin/python'} 21:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:13:47 INFO - Cleaning up... 21:13:47 INFO - Return code: 0 21:13:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1448850>, '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 0x13bd6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bdb60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372', '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 21:13:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:13:47 INFO - Using env: {'DISPLAY': ':0', 21:13:47 INFO - 'HOME': '/home/cltbld', 21:13:47 INFO - 'LANG': 'en_US.UTF-8', 21:13:47 INFO - 'LANGUAGE': 'en_US:en', 21:13:47 INFO - 'LOGNAME': 'cltbld', 21:13:47 INFO - 'MAIL': '/var/mail/cltbld', 21:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:47 INFO - 'MOZ_NO_REMOTE': '1', 21:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:47 INFO - 'NO_EM_RESTART': '1', 21:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:47 INFO - 'PWD': '/builds/slave/test', 21:13:47 INFO - 'SHELL': '/bin/bash', 21:13:47 INFO - 'SHLVL': '1', 21:13:47 INFO - 'TERM': 'linux', 21:13:47 INFO - 'TMOUT': '86400', 21:13:47 INFO - 'USER': 'cltbld', 21:13:47 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372', 21:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:47 INFO - '_': '/tools/buildbot/bin/python'} 21:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:47 INFO - Downloading/unpacking psutil>=3.1.1 21:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:13:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:13:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:13:50 INFO - Installing collected packages: psutil 21:13:50 INFO - Running setup.py install for psutil 21:13:50 INFO - building 'psutil._psutil_linux' extension 21:13:50 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 21:13:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:13:50 INFO - building 'psutil._psutil_posix' extension 21:13:50 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 21:13:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:13:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:13:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:13:50 INFO - Successfully installed psutil 21:13:50 INFO - Cleaning up... 21:13:50 INFO - Return code: 0 21:13:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:50 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 0x104d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1448850>, '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 0x13bd6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bdb60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372', '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 21:13:50 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 21:13:50 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 21:13:50 INFO - Using env: {'DISPLAY': ':0', 21:13:50 INFO - 'HOME': '/home/cltbld', 21:13:50 INFO - 'LANG': 'en_US.UTF-8', 21:13:50 INFO - 'LANGUAGE': 'en_US:en', 21:13:50 INFO - 'LOGNAME': 'cltbld', 21:13:50 INFO - 'MAIL': '/var/mail/cltbld', 21:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:50 INFO - 'MOZ_NO_REMOTE': '1', 21:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:50 INFO - 'NO_EM_RESTART': '1', 21:13:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:50 INFO - 'PWD': '/builds/slave/test', 21:13:50 INFO - 'SHELL': '/bin/bash', 21:13:50 INFO - 'SHLVL': '1', 21:13:50 INFO - 'TERM': 'linux', 21:13:50 INFO - 'TMOUT': '86400', 21:13:50 INFO - 'USER': 'cltbld', 21:13:50 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372', 21:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:50 INFO - '_': '/tools/buildbot/bin/python'} 21:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:13:50 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 21:13:50 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 21:13:50 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 21:13:50 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 21:13:50 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 21:13:50 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 21:13:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:13:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:13:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:13:52 INFO - Installing collected packages: mozsystemmonitor 21:13:52 INFO - Running setup.py install for mozsystemmonitor 21:13:52 INFO - Successfully installed mozsystemmonitor 21:13:52 INFO - Cleaning up... 21:13:52 INFO - Return code: 0 21:13:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:13:52 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')]} 21:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:52 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')]} 21:13:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1448850>, '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 0x13bd6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bdb60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372', '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 21:13:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:13:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:13:53 INFO - Using env: {'DISPLAY': ':0', 21:13:53 INFO - 'HOME': '/home/cltbld', 21:13:53 INFO - 'LANG': 'en_US.UTF-8', 21:13:53 INFO - 'LANGUAGE': 'en_US:en', 21:13:53 INFO - 'LOGNAME': 'cltbld', 21:13:53 INFO - 'MAIL': '/var/mail/cltbld', 21:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:53 INFO - 'MOZ_NO_REMOTE': '1', 21:13:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:53 INFO - 'NO_EM_RESTART': '1', 21:13:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:53 INFO - 'PWD': '/builds/slave/test', 21:13:53 INFO - 'SHELL': '/bin/bash', 21:13:53 INFO - 'SHLVL': '1', 21:13:53 INFO - 'TERM': 'linux', 21:13:53 INFO - 'TMOUT': '86400', 21:13:53 INFO - 'USER': 'cltbld', 21:13:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372', 21:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:53 INFO - '_': '/tools/buildbot/bin/python'} 21:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:53 INFO - Downloading/unpacking jsonschema==2.5.1 21:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:13:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:55 INFO - Downloading functools32-3.2.3-2.tar.gz 21:13:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:13:55 INFO - warning: no files found matching '*.txt' 21:13:55 INFO - no previously-included directories found matching 'build' 21:13:55 INFO - no previously-included directories found matching 'dist' 21:13:55 INFO - no previously-included directories found matching '.git*' 21:13:55 INFO - Installing collected packages: jsonschema, functools32 21:13:55 INFO - Running setup.py install for functools32 21:13:55 INFO - warning: no files found matching '*.txt' 21:13:55 INFO - no previously-included directories found matching 'build' 21:13:55 INFO - no previously-included directories found matching 'dist' 21:13:55 INFO - no previously-included directories found matching '.git*' 21:13:55 INFO - Successfully installed jsonschema functools32 21:13:55 INFO - Cleaning up... 21:13:55 INFO - Return code: 0 21:13:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:55 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 0x104d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1448850>, '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 0x13bd6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bdb60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372', '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 21:13:55 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 21:13:55 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 21:13:55 INFO - Using env: {'DISPLAY': ':0', 21:13:55 INFO - 'HOME': '/home/cltbld', 21:13:55 INFO - 'LANG': 'en_US.UTF-8', 21:13:55 INFO - 'LANGUAGE': 'en_US:en', 21:13:55 INFO - 'LOGNAME': 'cltbld', 21:13:55 INFO - 'MAIL': '/var/mail/cltbld', 21:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:55 INFO - 'MOZ_NO_REMOTE': '1', 21:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:55 INFO - 'NO_EM_RESTART': '1', 21:13:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:55 INFO - 'PWD': '/builds/slave/test', 21:13:55 INFO - 'SHELL': '/bin/bash', 21:13:55 INFO - 'SHLVL': '1', 21:13:55 INFO - 'TERM': 'linux', 21:13:55 INFO - 'TMOUT': '86400', 21:13:55 INFO - 'USER': 'cltbld', 21:13:55 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372', 21:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:55 INFO - '_': '/tools/buildbot/bin/python'} 21:13:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:13:55 INFO - Cleaning up... 21:13:55 INFO - Return code: 0 21:13:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:55 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 0x104d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1448850>, '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 0x13bd6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bdb60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372', '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 21:13:55 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 21:13:55 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 21:13:55 INFO - Using env: {'DISPLAY': ':0', 21:13:55 INFO - 'HOME': '/home/cltbld', 21:13:55 INFO - 'LANG': 'en_US.UTF-8', 21:13:55 INFO - 'LANGUAGE': 'en_US:en', 21:13:55 INFO - 'LOGNAME': 'cltbld', 21:13:55 INFO - 'MAIL': '/var/mail/cltbld', 21:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:55 INFO - 'MOZ_NO_REMOTE': '1', 21:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:55 INFO - 'NO_EM_RESTART': '1', 21:13:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:55 INFO - 'PWD': '/builds/slave/test', 21:13:55 INFO - 'SHELL': '/bin/bash', 21:13:55 INFO - 'SHLVL': '1', 21:13:55 INFO - 'TERM': 'linux', 21:13:55 INFO - 'TMOUT': '86400', 21:13:55 INFO - 'USER': 'cltbld', 21:13:55 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372', 21:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:55 INFO - '_': '/tools/buildbot/bin/python'} 21:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:56 INFO - Downloading/unpacking blobuploader==1.2.4 21:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:58 INFO - Downloading blobuploader-1.2.4.tar.gz 21:13:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:13:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:13:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:59 INFO - Downloading docopt-0.6.1.tar.gz 21:13:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:13:59 INFO - Installing collected packages: blobuploader, requests, docopt 21:13:59 INFO - Running setup.py install for blobuploader 21:13:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:13:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:13:59 INFO - Running setup.py install for requests 21:13:59 INFO - Running setup.py install for docopt 21:13:59 INFO - Successfully installed blobuploader requests docopt 21:13:59 INFO - Cleaning up... 21:13:59 INFO - Return code: 0 21:13:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1448850>, '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 0x13bd6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bdb60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372', '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 21:13:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:13:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:13:59 INFO - Using env: {'DISPLAY': ':0', 21:13:59 INFO - 'HOME': '/home/cltbld', 21:13:59 INFO - 'LANG': 'en_US.UTF-8', 21:13:59 INFO - 'LANGUAGE': 'en_US:en', 21:13:59 INFO - 'LOGNAME': 'cltbld', 21:13:59 INFO - 'MAIL': '/var/mail/cltbld', 21:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:59 INFO - 'MOZ_NO_REMOTE': '1', 21:13:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:59 INFO - 'NO_EM_RESTART': '1', 21:13:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:59 INFO - 'PWD': '/builds/slave/test', 21:13:59 INFO - 'SHELL': '/bin/bash', 21:13:59 INFO - 'SHLVL': '1', 21:13:59 INFO - 'TERM': 'linux', 21:13:59 INFO - 'TMOUT': '86400', 21:13:59 INFO - 'USER': 'cltbld', 21:13:59 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372', 21:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:59 INFO - '_': '/tools/buildbot/bin/python'} 21:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:13:59 INFO - Running setup.py (path:/tmp/pip-yregIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:14:00 INFO - Running setup.py (path:/tmp/pip-zuAk5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:14:00 INFO - Running setup.py (path:/tmp/pip-y_XwHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:14:00 INFO - Running setup.py (path:/tmp/pip-9iS0Jq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:14:00 INFO - Running setup.py (path:/tmp/pip-XswHcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:14:00 INFO - Running setup.py (path:/tmp/pip-MHSoMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:14:00 INFO - Running setup.py (path:/tmp/pip-6MNj4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:14:00 INFO - Running setup.py (path:/tmp/pip-dxcbPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:14:00 INFO - Running setup.py (path:/tmp/pip-LFAUYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:14:00 INFO - Running setup.py (path:/tmp/pip-MjEPGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:14:00 INFO - Running setup.py (path:/tmp/pip-FHgSz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:14:00 INFO - Running setup.py (path:/tmp/pip-CtjpvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:14:00 INFO - Running setup.py (path:/tmp/pip-uvljim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:14:00 INFO - Running setup.py (path:/tmp/pip-lX_A3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:14:00 INFO - Running setup.py (path:/tmp/pip-ayPF7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:14:01 INFO - Running setup.py (path:/tmp/pip-1LbwlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:14:01 INFO - Running setup.py (path:/tmp/pip-mKEcEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:14:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:14:01 INFO - Running setup.py install for manifestparser 21:14:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:14:01 INFO - Running setup.py install for mozcrash 21:14:01 INFO - Running setup.py install for mozdebug 21:14:01 INFO - Running setup.py install for mozdevice 21:14:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:14:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:14:01 INFO - Running setup.py install for mozfile 21:14:01 INFO - Running setup.py install for mozhttpd 21:14:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:14:01 INFO - Running setup.py install for mozinfo 21:14:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:14:01 INFO - Running setup.py install for mozInstall 21:14:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:14:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:14:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:14:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:14:01 INFO - Running setup.py install for mozleak 21:14:02 INFO - Running setup.py install for mozlog 21:14:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:14:02 INFO - Running setup.py install for moznetwork 21:14:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:14:02 INFO - Running setup.py install for mozprocess 21:14:02 INFO - Running setup.py install for mozprofile 21:14:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:14:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:14:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:14:02 INFO - Running setup.py install for mozrunner 21:14:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:14:02 INFO - Running setup.py install for mozscreenshot 21:14:02 INFO - Running setup.py install for moztest 21:14:02 INFO - Running setup.py install for mozversion 21:14:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:14:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:14:02 INFO - Cleaning up... 21:14:02 INFO - Return code: 0 21:14:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:14: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')]} 21:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14: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')]} 21:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1448850>, '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 0x13bd6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bdb60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372', '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 21:14:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:14:03 INFO - Using env: {'DISPLAY': ':0', 21:14:03 INFO - 'HOME': '/home/cltbld', 21:14:03 INFO - 'LANG': 'en_US.UTF-8', 21:14:03 INFO - 'LANGUAGE': 'en_US:en', 21:14:03 INFO - 'LOGNAME': 'cltbld', 21:14:03 INFO - 'MAIL': '/var/mail/cltbld', 21:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:03 INFO - 'MOZ_NO_REMOTE': '1', 21:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:14:03 INFO - 'NO_EM_RESTART': '1', 21:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:03 INFO - 'PWD': '/builds/slave/test', 21:14:03 INFO - 'SHELL': '/bin/bash', 21:14:03 INFO - 'SHLVL': '1', 21:14:03 INFO - 'TERM': 'linux', 21:14:03 INFO - 'TMOUT': '86400', 21:14:03 INFO - 'USER': 'cltbld', 21:14:03 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372', 21:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:03 INFO - '_': '/tools/buildbot/bin/python'} 21:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:14:03 INFO - Running setup.py (path:/tmp/pip-Ho6Odu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:14:03 INFO - Running setup.py (path:/tmp/pip-rBED39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:14:03 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)) 21:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:14:03 INFO - Running setup.py (path:/tmp/pip-aCuLka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:14:03 INFO - Running setup.py (path:/tmp/pip-z7CUpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:14:03 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)) 21:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:14:03 INFO - Running setup.py (path:/tmp/pip-YmzmeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:14:03 INFO - Running setup.py (path:/tmp/pip-0jYJXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:14:03 INFO - Running setup.py (path:/tmp/pip-OOv9zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:14:03 INFO - Running setup.py (path:/tmp/pip-_XYUrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:14:03 INFO - Running setup.py (path:/tmp/pip-Pn92jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:14:03 INFO - Running setup.py (path:/tmp/pip-hS0F_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:14:03 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)) 21:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:14:03 INFO - Running setup.py (path:/tmp/pip-s3eh6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:14:04 INFO - Running setup.py (path:/tmp/pip-GbdZSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:14:04 INFO - Running setup.py (path:/tmp/pip-ZoFz_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:14:04 INFO - Running setup.py (path:/tmp/pip-jsj2cK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:14:04 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)) 21:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:14:04 INFO - Running setup.py (path:/tmp/pip-2nUo7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:14:04 INFO - Running setup.py (path:/tmp/pip-jxphcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:14:04 INFO - Running setup.py (path:/tmp/pip-plImCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:14:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:06 INFO - Downloading blessings-1.6.tar.gz 21:14:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:14:06 INFO - Installing collected packages: blessings 21:14:06 INFO - Running setup.py install for blessings 21:14:06 INFO - Successfully installed blessings 21:14:06 INFO - Cleaning up... 21:14:06 INFO - Return code: 0 21:14:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:14:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:14:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:14:06 INFO - Reading from file tmpfile_stdout 21:14:06 INFO - Current package versions: 21:14:06 INFO - argparse == 1.2.1 21:14:06 INFO - blessings == 1.6 21:14:06 INFO - blobuploader == 1.2.4 21:14:06 INFO - docopt == 0.6.1 21:14:06 INFO - functools32 == 3.2.3-2 21:14:06 INFO - jsonschema == 2.5.1 21:14:06 INFO - manifestparser == 1.1 21:14:06 INFO - mozInstall == 1.12 21:14:06 INFO - mozcrash == 1.0 21:14:06 INFO - mozdebug == 0.1 21:14:06 INFO - mozdevice == 0.49 21:14:06 INFO - mozfile == 1.2 21:14:06 INFO - mozhttpd == 0.7 21:14:06 INFO - mozinfo == 0.9 21:14:06 INFO - mozleak == 0.1 21:14:06 INFO - mozlog == 3.4 21:14:06 INFO - moznetwork == 0.27 21:14:06 INFO - mozprocess == 0.23 21:14:06 INFO - mozprofile == 0.28 21:14:06 INFO - mozrunner == 6.13 21:14:06 INFO - mozscreenshot == 0.1 21:14:06 INFO - mozsystemmonitor == 0.3 21:14:06 INFO - moztest == 0.7 21:14:06 INFO - mozversion == 1.4 21:14:06 INFO - psutil == 3.1.1 21:14:06 INFO - requests == 1.2.3 21:14:06 INFO - wsgiref == 0.1.2 21:14:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1448850>, '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 0x13bd6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bdb60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372', '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 21:14:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:14:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:14:06 INFO - Using env: {'DISPLAY': ':0', 21:14:06 INFO - 'HOME': '/home/cltbld', 21:14:06 INFO - 'LANG': 'en_US.UTF-8', 21:14:06 INFO - 'LANGUAGE': 'en_US:en', 21:14:06 INFO - 'LOGNAME': 'cltbld', 21:14:06 INFO - 'MAIL': '/var/mail/cltbld', 21:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:06 INFO - 'MOZ_NO_REMOTE': '1', 21:14:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:14:06 INFO - 'NO_EM_RESTART': '1', 21:14:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:06 INFO - 'PWD': '/builds/slave/test', 21:14:06 INFO - 'SHELL': '/bin/bash', 21:14:06 INFO - 'SHLVL': '1', 21:14:06 INFO - 'TERM': 'linux', 21:14:06 INFO - 'TMOUT': '86400', 21:14:06 INFO - 'USER': 'cltbld', 21:14:06 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372', 21:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:06 INFO - '_': '/tools/buildbot/bin/python'} 21:14:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:14:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:14:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:14:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:14:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:14:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:14:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:14:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:14:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:14:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:14:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:14:07 INFO - Cleaning up... 21:14:07 INFO - Return code: 0 21:14:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1448850>, '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 0x13bd6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bdb60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372', '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 21:14:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:14:07 INFO - Using env: {'DISPLAY': ':0', 21:14:07 INFO - 'HOME': '/home/cltbld', 21:14:07 INFO - 'LANG': 'en_US.UTF-8', 21:14:07 INFO - 'LANGUAGE': 'en_US:en', 21:14:07 INFO - 'LOGNAME': 'cltbld', 21:14:07 INFO - 'MAIL': '/var/mail/cltbld', 21:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:07 INFO - 'MOZ_NO_REMOTE': '1', 21:14:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:14:07 INFO - 'NO_EM_RESTART': '1', 21:14:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:07 INFO - 'PWD': '/builds/slave/test', 21:14:07 INFO - 'SHELL': '/bin/bash', 21:14:07 INFO - 'SHLVL': '1', 21:14:07 INFO - 'TERM': 'linux', 21:14:07 INFO - 'TMOUT': '86400', 21:14:07 INFO - 'USER': 'cltbld', 21:14:07 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372', 21:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:07 INFO - '_': '/tools/buildbot/bin/python'} 21:14:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:14:07 INFO - Cleaning up... 21:14:07 INFO - Return code: 0 21:14:07 INFO - Running post-action listener: _resource_record_post_action 21:14:07 INFO - Running post-action listener: _start_resource_monitoring 21:14:07 INFO - Starting resource monitoring. 21:14:07 INFO - [mozharness: 2016-12-19 05:14:07.416752Z] Finished create-virtualenv step (success) 21:14:07 INFO - [mozharness: 2016-12-19 05:14:07.417235Z] Running install step. 21:14:07 INFO - Running pre-action listener: _resource_record_pre_action 21:14:07 INFO - Running main action method: install 21:14:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:14:07 INFO - Reading from file tmpfile_stdout 21:14:07 INFO - Detecting whether we're running mozinstall >=1.0... 21:14:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:14:07 INFO - Reading from file tmpfile_stdout 21:14:07 INFO - Output received: 21:14:07 INFO - Usage: mozinstall [options] installer 21:14:07 INFO - Options: 21:14:07 INFO - -h, --help show this help message and exit 21:14:07 INFO - -d DEST, --destination=DEST 21:14:07 INFO - Directory to install application into. [default: 21:14:07 INFO - "/builds/slave/test"] 21:14:07 INFO - --app=APP Application being installed. [default: firefox] 21:14:07 INFO - mkdir: /builds/slave/test/build/application 21:14:07 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'] 21:14:07 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 21:14:23 INFO - Reading from file tmpfile_stdout 21:14:23 INFO - Output received: 21:14:23 INFO - /builds/slave/test/build/application/firefox/firefox 21:14:23 INFO - Running post-action listener: _resource_record_post_action 21:14:23 INFO - [mozharness: 2016-12-19 05:14:23.799333Z] Finished install step (success) 21:14:23 INFO - [mozharness: 2016-12-19 05:14:23.799665Z] Running run-tests step. 21:14:23 INFO - Running pre-action listener: _resource_record_pre_action 21:14:23 INFO - Running main action method: run_tests 21:14:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:14:23 INFO - Python 2.7.3 21:14:23 INFO - Return code: 0 21:14:23 INFO - grabbing minidump binary from tooltool 21:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:23 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 0x1448850>, '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 0x13bd6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bdb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:14:23 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 21:14:23 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 21:14:23 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 21:14:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:14:23 INFO - Return code: 0 21:14:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:14:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:14:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:14:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:14:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:14:23 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MwmZEgytS2OCviwCAt76pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:14:23 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MwmZEgytS2OCviwCAt76pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:14:23 INFO - Using env: {'DISPLAY': ':0', 21:14:23 INFO - 'HOME': '/home/cltbld', 21:14:23 INFO - 'LANG': 'en_US.UTF-8', 21:14:23 INFO - 'LANGUAGE': 'en_US:en', 21:14:23 INFO - 'LOGNAME': 'cltbld', 21:14:23 INFO - 'MAIL': '/var/mail/cltbld', 21:14:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:14:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:23 INFO - 'MOZ_NO_REMOTE': '1', 21:14:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:14:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:14:23 INFO - 'NO_EM_RESTART': '1', 21:14:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:23 INFO - 'PWD': '/builds/slave/test', 21:14:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:14:23 INFO - 'SHELL': '/bin/bash', 21:14:23 INFO - 'SHLVL': '1', 21:14:23 INFO - 'TERM': 'linux', 21:14:23 INFO - 'TMOUT': '86400', 21:14:23 INFO - 'USER': 'cltbld', 21:14:23 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372', 21:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:23 INFO - '_': '/tools/buildbot/bin/python'} 21:14:23 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MwmZEgytS2OCviwCAt76pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:14:24 INFO - mozversion application_buildid: 20161218202235 21:14:24 INFO - mozversion application_changeset: a61af3f4bc6ee9fc425239806bdf988c65c1e81f 21:14:24 INFO - mozversion application_display_name: Nightly 21:14:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:14:24 INFO - mozversion application_name: Firefox 21:14:24 INFO - mozversion application_remotingname: firefox 21:14:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:14:24 INFO - mozversion application_vendor: Mozilla 21:14:24 INFO - mozversion application_version: 53.0a1 21:14:24 INFO - mozversion platform_buildid: 20161218202235 21:14:24 INFO - mozversion platform_changeset: a61af3f4bc6ee9fc425239806bdf988c65c1e81f 21:14:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:14:24 INFO - mozversion platform_version: 53.0a1 21:14:24 INFO - using testdate: 1482124464 21:14:24 INFO - actual date: 1482124464 21:14:24 INFO - starting webserver on 'localhost:39319' 21:14:24 INFO - SUITE-START | Running 2 tests 21:14:24 INFO - TEST-START | dromaeo_css 21:14:24 INFO - operating with platform_type : linux_ 21:14:24 INFO - Initialising browser for dromaeo_css test... 21:14:24 INFO - TEST-INFO | started process 6038 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsgrRdv/profile http://localhost:39319/getInfo.html) 21:14:27 INFO - PROCESS | 6038 | __metrics Screen width/height:1600/1200 21:14:27 INFO - PROCESS | 6038 | colorDepth:24 21:14:27 INFO - PROCESS | 6038 | Browser inner width/height: 1024/697 21:14:27 INFO - PROCESS | 6038 | __metrics 21:14:28 INFO - PROCESS | 6038 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:14:28 INFO - PROCESS | 6038 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:14:29 INFO - TEST-INFO | 6038: exit 0 21:14:29 INFO - Browser initialized. 21:14:29 INFO - Running cycle 1/1 for dromaeo_css test... 21:14:29 INFO - TEST-INFO | started process 6118 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsgrRdv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:14:41 INFO - PROCESS | 6118 | RSS: Main: 155865088 21:14:41 INFO - PROCESS | 6118 | 21:15:32 INFO - PROCESS | 6118 | 1482124532890 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] 21:17:45 INFO - PROCESS | 6118 | Cycle 1(1): loaded http://localhost:39319/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39319/tests/dromaeo/cssquery-ext.html) 21:17:48 INFO - PROCESS | 6118 | RSS: Main: 362754048 21:17:48 INFO - PROCESS | 6118 | 21:20:51 INFO - PROCESS | 6118 | Cycle 1(1): loaded http://localhost:39319/tests/dromaeo/cssquery-ext.html (next: http://localhost:39319/tests/dromaeo/cssquery-jquery.html) 21:20:51 INFO - PROCESS | 6118 | RSS: Main: 252383232 21:20:51 INFO - PROCESS | 6118 | 21:23:54 INFO - PROCESS | 6118 | Cycle 1(1): loaded http://localhost:39319/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39319/tests/dromaeo/cssquery-mootools.html) 21:23:54 INFO - PROCESS | 6118 | RSS: Main: 191897600 21:23:54 INFO - PROCESS | 6118 | 21:26:57 INFO - PROCESS | 6118 | Cycle 1(1): loaded http://localhost:39319/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39319/tests/dromaeo/cssquery-prototype.html) 21:26:57 INFO - PROCESS | 6118 | RSS: Main: 193261568 21:26:57 INFO - PROCESS | 6118 | 21:30:01 INFO - PROCESS | 6118 | Cycle 1(1): loaded http://localhost:39319/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39319/tests/dromaeo/cssquery-yui.html) 21:30:01 INFO - PROCESS | 6118 | RSS: Main: 193888256 21:30:01 INFO - PROCESS | 6118 | 21:33:04 INFO - PROCESS | 6118 | Cycle 1(1): loaded http://localhost:39319/tests/dromaeo/cssquery-yui.html (next: http://localhost:39319/tests/dromaeo/cssquery-dojo.html) 21:33:05 INFO - PROCESS | 6118 | RSS: Main: 284831744 21:33:05 INFO - PROCESS | 6118 | 21:33:05 INFO - PROCESS | 6118 | __start_tp_report 21:33:05 INFO - PROCESS | 6118 | _x_x_mozilla_page_load 21:33:05 INFO - PROCESS | 6118 | _x_x_mozilla_page_load_details 21:33:05 INFO - PROCESS | 6118 | |i|pagename|runs| 21:33:05 INFO - PROCESS | 6118 | |0;dojo.html;2594.3643807267217;2620.606908963654;2634.4862751763403;2650.628911952327;2661.015424293012;4585.724856508612;4594.839180628679;4706.4352277726675;4719.669623126382;4740.146773580754;4683.0399768047555;4688.9296660550035;4698.060387922412;4706.011737535122;4717.410323709536;4305.117450922569;4327;4327.978360108195;4334.523202447744;4367.1265746850595;4327.156204540116;4334.024844410014;4335.414719012941;4353;4363.280058790312;4288.421063156465;4308.763018034007;4316;4336.739795612258;4349.521552629209;4392.802323895432;4396.20868243716;4396.472423309224;4411.1618792429335;4431.64546836254;4216.451861258048;4241.915161696779;4275.0594869128745;4312.417823593806;4319.07139964909;4669.159551280768;4698.271767875985;4698.412698412699;4706.388169537938;4767.261074533453;4987.725675087869;4988.251762235657;5021.824236151717;5031.874203144914;5059.544640982329;4908.361912951329;4942.481039490874;4944.53026962438;5051.924221136685;5113.948860511385;4693.24908014716;4706.270528068155;4731.645126615517;4733.9053218936115;4781.067691800135;5199.688018718889;5206.661566998133;5207.973960130175;5211.374635043819;5262;4746.501617330199;4950;4963.230699241623;4963.652544321935;4966.6771659842;4868.902621947541;4935.284383764334;4994.200927851526;5029.497050294941;5045.899082018339;4968.577670898014;4976.975115124401;4984.352034235599;5013.799448022039;5023.146065168857;4955.430125535538;4965.404151501771;4966.677165984272;4968.503149685075;5015.749212539358;4051.554329023805;4079.347304431277;4115.71190016702;4177.3316269396755;4180.811863466151;3697.5008373869723;3700.9814950925074;3726.6646001859963;3729;3744.8876533704033;4367.061081867414;4384.210842048398;4393.51671316155;4396.120775844844;4436;4889.853304400874;4921.163402221559;5104.489551044866;5119.462456442095;5163.07064728345;4315.11540134278;4354.346847972766;4374.737515749065;4381.78091095444;4427.512973572904;4518.638508919278;4525.932111018337;4533.274676051882;4539.0921815637;4583.289590113538;4763.047390521979;4773.474917758975;4774.809007639656;4775.33145359643;4816.975915120543;4865.537773911473;4889.828855990023;4896.045271172087;5030.773615187252;5073;4789.544993225638;4791.880202994953;4795.112904112751;4827.975860120677;4832.565069143653;5009.198528235464;5012.223105418666;5012.674176178537;5014.323066386137;5064.620153488429;4895.6083513318135;4933.9013219736125;5085.957378737276;5093.083245015784;5097.133487307241;4856.514348565115;4859.586935110414;4861.9027619448125;4865.5864251539015;4865.829695960766;4844.685095468783;4847.636427268039;4871.5128487151005;4872.074305882013;4876.073546026244;4769;4777.283407488765;4786.44955830084;4786.44955830084;4786.521347865186;4916.926246106383;4920.852374428773;4926.137925862888;4927.1131196384995;4927.137750893651;4752;4825.059113472839;4842.564169224786;4897.8285759998225;4898.804047838046 21:33:05 INFO - PROCESS | 6118 | |1;ext.html;522.5584381197888;556.8747031917819;559.829252078116;569.4191924237275;585.2654918077811;27737.722622773766;36960.63039369609;38432.423513647285;38451.23097538047;41877.58122418775;39955.40066898999;40364.79817600908;40428;40440.39339409911;40448.59551404485;7305.342519173273;7483.176850546449;7666.540007599562;7669.348105411047;7672.693092276302;7490.438217133709;9567.569459374345;9827.312088153833;9831.115199632031;10150.441725705083;9904.702858914245;9958.20334373252;9967.152792012688;9970.302078854484;9974.401535907833;9664.806703865954;9714;9717.46553939533;9723.756906077333;9730.805383892353;9734.269929755226;9773.804523909483;9800.460974646392;9803.705888823346;9808.313418060667;37120;37298;37346.62653373458;37424.62575374239;37448;2920.8831646734106;3069.493533566981;3112.4086423579674;3247.382997230542;3323.4516304809677;27457.588136177772;27723;27821.860890695418;28344.14967550977;28687.13938581846;3413.607435144965;3429.3827111120236;3464.393731097073;3521.5245941797784;3523.859045638197;166449;167290;167360;167546;167613;50911.490885091414;51382.743086285074;51389;51425;51455;53556.46443535593;53790.19314710282;53866.46133538614;54029;54037;13330.666733331744;13471.932640336736;13497.662558436117;13500.864991350158;13517.864821351857;8832;9023.503707296162;10250;10486.790264194673;10544.841827372595;16102.838971610368;16451.42420015318;16802.075885826398;16871;16890.128678124503;6440.967795160994;6441.67791610427;6534.542582019308;6731.394174524316;6795.456363490909;766.2911806578892;847.9745607631781;882.2148288023664;1009.9747506312401;1015.3907655406697;24396.146134885195;27880;28420.573691394646;28623.85688071588;28665.57001644977;884.062893333069;901.2294488212615;910.8360495110944;933.6218831373304;942.8679984802134;12966.870331296566;13353.933230333787;13485;13541.1198272112;13579.864201358057;331378;332765;333087;333623;334268.901765316;42320.15359692789;42539.7873010633;42646.786766066594;42672.35991460131;42682.57317426786;1043.9634612788668;1095.386583513251;1143.7312231625729;1160.5531870230022;1195.8684544700077;23570.528589427773;25475.235742927744;25608.61587076158;25634.871825640752;25966.870165649052;36099.639003610675;36474.088147796516;36540.26919461649;36569.45145822868;36605.26789464142;274173;274998;275371;276437;277123;21964.780352196274;22383.44041398913;22395.32814015582;22603.547929041655;23712.881435592713;35106.82446587751;35394.522383432915;35406.46890296699;35442.29115417626;35694.64305357017;29876.850615746782;30820.383592328475;31439.68560314459;31588.526172106976;32447.513287300237;30380.84809575938;30675.693243067282;31054.37891242208;31077.067687969397;32005.839970799996;30418.543721843747;30829;30865.524498947976;31659;31779.841100794347;26289.73710262873;28031.299217519725;28135.57796633093;28309.716902831533;28545;22463.213787517358;22587.48250349904;22749.88625056864;22959.311220663407;22992.540149197255 21:33:05 INFO - PROCESS | 6118 | |2;jquery.html;338.55058650662465;360.713232979781;363.84060600337;368.49700159282577;380.3154322220003;12454.252744835316;13240.470381184754;13827.377768000439;16230.188490575454;16232.594185145377;14133.434662613508;14468.710625787504;15977.92011039946;16003.679926401464;16006.359745610162;4915.238138088593;5113.335266415361;5115.53960143587;5121.923171152435;5128.384593848743;3607.4228123500247;3819.102510909934;5644.125160600113;5870.823875283727;5939.1388248703915;5843.18195452637;6022.066579680157;6022.819315420523;6028.487578555828;6029.577929544934;5905.4094590541035;5942.5840191186635;5975;5988.011978023621;5988.520918326523;5052.797888084472;5191.5846732261325;5244.842654720364;5246.97376513115;5248.8425347239645;18201;18890.62218755617;20152.093155807877;20269.594608107902;20291.188352465884;1656.4119737493138;1759.5601099725068;1820.7541981832549;1850.3061351993003;2382.9761702383103;8650.394472386935;9138.40600360981;9421.952890235574;9613.423194608276;9669.17811985982;1610.798650168729;1621.7486289625008;1631.4126914310839;1659.7676325314465;1704.207543492282;43539.564604354186;58827.705861470844;60818.39181608171;62405.687971560306;66254.67490650257;8806.427582207136;8833.823323533494;9468.431894086378;9615.086566776145;10092.646757363456;13296.534621288209;13362.265075420752;13383.799243011363;13399.866001340057;13401.396937137852;6908.9309106909295;6912.412444942236;7051.365377116084;7098.964505177441;7106.822329441805;6541.149650545399;6542.6401547914365;6682.665866706645;6684.732610695615;6712.731490740316;4147.6267135957905;4266;4292.785360731951;4324.091940692427;4389.31965545341;1656.8343165683336;1772.7075032619473;1810.5926166612408;1835.7980622131554;1865.2352535460395;709.5955305475829;754.9352520855456;781.9335356494648;862.7713655881197;879.9868001979976;15822.76265856013;16766.497005089866;16900.661986760195;16977.745333820003;17129.82870171307;783.134636226961;784.3685832904566;785.4344871692487;841.5581819544788;915.8214148241029;8686.6525338987;9595.664151754656;9606.711798646053;9647.951760241294;9681.951590242004;318234;318596;327042;349118;356734.32656734117;75776;76195.61902190564;76740.61629691816;77044.61477692575;78456;915.8809354783969;937.9624815007323;963.0465838819518;963.9614415423305;965.6282331302499;13990.790138148139;14639.780403293746;14859.257037148316;15034.097954122788;15621.843781562038;35606.64393356137;35609.82195089008;36472;36731;37389.626103738614;40575.797121014206;41693.58306416897;44920.36353819793;45214.77392613016;48183.518164817906;7320.743773967885;7552;7694.7303694889715;7715.459917805924;7771.4559980800805;11202.15983801202;11325.814573680342;11868.287902725864;11928.463219155332;12147.75704485923;9829.31194816356;10104;10260.846087308846;10328;10712.946435268086;9729.270304727315;9884.479363520637;10055.245856560934;10148.188144948239;10520.432554356368;7803.297703206738;10138.341007834468;10591.20565957541;10640.148788097089;10839;6594.944808830564;6782;6828.078209441662;7087.681054352463;7460.440466965108;8316.584170791315;9885.406875587487;10139.695809125738;10677.51951162184;10738.194635402533 21:33:05 INFO - PROCESS | 6118 | |3;mootools.html;1324.4371142264538;1334.3528388731468;1416.6741649420633;1624.3664970661437;1629.1202750514722;7110.146782386115;7540.509866858657;7548.886766698497;7555.244475552442;7559.924400755991;6425.100485931974;6661.067450556926;6665.2668206497365;6766.627835469048;7479.10250769907;1911.598564301495;2045.9079341429597;2111.947201319964;2117.597656445278;2132.8507004509693;2139.8181154601875;2141.732283464567;2145.7210562626838;2147.1196809308185;2147.850899768624;2065.772764995857;2150.849440539163;2153.76308606054;2156.611809874222;2157.9568408631817;2073.0774805211686;2098.3495116513927;2101.894905254731;2106.24175296893;2129.276046144311;2103.4110449074283;2106.9367918962303;2122.182959560565;2125.426134943572;2126.4683829042738;7528.849423011564;7547.32074113327;7620.885686714703;7621.733239336652;7630.427717921179;4486.461624605068;4648.86053418398;4654.232051711463;4659.091477161955;4659.953400465985;2931.809432386888;2956.704329567048;3011.9548206776917;3021.4108248891475;3059.7552195824283;872.3718922375879;888.5246393179682;895.4135041547731;902.0303174087882;921.5760750054916;10145.543450544743;10233.079022887901;10266.384016959006;10271.28101032928;10278.17774578032;4080.6123418275215;4131.400946862688;4242.490901091889;4258.190943720683;4287.3140297552245;8525.934258217723;8530.65877364911;8535;8540.829183416297;8542.273906717874;4610.377599024089;4684.461286952044;4687.437507499054;4691.390119284471;4692.671512994058;4130.91738165235;4251.426057482262;4287.421198138274;4291.6566674665955;4322.654187664979;3193.8722451101694;3337.18239031434;3375.5611770470173;3425.486177073409;3540.4689296605716;1142.1833389126814;1160.0835340081242;1168.5033860609376;1180.167981572989;1187.1511869013696;584.4652143288843;706.8303607134251;722.2380388689877;729.1541811498636;731.5720303622334;4898.804047838118;4992.151334273182;5006.168172231269;5081.212412076134;5114.693118412907;752.3755283115001;760.3081196111511;796.3589310605018;810.2181394953898;848.2620120495085;3255.3560451971603;3314.734821214297;3346.4143774839304;3400.7279417646528;3485.773424727435;8629.093945135795;8807.515586642668;8892.555372231363;8893.555322233862;8910.331725120643;8831.161039701346;8836.823263534694;8848.734537963872;8854.24738897188;8866.73399798007;6615.503837212132;6976.127984002;7121.572705637678;7140.964295178491;7158.2841715829045;4940.975295123501;5173.741312934263;5269.631125821155;5309.070912590359;5358.276632654542;8025.8796118059445;8118.797030074059;8119.75640730779;8151.918480815353;8169.959150204211;8231.711890083818;8254.0507841599;8284.420090593601;8318.417710760188;8350.665973360998;6490.675466226576;6686.632235227109;6687.164104486939;6690.19717633887;6701;6381.521385896169;6461.709223084878;6560.343965603402;6630.071789949508;7043.190033146254;6354.459870911024;6511.902321465276;6532.5753826001155;6552.770653027121;6564.5076619254705;6328.968355158195;6341.334159913327;6407;6408.391202835724;6514.609123452608;5860.267466566679;5991.400859913973;5994.490468310068;5994.6403215807195;6005.159277701038;4508.571685689854;4522;4546.545345465427;4572.497025327278;4620.075984802986;4309.612134907873;4529.19787796293;4537.387452693844;4636.744979026051;4714.834980775657 21:33:05 INFO - PROCESS | 6118 | |4;prototype.html;348.6739898195188;351.7678332300682;352.06877808197316;358.9874354397597;363.88650728769966;4713.740744259065;4716.811327546894;4724;4734.715917044975;4747.074320507502;4647.512011238822;4683.9531604684025;4690.179218636734;4712.5758681718635;4729.905401891969;3600.945985810215;3703.8333275002688;3722;3736.8692095776655;3747.550293964728;3773.867689817445;3778.5843557208686;3785.734998550103;3786.2616789726017;3788.9621103789023;3715.758475699071;3743.270062337845;3743.7753734775865;3754.680852127559;3773.283076215524;3582.802945837978;3674.6141655126094;3682.839905429781;3756.417755247941;3758.8535496673503;3405.7956522608724;3408.9488657670154;3410.6930376266255;3412.1128506588216;3413.197898493852;4569.885752856172;4577.3362862384765;4596.287575425815;4598.2642777155825;4608.364030769062;3980.223856348013;4257.318828987378;4295.269804133273;4314.978425107885;4320.222359975203;4826.879328016793;4829.782659780319;4853.150698627726;4859.379762077275;4895.5838753705975;3472.131967008248;3477.8261086945804;3477.982610086933;3495.790252584853;3496.465062829454;5081.466446023188;5119.003588600449;5126.308687938825;5138.229265610151;5154.252633368141;3466.0814884055744;3528.259065596202;3537.876174333886;3559.8786382289495;3564.322778672044;3597.2265962817596;3602.603713591503;3628.9294658075933;3630.528031355907;3631.5460567429072;4044.51465824103;4086.1214838809206;4088.5281298732434;4120.96975756061;4139.77231252278;4642.234031384851;4873.951260487421;4882.414110306786;4891.095147397743;4902.558769710672;1220.920640158387;1233.7902556565405;1238.411754416645;1241.3855141704732;1245.6636708088765;827.1439060572279;844.6832437835811;852.9701460448855;861.345377513082;863.8574635185124;4226.197022565702;4247.277962746341;4352.717073390219;4404.339349097661;4417.271150260235;5067.923981140286;5081.898362032813;5084.339035925306;5099.260607211933;5105.438401775802;4411.889702757457;4420.182266280748;4427.26950053244;4434.17967675981;4439.334099885043;2544.262163972427;2604.869756512167;2624.834511527997;2630.763231309153;2642.9074982375523;4616.28447590624;4617.607503362185;4653.185692503798;4662.945770520315;4687.39063921688;5051.494850514992;5059.72171530562;5059.924101138486;5062;5069.44236134025;4509.210888094636;4641.67508274431;4668.4631267404;4687;4697.4832768395445;4887.535684110004;4889.19328310839;4932.4081110267;4949.604031677529;4960.280759289955;4832.565069143794;4848.175810112219;4854.271859221145;4868.537488938545;4876.463589005278;4418.182636212311;4558.404558404532;4600;4605.217113090715;4633.258678611406;3447.6552344765323;3450.413429716904;3474.5483087198504;3476.3834816809294;3481.3037392522106;4940.4547816008635;4951.554360107608;4953.975230123826;4957.305977163128;4979.278004689372;4652.720836749806;4814.855554333376;4823.758812059313;4919.130730322455;4976.2286845539;4960.826371076995;4968.3044373788425;4990.575801056951;5002.899942001212;5004.799808007639;4878.609711223165;4879.609631229564;4884.389451318585;4902.460729319843;4911.656184067081;4881.365422495053;4966.627502937222;5001.899962000667;5009.674371166008;5026.220935754964;4896.192128298933;4907.3620429343955;4907.386576677915;4907.852764417074;4908.214685650279 21:33:05 INFO - PROCESS | 6118 | |5;yui.html;635.231370042249;642.9614223146615;652.7225928980182;729.1869565434539;752.6161657554645;12954.74090518189;14238.715225695505;14259;14282.57152285433;14297.642558936031;13182.604521864336;13237.801432978513;13240.668983275398;13360.665983350422;13360.799588006188;601.6269912654161;636.7675798333598;742.2243755275723;759.1611269547153;774.1871035412822;760.3005235183645;775.6005657086605;775.8913752074714;776.3556248313886;776.4952780692538;829.85062688716;831.4803247970019;831.6465502161587;831.7421599304236;832.0182185021672;630.760311081786;672.3814091036259;818.1572979830754;819.1071731812293;819.7212947597816;574.2964868036663;606.5996442348073;610.4749915073033;611.2542697908544;611.4191518057819;13698;13784.862151378458;13788.586342409744;13793.10344827583;13804.654883627989;12589.937050314782;12671.683207919783;12837.422315995802;12977.416016279196;13118;11246.3814490203;11424.714382140513;11522.654320370402;11812.704682382922;11893.286402815773;4003.2794097062515;4006.2988976929214;4011.338129208677;4065.532463766675;4197.748135111903;61007.69496152491;63666.68166659183;63859;64300.03549946802;66117;9983;10189.796204075878;10222.488875556193;10363.585456581652;10772.08437282824;19048.42854714361;19080.8091919079;19082.236710531703;19093.713594296096;19108.808911910703;6713.0937323461685;6898.758543450955;6974.546654467444;6975.4070903972715;7046;3616.5840928293055;3658.2317713279976;3791.848326066982;3876.379779235309;3894.3963685628773;2729.208529526415;2789.0377819652185;2805.6773471050683;2808.2698498390564;2817;496.3026947139275;503.2803091579077;506.4757975495418;507.1505228741843;511.11832089645065;534.668505526576;562.7889541421966;563.8618538458022;588.147186579453;603.4448307557058;8013.805587881325;8147.877781833277;8179.182081791892;8216.34269258458;8544.61549230286;590.6692252338704;597.2403718591477;611.1901730207493;615.6359579215833;665.4643012374988;3989.3617021276455;4080.8571699990357;4254.85108021224;4294.935575966363;4349.151915376471;59689.40310596925;59873.40126598678;60181.39818601846;61790.382096178466;62300.688496558134;40559.58041468535;48055.519444805104;51230.74384628053;52370;53387.733061334446;47996.280055799194;48158.27762583564;49168;49230.75384623054;50053.9967601945;8117.634706438343;8438.240558349778;8504.957475212585;8512.829743405222;8691.391602587759;34777;35102;35331.11672208215;36037;36172.81913590415;43043.13913721771;45175.32237016382;46203.3069503951;48352;48492.75753621209;9926.354786938826;10048.246381521269;10117.544710488193;10191.898081019095;10673.839892401775;10964.945175274073;11190.66428007161;11658.6502404928;11982.820257695967;12005.279683219034;10685.893141068489;11140.944295278472;11189.216754827085;11318.773624527628;11757;10779;10922.781544369227;11254.774904502028;11328.603498877499;11403.429828508708;10596.47017649099;10656.62701805433;10787.298825576627;11283.097352211968;11353.432328383713;8722.869156962777;8762.824743505222;9001.54992250398;9196.908030919605;9329.440233586007;8709.303255739653;8993.460392376217;9381.953090234505;9644.083812037845;9684.966157106805 21:33:05 INFO - PROCESS | 6118 | __end_tp_report 21:33:05 INFO - PROCESS | 6118 | __start_cc_report 21:33:05 INFO - PROCESS | 6118 | _x_x_mozilla_cycle_collect,2555 21:33:05 INFO - PROCESS | 6118 | __end_cc_report 21:33:05 INFO - PROCESS | 6118 | __startTimestamp1482125585083__endTimestamp 21:33:05 INFO - PROCESS | 6118 | 21:33:05 INFO - PROCESS | 6118 | ------- Summary: start ------- 21:33:05 INFO - PROCESS | 6118 | Number of tests: 6 21:33:05 INFO - PROCESS | 6118 | 21:33:05 INFO - PROCESS | 6118 | [#0] dojo.html Cycles:165 Average:4643.66 Median:4781.07 stddev:484.85 (10.1%) stddev-sans-first:458.91 21:33:05 INFO - PROCESS | 6118 | Values: 2594.4 2620.6 2634.5 2650.6 2661.0 4585.7 4594.8 4706.4 4719.7 4740.1 4683.0 4688.9 4698.1 4706.0 4717.4 4305.1 4327.0 4328.0 4334.5 4367.1 4327.2 4334.0 4335.4 4353.0 4363.3 4288.4 4308.8 4316.0 4336.7 4349.5 4392.8 4396.2 4396.5 4411.2 4431.6 4216.5 4241.9 4275.1 4312.4 4319.1 4669.2 4698.3 4698.4 4706.4 4767.3 4987.7 4988.3 5021.8 5031.9 5059.5 4908.4 4942.5 4944.5 5051.9 5113.9 4693.2 4706.3 4731.6 4733.9 4781.1 5199.7 5206.7 5208.0 5211.4 5262.0 4746.5 4950.0 4963.2 4963.7 4966.7 4868.9 4935.3 4994.2 5029.5 5045.9 4968.6 4977.0 4984.4 5013.8 5023.1 4955.4 4965.4 4966.7 4968.5 5015.7 4051.6 4079.3 4115.7 4177.3 4180.8 3697.5 3701.0 3726.7 3729.0 3744.9 4367.1 4384.2 4393.5 4396.1 4436.0 4889.9 4921.2 5104.5 5119.5 5163.1 4315.1 4354.3 4374.7 4381.8 4427.5 4518.6 4525.9 4533.3 4539.1 4583.3 4763.0 4773.5 4774.8 4775.3 4817.0 4865.5 4889.8 4896.0 5030.8 5073.0 4789.5 4791.9 4795.1 4828.0 4832.6 5009.2 5012.2 5012.7 5014.3 5064.6 4895.6 4933.9 5086.0 5093.1 5097.1 4856.5 4859.6 4861.9 4865.6 4865.8 4844.7 4847.6 4871.5 4872.1 4876.1 4769.0 4777.3 4786.4 4786.4 4786.5 4916.9 4920.9 4926.1 4927.1 4927.1 4752.0 4825.1 4842.6 4897.8 4898.8 21:33:05 INFO - PROCESS | 6118 | 21:33:05 INFO - PROCESS | 6118 | [#1] ext.html Cycles:180 Average:40936.00 Median:333945.95 stddev:70309.93 (21.1%) stddev-sans-first:70441.69 21:33:05 INFO - PROCESS | 6118 | Values: 522.6 556.9 559.8 569.4 585.3 27737.7 36960.6 38432.4 38451.2 41877.6 39955.4 40364.8 40428.0 40440.4 40448.6 7305.3 7483.2 7666.5 7669.3 7672.7 7490.4 9567.6 9827.3 9831.1 10150.4 9904.7 9958.2 9967.2 9970.3 9974.4 9664.8 9714.0 9717.5 9723.8 9730.8 9734.3 9773.8 9800.5 9803.7 9808.3 37120.0 37298.0 37346.6 37424.6 37448.0 2920.9 3069.5 3112.4 3247.4 3323.5 27457.6 27723.0 27821.9 28344.1 28687.1 3413.6 3429.4 3464.4 3521.5 3523.9 166449.0 167290.0 167360.0 167546.0 167613.0 50911.5 51382.7 51389.0 51425.0 51455.0 53556.5 53790.2 53866.5 54029.0 54037.0 13330.7 13471.9 13497.7 13500.9 13517.9 8832.0 9023.5 10250.0 10486.8 10544.8 16102.8 16451.4 16802.1 16871.0 16890.1 6441.0 6441.7 6534.5 6731.4 6795.5 766.3 848.0 882.2 1010.0 1015.4 24396.1 27880.0 28420.6 28623.9 28665.6 884.1 901.2 910.8 933.6 942.9 12966.9 13353.9 13485.0 13541.1 13579.9 331378.0 332765.0 333087.0 333623.0 334268.9 42320.2 42539.8 42646.8 42672.4 42682.6 1044.0 1095.4 1143.7 1160.6 1195.9 23570.5 25475.2 25608.6 25634.9 25966.9 36099.6 36474.1 36540.3 36569.5 36605.3 274173.0 274998.0 275371.0 276437.0 277123.0 21964.8 22383.4 22395.3 22603.5 23712.9 35106.8 35394.5 35406.5 35442.3 35694.6 29876.9 30820.4 31439.7 31588.5 32447.5 30380.8 30675.7 31054.4 31077.1 32005.8 30418.5 30829.0 30865.5 31659.0 31779.8 26289.7 28031.3 28135.6 28309.7 28545.0 22463.2 22587.5 22749.9 22959.3 22992.5 21:33:05 INFO - PROCESS | 6118 | 21:33:05 INFO - PROCESS | 6118 | [#2] jquery.html Cycles:180 Average:21995.90 Median:45067.57 stddev:55356.34 (122.8%) stddev-sans-first:55487.75 21:33:05 INFO - PROCESS | 6118 | Values: 338.6 360.7 363.8 368.5 380.3 12454.3 13240.5 13827.4 16230.2 16232.6 14133.4 14468.7 15977.9 16003.7 16006.4 4915.2 5113.3 5115.5 5121.9 5128.4 3607.4 3819.1 5644.1 5870.8 5939.1 5843.2 6022.1 6022.8 6028.5 6029.6 5905.4 5942.6 5975.0 5988.0 5988.5 5052.8 5191.6 5244.8 5247.0 5248.8 18201.0 18890.6 20152.1 20269.6 20291.2 1656.4 1759.6 1820.8 1850.3 2383.0 8650.4 9138.4 9422.0 9613.4 9669.2 1610.8 1621.7 1631.4 1659.8 1704.2 43539.6 58827.7 60818.4 62405.7 66254.7 8806.4 8833.8 9468.4 9615.1 10092.6 13296.5 13362.3 13383.8 13399.9 13401.4 6908.9 6912.4 7051.4 7099.0 7106.8 6541.1 6542.6 6682.7 6684.7 6712.7 4147.6 4266.0 4292.8 4324.1 4389.3 1656.8 1772.7 1810.6 1835.8 1865.2 709.6 754.9 781.9 862.8 880.0 15822.8 16766.5 16900.7 16977.7 17129.8 783.1 784.4 785.4 841.6 915.8 8686.7 9595.7 9606.7 9648.0 9682.0 318234.0 318596.0 327042.0 349118.0 356734.3 75776.0 76195.6 76740.6 77044.6 78456.0 915.9 938.0 963.0 964.0 965.6 13990.8 14639.8 14859.3 15034.1 15621.8 35606.6 35609.8 36472.0 36731.0 37389.6 40575.8 41693.6 44920.4 45214.8 48183.5 7320.7 7552.0 7694.7 7715.5 7771.5 11202.2 11325.8 11868.3 11928.5 12147.8 9829.3 10104.0 10260.8 10328.0 10712.9 9729.3 9884.5 10055.2 10148.2 10520.4 7803.3 10138.3 10591.2 10640.1 10839.0 6594.9 6782.0 6828.1 7087.7 7460.4 8316.6 9885.4 10139.7 10677.5 10738.2 21:33:05 INFO - PROCESS | 6118 | 21:33:05 INFO - PROCESS | 6118 | [#3] mootools.html Cycles:180 Average:4895.56 Median:5144.22 stddev:2661.64 (51.7%) stddev-sans-first:2655.57 21:33:05 INFO - PROCESS | 6118 | Values: 1324.4 1334.4 1416.7 1624.4 1629.1 7110.1 7540.5 7548.9 7555.2 7559.9 6425.1 6661.1 6665.3 6766.6 7479.1 1911.6 2045.9 2111.9 2117.6 2132.9 2139.8 2141.7 2145.7 2147.1 2147.9 2065.8 2150.8 2153.8 2156.6 2158.0 2073.1 2098.3 2101.9 2106.2 2129.3 2103.4 2106.9 2122.2 2125.4 2126.5 7528.8 7547.3 7620.9 7621.7 7630.4 4486.5 4648.9 4654.2 4659.1 4660.0 2931.8 2956.7 3012.0 3021.4 3059.8 872.4 888.5 895.4 902.0 921.6 10145.5 10233.1 10266.4 10271.3 10278.2 4080.6 4131.4 4242.5 4258.2 4287.3 8525.9 8530.7 8535.0 8540.8 8542.3 4610.4 4684.5 4687.4 4691.4 4692.7 4130.9 4251.4 4287.4 4291.7 4322.7 3193.9 3337.2 3375.6 3425.5 3540.5 1142.2 1160.1 1168.5 1180.2 1187.2 584.5 706.8 722.2 729.2 731.6 4898.8 4992.2 5006.2 5081.2 5114.7 752.4 760.3 796.4 810.2 848.3 3255.4 3314.7 3346.4 3400.7 3485.8 8629.1 8807.5 8892.6 8893.6 8910.3 8831.2 8836.8 8848.7 8854.2 8866.7 6615.5 6976.1 7121.6 7141.0 7158.3 4941.0 5173.7 5269.6 5309.1 5358.3 8025.9 8118.8 8119.8 8151.9 8170.0 8231.7 8254.1 8284.4 8318.4 8350.7 6490.7 6686.6 6687.2 6690.2 6701.0 6381.5 6461.7 6560.3 6630.1 7043.2 6354.5 6511.9 6532.6 6552.8 6564.5 6329.0 6341.3 6407.0 6408.4 6514.6 5860.3 5991.4 5994.5 5994.6 6005.2 4508.6 4522.0 4546.5 4572.5 4620.1 4309.6 4529.2 4537.4 4636.7 4714.8 21:33:05 INFO - PROCESS | 6118 | 21:33:05 INFO - PROCESS | 6118 | [#4] prototype.html Cycles:180 Average:4075.73 Median:4616.95 stddev:1167.67 (25.3%) stddev-sans-first:1136.95 21:33:05 INFO - PROCESS | 6118 | Values: 348.7 351.8 352.1 359.0 363.9 4713.7 4716.8 4724.0 4734.7 4747.1 4647.5 4684.0 4690.2 4712.6 4729.9 3600.9 3703.8 3722.0 3736.9 3747.6 3773.9 3778.6 3785.7 3786.3 3789.0 3715.8 3743.3 3743.8 3754.7 3773.3 3582.8 3674.6 3682.8 3756.4 3758.9 3405.8 3408.9 3410.7 3412.1 3413.2 4569.9 4577.3 4596.3 4598.3 4608.4 3980.2 4257.3 4295.3 4315.0 4320.2 4826.9 4829.8 4853.2 4859.4 4895.6 3472.1 3477.8 3478.0 3495.8 3496.5 5081.5 5119.0 5126.3 5138.2 5154.3 3466.1 3528.3 3537.9 3559.9 3564.3 3597.2 3602.6 3628.9 3630.5 3631.5 4044.5 4086.1 4088.5 4121.0 4139.8 4642.2 4874.0 4882.4 4891.1 4902.6 1220.9 1233.8 1238.4 1241.4 1245.7 827.1 844.7 853.0 861.3 863.9 4226.2 4247.3 4352.7 4404.3 4417.3 5067.9 5081.9 5084.3 5099.3 5105.4 4411.9 4420.2 4427.3 4434.2 4439.3 2544.3 2604.9 2624.8 2630.8 2642.9 4616.3 4617.6 4653.2 4662.9 4687.4 5051.5 5059.7 5059.9 5062.0 5069.4 4509.2 4641.7 4668.5 4687.0 4697.5 4887.5 4889.2 4932.4 4949.6 4960.3 4832.6 4848.2 4854.3 4868.5 4876.5 4418.2 4558.4 4600.0 4605.2 4633.3 3447.7 3450.4 3474.5 3476.4 3481.3 4940.5 4951.6 4954.0 4957.3 4979.3 4652.7 4814.9 4823.8 4919.1 4976.2 4960.8 4968.3 4990.6 5002.9 5004.8 4878.6 4879.6 4884.4 4902.5 4911.7 4881.4 4966.6 5001.9 5009.7 5026.2 4896.2 4907.4 4907.4 4907.9 4908.2 21:33:05 INFO - PROCESS | 6118 | 21:33:05 INFO - PROCESS | 6118 | [#5] yui.html Cycles:180 Average:14360.25 Median:48422.38 stddev:17470.74 (36.1%) stddev-sans-first:17489.35 21:33:05 INFO - PROCESS | 6118 | Values: 635.2 643.0 652.7 729.2 752.6 12954.7 14238.7 14259.0 14282.6 14297.6 13182.6 13237.8 13240.7 13360.7 13360.8 601.6 636.8 742.2 759.2 774.2 760.3 775.6 775.9 776.4 776.5 829.9 831.5 831.6 831.7 832.0 630.8 672.4 818.2 819.1 819.7 574.3 606.6 610.5 611.3 611.4 13698.0 13784.9 13788.6 13793.1 13804.7 12589.9 12671.7 12837.4 12977.4 13118.0 11246.4 11424.7 11522.7 11812.7 11893.3 4003.3 4006.3 4011.3 4065.5 4197.7 61007.7 63666.7 63859.0 64300.0 66117.0 9983.0 10189.8 10222.5 10363.6 10772.1 19048.4 19080.8 19082.2 19093.7 19108.8 6713.1 6898.8 6974.5 6975.4 7046.0 3616.6 3658.2 3791.8 3876.4 3894.4 2729.2 2789.0 2805.7 2808.3 2817.0 496.3 503.3 506.5 507.2 511.1 534.7 562.8 563.9 588.1 603.4 8013.8 8147.9 8179.2 8216.3 8544.6 590.7 597.2 611.2 615.6 665.5 3989.4 4080.9 4254.9 4294.9 4349.2 59689.4 59873.4 60181.4 61790.4 62300.7 40559.6 48055.5 51230.7 52370.0 53387.7 47996.3 48158.3 49168.0 49230.8 50054.0 8117.6 8438.2 8505.0 8512.8 8691.4 34777.0 35102.0 35331.1 36037.0 36172.8 43043.1 45175.3 46203.3 48352.0 48492.8 9926.4 10048.2 10117.5 10191.9 10673.8 10964.9 11190.7 11658.7 11982.8 12005.3 10685.9 11140.9 11189.2 11318.8 11757.0 10779.0 10922.8 11254.8 11328.6 11403.4 10596.5 10656.6 10787.3 11283.1 11353.4 8722.9 8762.8 9001.5 9196.9 9329.4 8709.3 8993.5 9382.0 9644.1 9685.0 21:33:05 INFO - PROCESS | 6118 | -------- Summary: end -------- 21:33:05 INFO - PROCESS | 6118 | 21:33:05 INFO - TEST-INFO | 6118: exit 0 21:33:05 INFO - TEST-OK | dromaeo_css | took 1121837ms 21:33:05 INFO - TEST-START | kraken 21:33:05 INFO - operating with platform_type : linux_ 21:33:05 INFO - Initialising browser for kraken test... 21:33:05 INFO - TEST-INFO | started process 6422 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzRFUYK/profile http://localhost:39319/getInfo.html) 21:33:09 INFO - PROCESS | 6422 | __metrics Screen width/height:1600/1200 21:33:09 INFO - PROCESS | 6422 | colorDepth:24 21:33:09 INFO - PROCESS | 6422 | Browser inner width/height: 1024/697 21:33:09 INFO - PROCESS | 6422 | __metrics 21:33:10 INFO - PROCESS | 6422 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:33:10 INFO - PROCESS | 6422 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:33:11 INFO - TEST-INFO | 6422: exit 0 21:33:11 INFO - Browser initialized. 21:33:11 INFO - Running cycle 1/1 for kraken test... 21:33:11 INFO - TEST-INFO | started process 6504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzRFUYK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:33:23 INFO - PROCESS | 6504 | RSS: Main: 155807744 21:33:23 INFO - PROCESS | 6504 | 21:33:26 INFO - PROCESS | 6504 | Cycle 1(1): loaded http://localhost:39319/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39319/tests/kraken/driver.html?testName=audio-beat-detection) 21:33:27 INFO - PROCESS | 6504 | RSS: Main: 209661952 21:33:27 INFO - PROCESS | 6504 | 21:33:29 INFO - PROCESS | 6504 | Cycle 1(1): loaded http://localhost:39319/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39319/tests/kraken/driver.html?testName=audio-dft) 21:33:30 INFO - PROCESS | 6504 | RSS: Main: 188203008 21:33:30 INFO - PROCESS | 6504 | 21:33:33 INFO - PROCESS | 6504 | Cycle 1(1): loaded http://localhost:39319/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39319/tests/kraken/driver.html?testName=audio-fft) 21:33:34 INFO - PROCESS | 6504 | RSS: Main: 269230080 21:33:34 INFO - PROCESS | 6504 | 21:33:36 INFO - PROCESS | 6504 | Cycle 1(1): loaded http://localhost:39319/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39319/tests/kraken/driver.html?testName=audio-oscillator) 21:33:36 INFO - PROCESS | 6504 | RSS: Main: 181305344 21:33:36 INFO - PROCESS | 6504 | 21:33:39 INFO - PROCESS | 6504 | Cycle 1(1): loaded http://localhost:39319/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39319/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:33:39 INFO - PROCESS | 6504 | RSS: Main: 184279040 21:33:39 INFO - PROCESS | 6504 | 21:33:42 INFO - PROCESS | 6504 | Cycle 1(1): loaded http://localhost:39319/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39319/tests/kraken/driver.html?testName=imaging-darkroom) 21:33:43 INFO - PROCESS | 6504 | RSS: Main: 223371264 21:33:43 INFO - PROCESS | 6504 | 21:33:46 INFO - PROCESS | 6504 | Cycle 1(1): loaded http://localhost:39319/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39319/tests/kraken/driver.html?testName=imaging-desaturate) 21:33:47 INFO - PROCESS | 6504 | RSS: Main: 223694848 21:33:47 INFO - PROCESS | 6504 | 21:33:50 INFO - PROCESS | 6504 | Cycle 1(1): loaded http://localhost:39319/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39319/tests/kraken/driver.html?testName=json-parse-financial) 21:33:51 INFO - PROCESS | 6504 | RSS: Main: 222265344 21:33:51 INFO - PROCESS | 6504 | 21:33:52 INFO - PROCESS | 6504 | Cycle 1(1): loaded http://localhost:39319/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39319/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:33:53 INFO - PROCESS | 6504 | RSS: Main: 184037376 21:33:53 INFO - PROCESS | 6504 | 21:33:55 INFO - PROCESS | 6504 | Cycle 1(1): loaded http://localhost:39319/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39319/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:33:55 INFO - PROCESS | 6504 | RSS: Main: 191938560 21:33:55 INFO - PROCESS | 6504 | 21:33:58 INFO - PROCESS | 6504 | Cycle 1(1): loaded http://localhost:39319/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39319/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:33:58 INFO - PROCESS | 6504 | RSS: Main: 199876608 21:33:58 INFO - PROCESS | 6504 | 21:34:01 INFO - PROCESS | 6504 | Cycle 1(1): loaded http://localhost:39319/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39319/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:34:02 INFO - PROCESS | 6504 | RSS: Main: 209178624 21:34:02 INFO - PROCESS | 6504 | 21:34:05 INFO - PROCESS | 6504 | Cycle 1(1): loaded http://localhost:39319/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39319/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:34:06 INFO - PROCESS | 6504 | RSS: Main: 206163968 21:34:06 INFO - PROCESS | 6504 | 21:34:07 INFO - PROCESS | 6504 | Cycle 1(1): loaded http://localhost:39319/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39319/tests/kraken/driver.html?testName=ai-astar) 21:34:08 INFO - PROCESS | 6504 | RSS: Main: 256159744 21:34:08 INFO - PROCESS | 6504 | 21:34:08 INFO - PROCESS | 6504 | __start_tp_report 21:34:08 INFO - PROCESS | 6504 | _x_x_mozilla_page_load 21:34:08 INFO - PROCESS | 6504 | _x_x_mozilla_page_load_details 21:34:08 INFO - PROCESS | 6504 | |i|pagename|runs| 21:34:08 INFO - PROCESS | 6504 | |0;ai-astar;108;115;117;115;115;114;114;117;115;114 21:34:08 INFO - PROCESS | 6504 | |1;audio-beat-detection;151;126;126;161;127;126;130;127;146;123 21:34:08 INFO - PROCESS | 6504 | |2;audio-dft;161;163;161;162;164;163;160;161;161;160 21:34:08 INFO - PROCESS | 6504 | |3;audio-fft;77;77;75;115;80;76;77;76;91;76 21:34:08 INFO - PROCESS | 6504 | |4;audio-oscillator;85;86;121;84;85;86;104;85;86;108 21:34:08 INFO - PROCESS | 6504 | |5;imaging-gaussian-blur;128;128;127;128;127;127;128;126;126;127 21:34:08 INFO - PROCESS | 6504 | |6;imaging-darkroom;147;149;147;148;148;147;147;147;148;148 21:34:08 INFO - PROCESS | 6504 | |7;imaging-desaturate;96;97;96;95;96;96;96;97;95;96 21:34:08 INFO - PROCESS | 6504 | |8;json-parse-financial;64;65;64;64;67;66;65;65;65;65 21:34:08 INFO - PROCESS | 6504 | |9;json-stringify-tinderbox;65;66;66;66;66;66;67;67;67;66 21:34:08 INFO - PROCESS | 6504 | |10;stanford-crypto-aes;85;89;94;91;84;85;84;87;83;84 21:34:08 INFO - PROCESS | 6504 | |11;stanford-crypto-ccm;137;140;135;136;138;139;134;133;176;160 21:34:08 INFO - PROCESS | 6504 | |12;stanford-crypto-pbkdf2;181;187;180;179;178;181;180;179;178;181 21:34:08 INFO - PROCESS | 6504 | |13;stanford-crypto-sha256-iterative;70;68;69;69;74;68;71;69;67;68 21:34:08 INFO - PROCESS | 6504 | __end_tp_report 21:34:08 INFO - PROCESS | 6504 | __start_cc_report 21:34:08 INFO - PROCESS | 6504 | _x_x_mozilla_cycle_collect,1970 21:34:08 INFO - PROCESS | 6504 | __end_cc_report 21:34:08 INFO - PROCESS | 6504 | __startTimestamp1482125648056__endTimestamp 21:34:08 INFO - PROCESS | 6504 | 21:34:08 INFO - PROCESS | 6504 | ------- Summary: start ------- 21:34:08 INFO - PROCESS | 6504 | Number of tests: 14 21:34:08 INFO - PROCESS | 6504 | 21:34:08 INFO - PROCESS | 6504 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:2.50 (2.2%) stddev-sans-first:1.17 21:34:08 INFO - PROCESS | 6504 | Values: 108.0 115.0 117.0 115.0 115.0 114.0 114.0 117.0 115.0 114.0 21:34:08 INFO - PROCESS | 6504 | 21:34:08 INFO - PROCESS | 6504 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:128.50 stddev:13.28 (10.3%) stddev-sans-first:12.64 21:34:08 INFO - PROCESS | 6504 | Values: 151.0 126.0 126.0 161.0 127.0 126.0 130.0 127.0 146.0 123.0 21:34:08 INFO - PROCESS | 6504 | 21:34:08 INFO - PROCESS | 6504 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.35 (0.8%) stddev-sans-first:1.41 21:34:08 INFO - PROCESS | 6504 | Values: 161.0 163.0 161.0 162.0 164.0 163.0 160.0 161.0 161.0 160.0 21:34:08 INFO - PROCESS | 6504 | 21:34:08 INFO - PROCESS | 6504 | [#3] audio-fft Cycles:10 Average:82.00 Median:77.00 stddev:12.50 (16.2%) stddev-sans-first:13.13 21:34:08 INFO - PROCESS | 6504 | Values: 77.0 77.0 75.0 115.0 80.0 76.0 77.0 76.0 91.0 76.0 21:34:08 INFO - PROCESS | 6504 | 21:34:08 INFO - PROCESS | 6504 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:85.00 stddev:13.12 (15.4%) stddev-sans-first:13.60 21:34:08 INFO - PROCESS | 6504 | Values: 85.0 86.0 121.0 84.0 85.0 86.0 104.0 85.0 86.0 108.0 21:34:08 INFO - PROCESS | 6504 | 21:34:08 INFO - PROCESS | 6504 | [#5] imaging-gaussian-blur Cycles:10 Average:127.20 Median:127.50 stddev:0.79 (0.6%) stddev-sans-first:0.78 21:34:08 INFO - PROCESS | 6504 | Values: 128.0 128.0 127.0 128.0 127.0 127.0 128.0 126.0 126.0 127.0 21:34:08 INFO - PROCESS | 6504 | 21:34:08 INFO - PROCESS | 6504 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 21:34:08 INFO - PROCESS | 6504 | Values: 147.0 149.0 147.0 148.0 148.0 147.0 147.0 147.0 148.0 148.0 21:34:08 INFO - PROCESS | 6504 | 21:34:08 INFO - PROCESS | 6504 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 21:34:08 INFO - PROCESS | 6504 | Values: 96.0 97.0 96.0 95.0 96.0 96.0 96.0 97.0 95.0 96.0 21:34:08 INFO - PROCESS | 6504 | 21:34:08 INFO - PROCESS | 6504 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:0.94 (1.5%) stddev-sans-first:0.93 21:34:08 INFO - PROCESS | 6504 | Values: 64.0 65.0 64.0 64.0 67.0 66.0 65.0 65.0 65.0 65.0 21:34:08 INFO - PROCESS | 6504 | 21:34:08 INFO - PROCESS | 6504 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 21:34:08 INFO - PROCESS | 6504 | Values: 65.0 66.0 66.0 66.0 66.0 66.0 67.0 67.0 67.0 66.0 21:34:08 INFO - PROCESS | 6504 | 21:34:08 INFO - PROCESS | 6504 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:86.00 stddev:3.63 (4.2%) stddev-sans-first:3.80 21:34:08 INFO - PROCESS | 6504 | Values: 85.0 89.0 94.0 91.0 84.0 85.0 84.0 87.0 83.0 84.0 21:34:08 INFO - PROCESS | 6504 | 21:34:08 INFO - PROCESS | 6504 | [#11] stanford-crypto-ccm Cycles:10 Average:142.80 Median:138.50 stddev:13.97 (10.1%) stddev-sans-first:14.66 21:34:08 INFO - PROCESS | 6504 | Values: 137.0 140.0 135.0 136.0 138.0 139.0 134.0 133.0 176.0 160.0 21:34:08 INFO - PROCESS | 6504 | 21:34:08 INFO - PROCESS | 6504 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.40 Median:180.50 stddev:2.59 (1.4%) stddev-sans-first:2.74 21:34:08 INFO - PROCESS | 6504 | Values: 181.0 187.0 180.0 179.0 178.0 181.0 180.0 179.0 178.0 181.0 21:34:08 INFO - PROCESS | 6504 | 21:34:08 INFO - PROCESS | 6504 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:2.00 (2.9%) stddev-sans-first:2.11 21:34:08 INFO - PROCESS | 6504 | Values: 70.0 68.0 69.0 69.0 74.0 68.0 71.0 69.0 67.0 68.0 21:34:08 INFO - PROCESS | 6504 | -------- Summary: end -------- 21:34:08 INFO - PROCESS | 6504 | 21:34:09 INFO - TEST-INFO | 6504: exit 0 21:34:09 INFO - TEST-OK | kraken | took 63309ms 21:34:09 INFO - SUITE-END | took 1185s 21:34:09 INFO - Completed test suite (00:19:45) 21:34:09 INFO - javascript benchmark 21:34:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2594.3643807267217, 2620.606908963654, 2634.4862751763403, 2650.628911952327, 2661.015424293012, 4585.724856508612, 4594.839180628679, 4706.4352277726675, 4719.669623126382, 4740.146773580754, 4683.0399768047555, 4688.9296660550035, 4698.060387922412, 4706.011737535122, 4717.410323709536, 4305.117450922569, 4327.0, 4327.978360108195, 4334.523202447744, 4367.1265746850595, 4327.156204540116, 4334.024844410014, 4335.414719012941, 4353.0, 4363.280058790312, 4288.421063156465, 4308.763018034007, 4316.0, 4336.739795612258, 4349.521552629209, 4392.802323895432, 4396.20868243716, 4396.472423309224, 4411.1618792429335, 4431.64546836254, 4216.451861258048, 4241.915161696779, 4275.0594869128745, 4312.417823593806, 4319.07139964909, 4669.159551280768, 4698.271767875985, 4698.412698412699, 4706.388169537938, 4767.261074533453, 4987.725675087869, 4988.251762235657, 5021.824236151717, 5031.874203144914, 5059.544640982329, 4908.361912951329, 4942.481039490874, 4944.53026962438, 5051.924221136685, 5113.948860511385, 4693.24908014716, 4706.270528068155, 4731.645126615517, 4733.9053218936115, 4781.067691800135, 5199.688018718889, 5206.661566998133, 5207.973960130175, 5211.374635043819, 5262.0, 4746.501617330199, 4950.0, 4963.230699241623, 4963.652544321935, 4966.6771659842, 4868.902621947541, 4935.284383764334, 4994.200927851526, 5029.497050294941, 5045.899082018339, 4968.577670898014, 4976.975115124401, 4984.352034235599, 5013.799448022039, 5023.146065168857, 4955.430125535538, 4965.404151501771, 4966.677165984272, 4968.503149685075, 5015.749212539358, 4051.554329023805, 4079.347304431277, 4115.71190016702, 4177.3316269396755, 4180.811863466151, 3697.5008373869723, 3700.9814950925074, 3726.6646001859963, 3729.0, 3744.8876533704033, 4367.061081867414, 4384.210842048398, 4393.51671316155, 4396.120775844844, 4436.0, 4889.853304400874, 4921.163402221559, 5104.489551044866, 5119.462456442095, 5163.07064728345, 4315.11540134278, 4354.346847972766, 4374.737515749065, 4381.78091095444, 4427.512973572904, 4518.638508919278, 4525.932111018337, 4533.274676051882, 4539.0921815637, 4583.289590113538, 4763.047390521979, 4773.474917758975, 4774.809007639656, 4775.33145359643, 4816.975915120543, 4865.537773911473, 4889.828855990023, 4896.045271172087, 5030.773615187252, 5073.0, 4789.544993225638, 4791.880202994953, 4795.112904112751, 4827.975860120677, 4832.565069143653, 5009.198528235464, 5012.223105418666, 5012.674176178537, 5014.323066386137, 5064.620153488429, 4895.6083513318135, 4933.9013219736125, 5085.957378737276, 5093.083245015784, 5097.133487307241, 4856.514348565115, 4859.586935110414, 4861.9027619448125, 4865.5864251539015, 4865.829695960766, 4844.685095468783, 4847.636427268039, 4871.5128487151005, 4872.074305882013, 4876.073546026244, 4769.0, 4777.283407488765, 4786.44955830084, 4786.44955830084, 4786.521347865186, 4916.926246106383, 4920.852374428773, 4926.137925862888, 4927.1131196384995, 4927.137750893651, 4752.0, 4825.059113472839, 4842.564169224786, 4897.8285759998225, 4898.804047838046], "value": 4612.7964819703675, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [522.5584381197888, 556.8747031917819, 559.829252078116, 569.4191924237275, 585.2654918077811, 27737.722622773766, 36960.63039369609, 38432.423513647285, 38451.23097538047, 41877.58122418775, 39955.40066898999, 40364.79817600908, 40428.0, 40440.39339409911, 40448.59551404485, 7305.342519173273, 7483.176850546449, 7666.540007599562, 7669.348105411047, 7672.693092276302, 7490.438217133709, 9567.569459374345, 9827.312088153833, 9831.115199632031, 10150.441725705083, 9904.702858914245, 9958.20334373252, 9967.152792012688, 9970.302078854484, 9974.401535907833, 9664.806703865954, 9714.0, 9717.46553939533, 9723.756906077333, 9730.805383892353, 9734.269929755226, 9773.804523909483, 9800.460974646392, 9803.705888823346, 9808.313418060667, 37120.0, 37298.0, 37346.62653373458, 37424.62575374239, 37448.0, 2920.8831646734106, 3069.493533566981, 3112.4086423579674, 3247.382997230542, 3323.4516304809677, 27457.588136177772, 27723.0, 27821.860890695418, 28344.14967550977, 28687.13938581846, 3413.607435144965, 3429.3827111120236, 3464.393731097073, 3521.5245941797784, 3523.859045638197, 166449.0, 167290.0, 167360.0, 167546.0, 167613.0, 50911.490885091414, 51382.743086285074, 51389.0, 51425.0, 51455.0, 53556.46443535593, 53790.19314710282, 53866.46133538614, 54029.0, 54037.0, 13330.666733331744, 13471.932640336736, 13497.662558436117, 13500.864991350158, 13517.864821351857, 8832.0, 9023.503707296162, 10250.0, 10486.790264194673, 10544.841827372595, 16102.838971610368, 16451.42420015318, 16802.075885826398, 16871.0, 16890.128678124503, 6440.967795160994, 6441.67791610427, 6534.542582019308, 6731.394174524316, 6795.456363490909, 766.2911806578892, 847.9745607631781, 882.2148288023664, 1009.9747506312401, 1015.3907655406697, 24396.146134885195, 27880.0, 28420.573691394646, 28623.85688071588, 28665.57001644977, 884.062893333069, 901.2294488212615, 910.8360495110944, 933.6218831373304, 942.8679984802134, 12966.870331296566, 13353.933230333787, 13485.0, 13541.1198272112, 13579.864201358057, 331378.0, 332765.0, 333087.0, 333623.0, 334268.901765316, 42320.15359692789, 42539.7873010633, 42646.786766066594, 42672.35991460131, 42682.57317426786, 1043.9634612788668, 1095.386583513251, 1143.7312231625729, 1160.5531870230022, 1195.8684544700077, 23570.528589427773, 25475.235742927744, 25608.61587076158, 25634.871825640752, 25966.870165649052, 36099.639003610675, 36474.088147796516, 36540.26919461649, 36569.45145822868, 36605.26789464142, 274173.0, 274998.0, 275371.0, 276437.0, 277123.0, 21964.780352196274, 22383.44041398913, 22395.32814015582, 22603.547929041655, 23712.881435592713, 35106.82446587751, 35394.522383432915, 35406.46890296699, 35442.29115417626, 35694.64305357017, 29876.850615746782, 30820.383592328475, 31439.68560314459, 31588.526172106976, 32447.513287300237, 30380.84809575938, 30675.693243067282, 31054.37891242208, 31077.067687969397, 32005.839970799996, 30418.543721843747, 30829.0, 30865.524498947976, 31659.0, 31779.841100794347, 26289.73710262873, 28031.299217519725, 28135.57796633093, 28309.716902831533, 28545.0, 22463.213787517358, 22587.48250349904, 22749.88625056864, 22959.311220663407, 22992.540149197255], "value": 16580.75154893496, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.55058650662465, 360.713232979781, 363.84060600337, 368.49700159282577, 380.3154322220003, 12454.252744835316, 13240.470381184754, 13827.377768000439, 16230.188490575454, 16232.594185145377, 14133.434662613508, 14468.710625787504, 15977.92011039946, 16003.679926401464, 16006.359745610162, 4915.238138088593, 5113.335266415361, 5115.53960143587, 5121.923171152435, 5128.384593848743, 3607.4228123500247, 3819.102510909934, 5644.125160600113, 5870.823875283727, 5939.1388248703915, 5843.18195452637, 6022.066579680157, 6022.819315420523, 6028.487578555828, 6029.577929544934, 5905.4094590541035, 5942.5840191186635, 5975.0, 5988.011978023621, 5988.520918326523, 5052.797888084472, 5191.5846732261325, 5244.842654720364, 5246.97376513115, 5248.8425347239645, 18201.0, 18890.62218755617, 20152.093155807877, 20269.594608107902, 20291.188352465884, 1656.4119737493138, 1759.5601099725068, 1820.7541981832549, 1850.3061351993003, 2382.9761702383103, 8650.394472386935, 9138.40600360981, 9421.952890235574, 9613.423194608276, 9669.17811985982, 1610.798650168729, 1621.7486289625008, 1631.4126914310839, 1659.7676325314465, 1704.207543492282, 43539.564604354186, 58827.705861470844, 60818.39181608171, 62405.687971560306, 66254.67490650257, 8806.427582207136, 8833.823323533494, 9468.431894086378, 9615.086566776145, 10092.646757363456, 13296.534621288209, 13362.265075420752, 13383.799243011363, 13399.866001340057, 13401.396937137852, 6908.9309106909295, 6912.412444942236, 7051.365377116084, 7098.964505177441, 7106.822329441805, 6541.149650545399, 6542.6401547914365, 6682.665866706645, 6684.732610695615, 6712.731490740316, 4147.6267135957905, 4266.0, 4292.785360731951, 4324.091940692427, 4389.31965545341, 1656.8343165683336, 1772.7075032619473, 1810.5926166612408, 1835.7980622131554, 1865.2352535460395, 709.5955305475829, 754.9352520855456, 781.9335356494648, 862.7713655881197, 879.9868001979976, 15822.76265856013, 16766.497005089866, 16900.661986760195, 16977.745333820003, 17129.82870171307, 783.134636226961, 784.3685832904566, 785.4344871692487, 841.5581819544788, 915.8214148241029, 8686.6525338987, 9595.664151754656, 9606.711798646053, 9647.951760241294, 9681.951590242004, 318234.0, 318596.0, 327042.0, 349118.0, 356734.32656734117, 75776.0, 76195.61902190564, 76740.61629691816, 77044.61477692575, 78456.0, 915.8809354783969, 937.9624815007323, 963.0465838819518, 963.9614415423305, 965.6282331302499, 13990.790138148139, 14639.780403293746, 14859.257037148316, 15034.097954122788, 15621.843781562038, 35606.64393356137, 35609.82195089008, 36472.0, 36731.0, 37389.626103738614, 40575.797121014206, 41693.58306416897, 44920.36353819793, 45214.77392613016, 48183.518164817906, 7320.743773967885, 7552.0, 7694.7303694889715, 7715.459917805924, 7771.4559980800805, 11202.15983801202, 11325.814573680342, 11868.287902725864, 11928.463219155332, 12147.75704485923, 9829.31194816356, 10104.0, 10260.846087308846, 10328.0, 10712.946435268086, 9729.270304727315, 9884.479363520637, 10055.245856560934, 10148.188144948239, 10520.432554356368, 7803.297703206738, 10138.341007834468, 10591.20565957541, 10640.148788097089, 10839.0, 6594.944808830564, 6782.0, 6828.078209441662, 7087.681054352463, 7460.440466965108, 8316.584170791315, 9885.406875587487, 10139.695809125738, 10677.51951162184, 10738.194635402533], "value": 7906.231034479682, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.4371142264538, 1334.3528388731468, 1416.6741649420633, 1624.3664970661437, 1629.1202750514722, 7110.146782386115, 7540.509866858657, 7548.886766698497, 7555.244475552442, 7559.924400755991, 6425.100485931974, 6661.067450556926, 6665.2668206497365, 6766.627835469048, 7479.10250769907, 1911.598564301495, 2045.9079341429597, 2111.947201319964, 2117.597656445278, 2132.8507004509693, 2139.8181154601875, 2141.732283464567, 2145.7210562626838, 2147.1196809308185, 2147.850899768624, 2065.772764995857, 2150.849440539163, 2153.76308606054, 2156.611809874222, 2157.9568408631817, 2073.0774805211686, 2098.3495116513927, 2101.894905254731, 2106.24175296893, 2129.276046144311, 2103.4110449074283, 2106.9367918962303, 2122.182959560565, 2125.426134943572, 2126.4683829042738, 7528.849423011564, 7547.32074113327, 7620.885686714703, 7621.733239336652, 7630.427717921179, 4486.461624605068, 4648.86053418398, 4654.232051711463, 4659.091477161955, 4659.953400465985, 2931.809432386888, 2956.704329567048, 3011.9548206776917, 3021.4108248891475, 3059.7552195824283, 872.3718922375879, 888.5246393179682, 895.4135041547731, 902.0303174087882, 921.5760750054916, 10145.543450544743, 10233.079022887901, 10266.384016959006, 10271.28101032928, 10278.17774578032, 4080.6123418275215, 4131.400946862688, 4242.490901091889, 4258.190943720683, 4287.3140297552245, 8525.934258217723, 8530.65877364911, 8535.0, 8540.829183416297, 8542.273906717874, 4610.377599024089, 4684.461286952044, 4687.437507499054, 4691.390119284471, 4692.671512994058, 4130.91738165235, 4251.426057482262, 4287.421198138274, 4291.6566674665955, 4322.654187664979, 3193.8722451101694, 3337.18239031434, 3375.5611770470173, 3425.486177073409, 3540.4689296605716, 1142.1833389126814, 1160.0835340081242, 1168.5033860609376, 1180.167981572989, 1187.1511869013696, 584.4652143288843, 706.8303607134251, 722.2380388689877, 729.1541811498636, 731.5720303622334, 4898.804047838118, 4992.151334273182, 5006.168172231269, 5081.212412076134, 5114.693118412907, 752.3755283115001, 760.3081196111511, 796.3589310605018, 810.2181394953898, 848.2620120495085, 3255.3560451971603, 3314.734821214297, 3346.4143774839304, 3400.7279417646528, 3485.773424727435, 8629.093945135795, 8807.515586642668, 8892.555372231363, 8893.555322233862, 8910.331725120643, 8831.161039701346, 8836.823263534694, 8848.734537963872, 8854.24738897188, 8866.73399798007, 6615.503837212132, 6976.127984002, 7121.572705637678, 7140.964295178491, 7158.2841715829045, 4940.975295123501, 5173.741312934263, 5269.631125821155, 5309.070912590359, 5358.276632654542, 8025.8796118059445, 8118.797030074059, 8119.75640730779, 8151.918480815353, 8169.959150204211, 8231.711890083818, 8254.0507841599, 8284.420090593601, 8318.417710760188, 8350.665973360998, 6490.675466226576, 6686.632235227109, 6687.164104486939, 6690.19717633887, 6701.0, 6381.521385896169, 6461.709223084878, 6560.343965603402, 6630.071789949508, 7043.190033146254, 6354.459870911024, 6511.902321465276, 6532.5753826001155, 6552.770653027121, 6564.5076619254705, 6328.968355158195, 6341.334159913327, 6407.0, 6408.391202835724, 6514.609123452608, 5860.267466566679, 5991.400859913973, 5994.490468310068, 5994.6403215807195, 6005.159277701038, 4508.571685689854, 4522.0, 4546.545345465427, 4572.497025327278, 4620.075984802986, 4309.612134907873, 4529.19787796293, 4537.387452693844, 4636.744979026051, 4714.834980775657], "value": 3964.6893058388605, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.6739898195188, 351.7678332300682, 352.06877808197316, 358.9874354397597, 363.88650728769966, 4713.740744259065, 4716.811327546894, 4724.0, 4734.715917044975, 4747.074320507502, 4647.512011238822, 4683.9531604684025, 4690.179218636734, 4712.5758681718635, 4729.905401891969, 3600.945985810215, 3703.8333275002688, 3722.0, 3736.8692095776655, 3747.550293964728, 3773.867689817445, 3778.5843557208686, 3785.734998550103, 3786.2616789726017, 3788.9621103789023, 3715.758475699071, 3743.270062337845, 3743.7753734775865, 3754.680852127559, 3773.283076215524, 3582.802945837978, 3674.6141655126094, 3682.839905429781, 3756.417755247941, 3758.8535496673503, 3405.7956522608724, 3408.9488657670154, 3410.6930376266255, 3412.1128506588216, 3413.197898493852, 4569.885752856172, 4577.3362862384765, 4596.287575425815, 4598.2642777155825, 4608.364030769062, 3980.223856348013, 4257.318828987378, 4295.269804133273, 4314.978425107885, 4320.222359975203, 4826.879328016793, 4829.782659780319, 4853.150698627726, 4859.379762077275, 4895.5838753705975, 3472.131967008248, 3477.8261086945804, 3477.982610086933, 3495.790252584853, 3496.465062829454, 5081.466446023188, 5119.003588600449, 5126.308687938825, 5138.229265610151, 5154.252633368141, 3466.0814884055744, 3528.259065596202, 3537.876174333886, 3559.8786382289495, 3564.322778672044, 3597.2265962817596, 3602.603713591503, 3628.9294658075933, 3630.528031355907, 3631.5460567429072, 4044.51465824103, 4086.1214838809206, 4088.5281298732434, 4120.96975756061, 4139.77231252278, 4642.234031384851, 4873.951260487421, 4882.414110306786, 4891.095147397743, 4902.558769710672, 1220.920640158387, 1233.7902556565405, 1238.411754416645, 1241.3855141704732, 1245.6636708088765, 827.1439060572279, 844.6832437835811, 852.9701460448855, 861.345377513082, 863.8574635185124, 4226.197022565702, 4247.277962746341, 4352.717073390219, 4404.339349097661, 4417.271150260235, 5067.923981140286, 5081.898362032813, 5084.339035925306, 5099.260607211933, 5105.438401775802, 4411.889702757457, 4420.182266280748, 4427.26950053244, 4434.17967675981, 4439.334099885043, 2544.262163972427, 2604.869756512167, 2624.834511527997, 2630.763231309153, 2642.9074982375523, 4616.28447590624, 4617.607503362185, 4653.185692503798, 4662.945770520315, 4687.39063921688, 5051.494850514992, 5059.72171530562, 5059.924101138486, 5062.0, 5069.44236134025, 4509.210888094636, 4641.67508274431, 4668.4631267404, 4687.0, 4697.4832768395445, 4887.535684110004, 4889.19328310839, 4932.4081110267, 4949.604031677529, 4960.280759289955, 4832.565069143794, 4848.175810112219, 4854.271859221145, 4868.537488938545, 4876.463589005278, 4418.182636212311, 4558.404558404532, 4600.0, 4605.217113090715, 4633.258678611406, 3447.6552344765323, 3450.413429716904, 3474.5483087198504, 3476.3834816809294, 3481.3037392522106, 4940.4547816008635, 4951.554360107608, 4953.975230123826, 4957.305977163128, 4979.278004689372, 4652.720836749806, 4814.855554333376, 4823.758812059313, 4919.130730322455, 4976.2286845539, 4960.826371076995, 4968.3044373788425, 4990.575801056951, 5002.899942001212, 5004.799808007639, 4878.609711223165, 4879.609631229564, 4884.389451318585, 4902.460729319843, 4911.656184067081, 4881.365422495053, 4966.627502937222, 5001.899962000667, 5009.674371166008, 5026.220935754964, 4896.192128298933, 4907.3620429343955, 4907.386576677915, 4907.852764417074, 4908.214685650279], "value": 3721.1510012691247, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [635.231370042249, 642.9614223146615, 652.7225928980182, 729.1869565434539, 752.6161657554645, 12954.74090518189, 14238.715225695505, 14259.0, 14282.57152285433, 14297.642558936031, 13182.604521864336, 13237.801432978513, 13240.668983275398, 13360.665983350422, 13360.799588006188, 601.6269912654161, 636.7675798333598, 742.2243755275723, 759.1611269547153, 774.1871035412822, 760.3005235183645, 775.6005657086605, 775.8913752074714, 776.3556248313886, 776.4952780692538, 829.85062688716, 831.4803247970019, 831.6465502161587, 831.7421599304236, 832.0182185021672, 630.760311081786, 672.3814091036259, 818.1572979830754, 819.1071731812293, 819.7212947597816, 574.2964868036663, 606.5996442348073, 610.4749915073033, 611.2542697908544, 611.4191518057819, 13698.0, 13784.862151378458, 13788.586342409744, 13793.10344827583, 13804.654883627989, 12589.937050314782, 12671.683207919783, 12837.422315995802, 12977.416016279196, 13118.0, 11246.3814490203, 11424.714382140513, 11522.654320370402, 11812.704682382922, 11893.286402815773, 4003.2794097062515, 4006.2988976929214, 4011.338129208677, 4065.532463766675, 4197.748135111903, 61007.69496152491, 63666.68166659183, 63859.0, 64300.03549946802, 66117.0, 9983.0, 10189.796204075878, 10222.488875556193, 10363.585456581652, 10772.08437282824, 19048.42854714361, 19080.8091919079, 19082.236710531703, 19093.713594296096, 19108.808911910703, 6713.0937323461685, 6898.758543450955, 6974.546654467444, 6975.4070903972715, 7046.0, 3616.5840928293055, 3658.2317713279976, 3791.848326066982, 3876.379779235309, 3894.3963685628773, 2729.208529526415, 2789.0377819652185, 2805.6773471050683, 2808.2698498390564, 2817.0, 496.3026947139275, 503.2803091579077, 506.4757975495418, 507.1505228741843, 511.11832089645065, 534.668505526576, 562.7889541421966, 563.8618538458022, 588.147186579453, 603.4448307557058, 8013.805587881325, 8147.877781833277, 8179.182081791892, 8216.34269258458, 8544.61549230286, 590.6692252338704, 597.2403718591477, 611.1901730207493, 615.6359579215833, 665.4643012374988, 3989.3617021276455, 4080.8571699990357, 4254.85108021224, 4294.935575966363, 4349.151915376471, 59689.40310596925, 59873.40126598678, 60181.39818601846, 61790.382096178466, 62300.688496558134, 40559.58041468535, 48055.519444805104, 51230.74384628053, 52370.0, 53387.733061334446, 47996.280055799194, 48158.27762583564, 49168.0, 49230.75384623054, 50053.9967601945, 8117.634706438343, 8438.240558349778, 8504.957475212585, 8512.829743405222, 8691.391602587759, 34777.0, 35102.0, 35331.11672208215, 36037.0, 36172.81913590415, 43043.13913721771, 45175.32237016382, 46203.3069503951, 48352.0, 48492.75753621209, 9926.354786938826, 10048.246381521269, 10117.544710488193, 10191.898081019095, 10673.839892401775, 10964.945175274073, 11190.66428007161, 11658.6502404928, 11982.820257695967, 12005.279683219034, 10685.893141068489, 11140.944295278472, 11189.216754827085, 11318.773624527628, 11757.0, 10779.0, 10922.781544369227, 11254.774904502028, 11328.603498877499, 11403.429828508708, 10596.47017649099, 10656.62701805433, 10787.298825576627, 11283.097352211968, 11353.432328383713, 8722.869156962777, 8762.824743505222, 9001.54992250398, 9196.908030919605, 9329.440233586007, 8709.303255739653, 8993.460392376217, 9381.953090234505, 9644.083812037845, 9684.966157106805], "value": 6198.0669099764855, "unit": "score"}], "name": "dromaeo_css", "value": 6172.41364067201, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 115.0, 117.0, 115.0, 115.0, 114.0, 114.0, 117.0, 115.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 126.0, 126.0, 161.0, 127.0, 126.0, 130.0, 127.0, 146.0, 123.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 162.0, 164.0, 163.0, 160.0, 161.0, 161.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 75.0, 115.0, 80.0, 76.0, 77.0, 76.0, 91.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 121.0, 84.0, 85.0, 86.0, 104.0, 85.0, 86.0, 108.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 128.0, 127.0, 128.0, 127.0, 127.0, 128.0, 126.0, 126.0, 127.0], "value": 127.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 148.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 95.0, 96.0, 96.0, 96.0, 97.0, 95.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 67.0, 66.0, 65.0, 65.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 67.0, 67.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 89.0, 94.0, 91.0, 84.0, 85.0, 84.0, 87.0, 83.0, 84.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 140.0, 135.0, 136.0, 138.0, 139.0, 134.0, 133.0, 176.0, 160.0], "value": 142.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 187.0, 180.0, 179.0, 178.0, 181.0, 180.0, 179.0, 178.0, 181.0], "value": 180.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 69.0, 69.0, 74.0, 68.0, 71.0, 69.0, 67.0, 68.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1566.3999999999999, "alertThreshold": 2.0}]} 21:34:09 INFO - Return code: 0 21:34:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:34:09 INFO - # TBPL SUCCESS # 21:34:09 INFO - Running post-action listener: _resource_record_post_action 21:34:09 INFO - [mozharness: 2016-12-19 05:34:09.858388Z] Finished run-tests step (success) 21:34:09 INFO - Running post-run listener: _resource_record_post_run 21:34:09 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 382291968; Read time: 16; Write time: 246776 21:34:09 INFO - TinderboxPrint: CPU usage
13.1% 21:34:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 21:34:09 INFO - TinderboxPrint: I/O write bytes / time
382,291,968 / 246,776 21:34:09 INFO - TinderboxPrint: CPU idle
8,335.1 (86.9%) 21:34:09 INFO - TinderboxPrint: CPU user
1,215.8 (12.7%) 21:34:09 INFO - TinderboxPrint: Swap in / out
0 / 0 21:34:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99643392; Read time: 0; Write time: 75504 21:34:09 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 282648576; Read time: 0; Write time: 171272 21:34:10 INFO - Running post-run listener: _upload_blobber_files 21:34:10 INFO - Blob upload gear active. 21:34:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:34:10 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 21:34:10 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'] 21:34:10 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 21:34:10 INFO - (blobuploader) - INFO - Open directory for files ... 21:34:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:34:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:34:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:34:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:34:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:34:17 INFO - (blobuploader) - INFO - Done attempting. 21:34:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:34:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:34:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:34:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:34:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:34:20 INFO - (blobuploader) - INFO - Done attempting. 21:34:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:34:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:34:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:34:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:34:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:34:21 INFO - (blobuploader) - INFO - Done attempting. 21:34:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:34:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:34:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:34:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:34:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:34:22 INFO - (blobuploader) - INFO - Done attempting. 21:34:22 INFO - (blobuploader) - INFO - Iteration through files over. 21:34:22 INFO - Return code: 0 21:34:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:34:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:34:22 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6d7bdb019076dd3647b6534824b625ff3d347e7c6a7fb67c7da3d2f599bfbe4079a75d542fffe46251d7443eb1f6e57adddc912ac2991a51bed845274718cce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51237231d4cf001b4081df6c403bc2f0491abf2e8f9fdd840ea9784bf9ecfce772ea9f2f20ca7be780c6b7d5124641d0336e7639be520db1e15e82d5edbad802", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/13a7650c85fb486c204a42b7bf63bea951330f3cd8b283913b9e2d692b855a73c246b1c7c9619acc48e031ee5dfa38b20b076aebec04f4b8761adb1551be8d81", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/330f3d1c095a08926e0a25f525706aa8c5a425ae369311b346e74afaa02ab898a95d954c5a0e1674f39b74d1240472b018e3f6c589ddbc74963d476948462d8c"} 21:34:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:34:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:34:22 INFO - Contents: 21:34:22 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6d7bdb019076dd3647b6534824b625ff3d347e7c6a7fb67c7da3d2f599bfbe4079a75d542fffe46251d7443eb1f6e57adddc912ac2991a51bed845274718cce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51237231d4cf001b4081df6c403bc2f0491abf2e8f9fdd840ea9784bf9ecfce772ea9f2f20ca7be780c6b7d5124641d0336e7639be520db1e15e82d5edbad802", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/13a7650c85fb486c204a42b7bf63bea951330f3cd8b283913b9e2d692b855a73c246b1c7c9619acc48e031ee5dfa38b20b076aebec04f4b8761adb1551be8d81", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/330f3d1c095a08926e0a25f525706aa8c5a425ae369311b346e74afaa02ab898a95d954c5a0e1674f39b74d1240472b018e3f6c589ddbc74963d476948462d8c"} 21:34:22 INFO - Running post-run listener: copy_logs_to_upload_dir 21:34:22 INFO - Copying logs to upload dir... 21:34:22 INFO - mkdir: /builds/slave/test/build/upload/logs 21:34:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.784092 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-12-18 21:34:22.194025) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-18 21:34:22.197252) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6d7bdb019076dd3647b6534824b625ff3d347e7c6a7fb67c7da3d2f599bfbe4079a75d542fffe46251d7443eb1f6e57adddc912ac2991a51bed845274718cce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51237231d4cf001b4081df6c403bc2f0491abf2e8f9fdd840ea9784bf9ecfce772ea9f2f20ca7be780c6b7d5124641d0336e7639be520db1e15e82d5edbad802", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/13a7650c85fb486c204a42b7bf63bea951330f3cd8b283913b9e2d692b855a73c246b1c7c9619acc48e031ee5dfa38b20b076aebec04f4b8761adb1551be8d81", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/330f3d1c095a08926e0a25f525706aa8c5a425ae369311b346e74afaa02ab898a95d954c5a0e1674f39b74d1240472b018e3f6c589ddbc74963d476948462d8c"} build_url:https://queue.taskcluster.net/v1/task/MwmZEgytS2OCviwCAt76pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011395 build_url: 'https://queue.taskcluster.net/v1/task/MwmZEgytS2OCviwCAt76pA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6d7bdb019076dd3647b6534824b625ff3d347e7c6a7fb67c7da3d2f599bfbe4079a75d542fffe46251d7443eb1f6e57adddc912ac2991a51bed845274718cce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51237231d4cf001b4081df6c403bc2f0491abf2e8f9fdd840ea9784bf9ecfce772ea9f2f20ca7be780c6b7d5124641d0336e7639be520db1e15e82d5edbad802", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/13a7650c85fb486c204a42b7bf63bea951330f3cd8b283913b9e2d692b855a73c246b1c7c9619acc48e031ee5dfa38b20b076aebec04f4b8761adb1551be8d81", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/330f3d1c095a08926e0a25f525706aa8c5a425ae369311b346e74afaa02ab898a95d954c5a0e1674f39b74d1240472b018e3f6c589ddbc74963d476948462d8c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-18 21:34:22.223111) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 21:34:22.223471) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1482124317.327173-1398855372 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 21:34:22.308085) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-18 21:34:22.308439) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-18 21:34:22.308813) ========= ========= Total master_lag: 0.17 =========