builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-058 starttime: 1474346349.74 results: success (0) buildid: 20160919200618 builduid: d4dcc52cf3154bd78689cb2e93a8e1dd revision: e1bf663363fd84b7c7c9f3c08bc22bce4874dede ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-19 21:39:09.740783) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-19 21:39:09.741313) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-19 21:39:09.741639) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-19 21:39:09.762401) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 21:39:09.762733) ========= 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=0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-19 21:39:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.9M=0s 2016-09-19 21:39:10 (45.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098134 ========= master_lag: 0.28 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 21:39:10.142147) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 21:39:10.142522) ========= 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=0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018516 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 21:39:10.176926) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 21:39:10.180390) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev e1bf663363fd84b7c7c9f3c08bc22bce4874dede --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev e1bf663363fd84b7c7c9f3c08bc22bce4874dede --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=0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-19 21:39:10,625 truncating revision to first 12 chars 2016-09-19 21:39:10,625 Setting DEBUG logging. 2016-09-19 21:39:10,625 attempt 1/10 2016-09-19 21:39:10,625 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/e1bf663363fd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-19 21:39:11,140 unpacking tar archive at: autoland-e1bf663363fd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.865501 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 21:39:11.066112) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-19 21:39:11.066560) ========= script_repo_revision: e1bf663363fd84b7c7c9f3c08bc22bce4874dede ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-19 21:39:11.067026) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-19 21:39:11.067336) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-19 21:39:11.078768) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-09-19 21:39:11.079101) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:39:11 INFO - MultiFileLogger online at 20160919 21:39:11 in /builds/slave/test 21:39:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 21:39:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:39:11 INFO - {'append_to_log': False, 21:39:11 INFO - 'base_work_dir': '/builds/slave/test', 21:39:11 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 21:39:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:39:11 INFO - 'branch': 'Autoland-Non-PGO', 21:39:11 INFO - 'buildbot_json_path': 'buildprops.json', 21:39:11 INFO - 'config_files': ('talos/linux_config.py',), 21:39:11 INFO - 'default_actions': ('clobber', 21:39:11 INFO - 'read-buildbot-config', 21:39:11 INFO - 'download-and-extract', 21:39:11 INFO - 'populate-webroot', 21:39:11 INFO - 'create-virtualenv', 21:39:11 INFO - 'install', 21:39:11 INFO - 'run-tests'), 21:39:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:39:11 INFO - 'download_minidump_stackwalk': True, 21:39:11 INFO - 'download_symbols': 'ondemand', 21:39:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:39:11 INFO - 'tooltool.py': '/tools/tooltool.py', 21:39:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:39:11 INFO - '/tools/misc-python/virtualenv.py')}, 21:39:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:39:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:39:11 INFO - 'installer_path': 'installer.exe', 21:39:11 INFO - 'log_level': 'info', 21:39:11 INFO - 'log_name': 'talos', 21:39:11 INFO - 'log_to_console': True, 21:39:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:39:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:39:11 INFO - 'opt_config_files': (), 21:39:11 INFO - 'pip_index': False, 21:39:11 INFO - 'sps_profile': False, 21:39:11 INFO - 'sps_profile_interval': 0, 21:39:11 INFO - 'suite': 'dromaeojs', 21:39:11 INFO - 'system_bits': '32', 21:39:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:39:11 INFO - 'title': 'talos-linux64-ix-058', 21:39:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:39:11 INFO - 'use_talos_json': True, 21:39:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:39:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:39:11 INFO - 'work_dir': 'build'} 21:39:11 INFO - [mozharness: 2016-09-20 04:39:11.623273Z] Running clobber step. 21:39:11 INFO - Running pre-action listener: _resource_record_pre_action 21:39:11 INFO - Running main action method: clobber 21:39:11 INFO - rmtree: /builds/slave/test/build 21:39:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:39:12 INFO - Running post-action listener: _resource_record_post_action 21:39:12 INFO - [mozharness: 2016-09-20 04:39:12.595418Z] Finished clobber step (success) 21:39:12 INFO - [mozharness: 2016-09-20 04:39:12.595519Z] Running read-buildbot-config step. 21:39:12 INFO - Running pre-action listener: _resource_record_pre_action 21:39:12 INFO - Running main action method: read_buildbot_config 21:39:12 INFO - Using buildbot properties: 21:39:12 INFO - { 21:39:12 INFO - "project": "", 21:39:12 INFO - "product": "firefox", 21:39:12 INFO - "script_repo_revision": "production", 21:39:12 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 21:39:12 INFO - "repository": "", 21:39:12 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 21:39:12 INFO - "buildid": "20160919200618", 21:39:12 INFO - "pgo_build": "False", 21:39:12 INFO - "basedir": "/builds/slave/test", 21:39:12 INFO - "buildnumber": 478, 21:39:12 INFO - "slavename": "talos-linux64-ix-058", 21:39:12 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:39:12 INFO - "platform": "ubuntu64_hw", 21:39:12 INFO - "scheduler": "tests-autoland-linux64-talos", 21:39:12 INFO - "branch": "autoland", 21:39:12 INFO - "repo_path": "integration/autoland", 21:39:12 INFO - "revision": "e1bf663363fd84b7c7c9f3c08bc22bce4874dede", 21:39:12 INFO - "stage_platform": "linux64", 21:39:12 INFO - "builduid": "d4dcc52cf3154bd78689cb2e93a8e1dd", 21:39:12 INFO - "slavebuilddir": "test" 21:39:12 INFO - } 21:39:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/NwbeHYMjSTGoSkwNnKg2Iw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:39:12 INFO - Running post-action listener: _resource_record_post_action 21:39:12 INFO - [mozharness: 2016-09-20 04:39:12.597982Z] Finished read-buildbot-config step (success) 21:39:12 INFO - [mozharness: 2016-09-20 04:39:12.598070Z] Running download-and-extract step. 21:39:12 INFO - Running pre-action listener: _resource_record_pre_action 21:39:12 INFO - Running main action method: download_and_extract 21:39:12 INFO - mkdir: /builds/slave/test/build/tests 21:39:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:39:12 INFO - trying https://queue.taskcluster.net/v1/task/NwbeHYMjSTGoSkwNnKg2Iw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:39:12 INFO - Downloading https://queue.taskcluster.net/v1/task/NwbeHYMjSTGoSkwNnKg2Iw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:39:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NwbeHYMjSTGoSkwNnKg2Iw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:39:13 INFO - Downloaded 1361 bytes. 21:39:13 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:39:13 INFO - Using the following test package requirements: 21:39:13 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:39:13 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:39:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:39:13 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:39:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:39:13 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:39:13 INFO - u'jsshell-linux-x86_64.zip'], 21:39:13 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:39:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:39:13 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:39:13 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:39:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:39:13 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:39:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:39:13 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:39:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:39:13 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:39:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:39:13 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:39:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NwbeHYMjSTGoSkwNnKg2Iw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:39:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NwbeHYMjSTGoSkwNnKg2Iw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:39:13 INFO - Fetch https://queue.taskcluster.net/v1/task/NwbeHYMjSTGoSkwNnKg2Iw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:39:13 INFO - Expected file size: 20370444 21:39:18 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:39:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NwbeHYMjSTGoSkwNnKg2Iw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:39:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NwbeHYMjSTGoSkwNnKg2Iw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:39:18 INFO - Fetch https://queue.taskcluster.net/v1/task/NwbeHYMjSTGoSkwNnKg2Iw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:39:18 INFO - Expected file size: 20370444 21:39:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NwbeHYMjSTGoSkwNnKg2Iw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:39:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NwbeHYMjSTGoSkwNnKg2Iw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:39:23 INFO - Fetch https://queue.taskcluster.net/v1/task/NwbeHYMjSTGoSkwNnKg2Iw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:39:23 INFO - Expected file size: 14414059 21:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:39:24 INFO - trying https://queue.taskcluster.net/v1/task/NwbeHYMjSTGoSkwNnKg2Iw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:39:24 INFO - Downloading https://queue.taskcluster.net/v1/task/NwbeHYMjSTGoSkwNnKg2Iw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:39:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NwbeHYMjSTGoSkwNnKg2Iw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:39:26 INFO - Downloaded 55605113 bytes. 21:39:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NwbeHYMjSTGoSkwNnKg2Iw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:39:26 INFO - mkdir: /builds/slave/test/properties 21:39:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:39:26 INFO - Writing to file /builds/slave/test/properties/build_url 21:39:26 INFO - Contents: 21:39:26 INFO - build_url:https://queue.taskcluster.net/v1/task/NwbeHYMjSTGoSkwNnKg2Iw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:39:27 INFO - Running post-action listener: _resource_record_post_action 21:39:27 INFO - Running post-action listener: set_extra_try_arguments 21:39:27 INFO - [mozharness: 2016-09-20 04:39:27.357390Z] Finished download-and-extract step (success) 21:39:27 INFO - [mozharness: 2016-09-20 04:39:27.357621Z] Running populate-webroot step. 21:39:27 INFO - Running pre-action listener: _resource_record_pre_action 21:39:27 INFO - Running main action method: populate_webroot 21:39:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:39:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:39:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:39:27 INFO - '--tppagecycles', 21:39:27 INFO - '7'], 21:39:27 INFO - 'tests': ['tsvgm']}}, 21:39:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:39:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:39:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:39:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:39:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:39:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:39:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:27 INFO - 'talos_options': ['--disable-e10s'], 21:39:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:39:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:39:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:27 INFO - 'talos_options': ['--disable-e10s'], 21:39:27 INFO - 'tests': ['damp', 'tps']}, 21:39:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:27 INFO - 'tests': ['damp', 'tps']}, 21:39:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:39:27 INFO - 'tests': ['dromaeo_dom']}, 21:39:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:39:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:39:27 INFO - 'tests': ['basic_compositor_video']}, 21:39:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:39:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:39:27 INFO - 'tests': ['a11yr', 21:39:27 INFO - 'ts_paint', 21:39:27 INFO - 'tpaint', 21:39:27 INFO - 'sessionrestore', 21:39:27 INFO - 'sessionrestore_no_auto_restore', 21:39:27 INFO - 'tabpaint']}, 21:39:27 INFO - 'other-e10s': {'tests': ['a11yr', 21:39:27 INFO - 'ts_paint', 21:39:27 INFO - 'tpaint', 21:39:27 INFO - 'sessionrestore', 21:39:27 INFO - 'sessionrestore_no_auto_restore', 21:39:27 INFO - 'tabpaint']}, 21:39:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:39:27 INFO - 'ts_paint', 21:39:27 INFO - 'tpaint', 21:39:27 INFO - 'sessionrestore', 21:39:27 INFO - 'sessionrestore_no_auto_restore', 21:39:27 INFO - 'tabpaint']}, 21:39:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:39:27 INFO - 'ts_paint', 21:39:27 INFO - 'tpaint', 21:39:27 INFO - 'sessionrestore', 21:39:27 INFO - 'sessionrestore_no_auto_restore', 21:39:27 INFO - 'tabpaint']}, 21:39:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:39:27 INFO - 'tests': ['a11yr', 21:39:27 INFO - 'ts_paint', 21:39:27 INFO - 'tpaint', 21:39:27 INFO - 'sessionrestore', 21:39:27 INFO - 'sessionrestore_no_auto_restore', 21:39:27 INFO - 'tabpaint']}, 21:39:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:39:27 INFO - 'tests': ['a11yr', 21:39:27 INFO - 'ts_paint', 21:39:27 INFO - 'tpaint', 21:39:27 INFO - 'sessionrestore', 21:39:27 INFO - 'sessionrestore_no_auto_restore', 21:39:27 INFO - 'tabpaint']}, 21:39:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:39:27 INFO - 'tests': ['tsvgx', 21:39:27 INFO - 'tsvgr_opacity', 21:39:27 INFO - 'tart', 21:39:27 INFO - 'tscrollx', 21:39:27 INFO - 'cart']}, 21:39:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:39:27 INFO - 'tsvgr_opacity', 21:39:27 INFO - 'tart', 21:39:27 INFO - 'tscrollx', 21:39:27 INFO - 'cart']}, 21:39:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:27 INFO - 'talos_options': ['--disable-e10s'], 21:39:27 INFO - 'tests': ['tp5o']}, 21:39:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:27 INFO - 'tests': ['tp5o']}, 21:39:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:27 INFO - 'talos_options': ['--disable-e10s', 21:39:27 INFO - '--xperf_path', 21:39:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:39:27 INFO - 'tests': ['tp5n']}, 21:39:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:27 INFO - 'talos_options': ['--xperf_path', 21:39:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:39:27 INFO - 'tests': ['tp5n']}}, 21:39:27 INFO - 'talos.zip': {'path': '', 21:39:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:39:27 INFO - Running post-action listener: _resource_record_post_action 21:39:27 INFO - [mozharness: 2016-09-20 04:39:27.375838Z] Finished populate-webroot step (success) 21:39:27 INFO - [mozharness: 2016-09-20 04:39:27.375926Z] Running create-virtualenv step. 21:39:27 INFO - Running pre-action listener: _resource_record_pre_action 21:39:27 INFO - Running main action method: create_virtualenv 21:39:27 INFO - Creating virtualenv /builds/slave/test/build/venv 21:39:27 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:39:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:39:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:39:27 INFO - Using real prefix '/usr' 21:39:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:39:27 INFO - Installing distribute.............................................................................................................................................................................................done. 21:39:29 INFO - Installing pip.................done. 21:39:29 INFO - Return code: 0 21:39:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:39:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f10561fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180af60>, '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 0x180bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c1d0>, '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': '0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363', '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:39:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:39:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:39:29 INFO - Using env: {'DISPLAY': ':0', 21:39:29 INFO - 'HOME': '/home/cltbld', 21:39:29 INFO - 'LANG': 'en_US.UTF-8', 21:39:29 INFO - 'LANGUAGE': 'en_US:en', 21:39:29 INFO - 'LOGNAME': 'cltbld', 21:39:29 INFO - 'MAIL': '/var/mail/cltbld', 21:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:29 INFO - 'MOZ_NO_REMOTE': '1', 21:39:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:29 INFO - 'NO_EM_RESTART': '1', 21:39:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:29 INFO - 'PWD': '/builds/slave/test', 21:39:29 INFO - 'SHELL': '/bin/bash', 21:39:29 INFO - 'SHLVL': '1', 21:39:29 INFO - 'TERM': 'linux', 21:39:29 INFO - 'TMOUT': '86400', 21:39:29 INFO - 'USER': 'cltbld', 21:39:29 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363', 21:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:29 INFO - '_': '/tools/buildbot/bin/python'} 21:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:30 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:39:30 INFO - Cleaning up... 21:39:30 INFO - Return code: 0 21:39:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:30 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 0x7f10561fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180af60>, '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 0x180bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c1d0>, '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': '0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363', '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:39:30 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:39:30 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:39:30 INFO - Using env: {'DISPLAY': ':0', 21:39:30 INFO - 'HOME': '/home/cltbld', 21:39:30 INFO - 'LANG': 'en_US.UTF-8', 21:39:30 INFO - 'LANGUAGE': 'en_US:en', 21:39:30 INFO - 'LOGNAME': 'cltbld', 21:39:30 INFO - 'MAIL': '/var/mail/cltbld', 21:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:30 INFO - 'MOZ_NO_REMOTE': '1', 21:39:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:30 INFO - 'NO_EM_RESTART': '1', 21:39:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:30 INFO - 'PWD': '/builds/slave/test', 21:39:30 INFO - 'SHELL': '/bin/bash', 21:39:30 INFO - 'SHLVL': '1', 21:39:30 INFO - 'TERM': 'linux', 21:39:30 INFO - 'TMOUT': '86400', 21:39:30 INFO - 'USER': 'cltbld', 21:39:30 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363', 21:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:30 INFO - '_': '/tools/buildbot/bin/python'} 21:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:30 INFO - Downloading/unpacking psutil>=3.1.1 21:39:30 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:39:30 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:39:30 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:39:30 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:39:30 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:39:30 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:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:39:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:39:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:39:32 INFO - Installing collected packages: psutil 21:39:32 INFO - Running setup.py install for psutil 21:39:32 INFO - building 'psutil._psutil_linux' extension 21:39:32 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:39:32 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:39:32 INFO - building 'psutil._psutil_posix' extension 21:39:32 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:39:32 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:39:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:39:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:39:32 INFO - Successfully installed psutil 21:39:32 INFO - Cleaning up... 21:39:32 INFO - Return code: 0 21:39:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:39:32 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:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:32 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:39:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:32 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 0x7f10561fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180af60>, '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 0x180bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c1d0>, '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': '0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363', '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:39:32 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:39:32 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:39:32 INFO - Using env: {'DISPLAY': ':0', 21:39:32 INFO - 'HOME': '/home/cltbld', 21:39:32 INFO - 'LANG': 'en_US.UTF-8', 21:39:32 INFO - 'LANGUAGE': 'en_US:en', 21:39:32 INFO - 'LOGNAME': 'cltbld', 21:39:32 INFO - 'MAIL': '/var/mail/cltbld', 21:39:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:32 INFO - 'MOZ_NO_REMOTE': '1', 21:39:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:32 INFO - 'NO_EM_RESTART': '1', 21:39:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:32 INFO - 'PWD': '/builds/slave/test', 21:39:32 INFO - 'SHELL': '/bin/bash', 21:39:32 INFO - 'SHLVL': '1', 21:39:32 INFO - 'TERM': 'linux', 21:39:32 INFO - 'TMOUT': '86400', 21:39:32 INFO - 'USER': 'cltbld', 21:39:32 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363', 21:39:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:32 INFO - '_': '/tools/buildbot/bin/python'} 21:39:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:39:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:39:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:39:35 INFO - Installing collected packages: mozsystemmonitor 21:39:35 INFO - Running setup.py install for mozsystemmonitor 21:39:35 INFO - Successfully installed mozsystemmonitor 21:39:35 INFO - Cleaning up... 21:39:35 INFO - Return code: 0 21:39:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:39:35 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:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:35 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:39:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:35 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 0x7f10561fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180af60>, '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 0x180bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c1d0>, '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': '0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363', '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:39:35 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:39:35 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:39:35 INFO - Using env: {'DISPLAY': ':0', 21:39:35 INFO - 'HOME': '/home/cltbld', 21:39:35 INFO - 'LANG': 'en_US.UTF-8', 21:39:35 INFO - 'LANGUAGE': 'en_US:en', 21:39:35 INFO - 'LOGNAME': 'cltbld', 21:39:35 INFO - 'MAIL': '/var/mail/cltbld', 21:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:35 INFO - 'MOZ_NO_REMOTE': '1', 21:39:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:35 INFO - 'NO_EM_RESTART': '1', 21:39:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:35 INFO - 'PWD': '/builds/slave/test', 21:39:35 INFO - 'SHELL': '/bin/bash', 21:39:35 INFO - 'SHLVL': '1', 21:39:35 INFO - 'TERM': 'linux', 21:39:35 INFO - 'TMOUT': '86400', 21:39:35 INFO - 'USER': 'cltbld', 21:39:35 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363', 21:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:35 INFO - '_': '/tools/buildbot/bin/python'} 21:39:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:35 INFO - Downloading/unpacking jsonschema==2.5.1 21:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:39:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:37 INFO - Downloading functools32-3.2.3-2.tar.gz 21:39:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:39:37 INFO - warning: no files found matching '*.txt' 21:39:37 INFO - no previously-included directories found matching 'build' 21:39:37 INFO - no previously-included directories found matching 'dist' 21:39:37 INFO - no previously-included directories found matching '.git*' 21:39:37 INFO - Installing collected packages: jsonschema, functools32 21:39:37 INFO - Running setup.py install for functools32 21:39:37 INFO - warning: no files found matching '*.txt' 21:39:37 INFO - no previously-included directories found matching 'build' 21:39:37 INFO - no previously-included directories found matching 'dist' 21:39:37 INFO - no previously-included directories found matching '.git*' 21:39:37 INFO - Successfully installed jsonschema functools32 21:39:37 INFO - Cleaning up... 21:39:37 INFO - Return code: 0 21:39:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:39:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:37 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 0x7f10561fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180af60>, '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 0x180bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c1d0>, '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': '0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363', '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:39:37 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:39:37 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:39:37 INFO - Using env: {'DISPLAY': ':0', 21:39:37 INFO - 'HOME': '/home/cltbld', 21:39:37 INFO - 'LANG': 'en_US.UTF-8', 21:39:37 INFO - 'LANGUAGE': 'en_US:en', 21:39:37 INFO - 'LOGNAME': 'cltbld', 21:39:37 INFO - 'MAIL': '/var/mail/cltbld', 21:39:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:37 INFO - 'MOZ_NO_REMOTE': '1', 21:39:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:37 INFO - 'NO_EM_RESTART': '1', 21:39:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:37 INFO - 'PWD': '/builds/slave/test', 21:39:37 INFO - 'SHELL': '/bin/bash', 21:39:37 INFO - 'SHLVL': '1', 21:39:37 INFO - 'TERM': 'linux', 21:39:37 INFO - 'TMOUT': '86400', 21:39:37 INFO - 'USER': 'cltbld', 21:39:37 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363', 21:39:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:37 INFO - '_': '/tools/buildbot/bin/python'} 21:39:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:39:38 INFO - Cleaning up... 21:39:38 INFO - Return code: 0 21:39:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:39:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:38 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 0x7f10561fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180af60>, '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 0x180bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c1d0>, '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': '0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363', '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:39:38 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:39:38 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:39:38 INFO - Using env: {'DISPLAY': ':0', 21:39:38 INFO - 'HOME': '/home/cltbld', 21:39:38 INFO - 'LANG': 'en_US.UTF-8', 21:39:38 INFO - 'LANGUAGE': 'en_US:en', 21:39:38 INFO - 'LOGNAME': 'cltbld', 21:39:38 INFO - 'MAIL': '/var/mail/cltbld', 21:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:38 INFO - 'MOZ_NO_REMOTE': '1', 21:39:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:38 INFO - 'NO_EM_RESTART': '1', 21:39:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:38 INFO - 'PWD': '/builds/slave/test', 21:39:38 INFO - 'SHELL': '/bin/bash', 21:39:38 INFO - 'SHLVL': '1', 21:39:38 INFO - 'TERM': 'linux', 21:39:38 INFO - 'TMOUT': '86400', 21:39:38 INFO - 'USER': 'cltbld', 21:39:38 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363', 21:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:38 INFO - '_': '/tools/buildbot/bin/python'} 21:39:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:38 INFO - Downloading/unpacking blobuploader==1.2.4 21:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:40 INFO - Downloading blobuploader-1.2.4.tar.gz 21:39:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:39:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:39:40 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:39:40 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:39:40 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:39:40 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:39:40 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:39:40 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:39:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:39:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:39:40 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:39:40 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:39:40 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:39:40 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:39:40 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:39:40 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:39:40 INFO - Downloading docopt-0.6.1.tar.gz 21:39:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:39:40 INFO - Installing collected packages: blobuploader, requests, docopt 21:39:40 INFO - Running setup.py install for blobuploader 21:39:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:39:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:39:41 INFO - Running setup.py install for requests 21:39:41 INFO - Running setup.py install for docopt 21:39:41 INFO - Successfully installed blobuploader requests docopt 21:39:41 INFO - Cleaning up... 21:39:41 INFO - Return code: 0 21:39:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:39: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:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39: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:39:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:41 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 0x7f10561fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180af60>, '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 0x180bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c1d0>, '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': '0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363', '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:39:41 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:39:41 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:39:41 INFO - Using env: {'DISPLAY': ':0', 21:39:41 INFO - 'HOME': '/home/cltbld', 21:39:41 INFO - 'LANG': 'en_US.UTF-8', 21:39:41 INFO - 'LANGUAGE': 'en_US:en', 21:39:41 INFO - 'LOGNAME': 'cltbld', 21:39:41 INFO - 'MAIL': '/var/mail/cltbld', 21:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:41 INFO - 'MOZ_NO_REMOTE': '1', 21:39:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:41 INFO - 'NO_EM_RESTART': '1', 21:39:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:41 INFO - 'PWD': '/builds/slave/test', 21:39:41 INFO - 'SHELL': '/bin/bash', 21:39:41 INFO - 'SHLVL': '1', 21:39:41 INFO - 'TERM': 'linux', 21:39:41 INFO - 'TMOUT': '86400', 21:39:41 INFO - 'USER': 'cltbld', 21:39:41 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363', 21:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:41 INFO - '_': '/tools/buildbot/bin/python'} 21:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:39:41 INFO - Running setup.py (path:/tmp/pip-YeAHc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:39:41 INFO - Running setup.py (path:/tmp/pip-ffzLiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:39:41 INFO - Running setup.py (path:/tmp/pip-CyL_Dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:39:42 INFO - Running setup.py (path:/tmp/pip-oO5hJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:39:42 INFO - Running setup.py (path:/tmp/pip-jf93YD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:39:42 INFO - Running setup.py (path:/tmp/pip-wWzahJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:39:42 INFO - Running setup.py (path:/tmp/pip-31ct5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:39:42 INFO - Running setup.py (path:/tmp/pip-Epz9h_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:39:42 INFO - Running setup.py (path:/tmp/pip-5eoVcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:39:42 INFO - Running setup.py (path:/tmp/pip-vWqUKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:39:42 INFO - Running setup.py (path:/tmp/pip-zZPutm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:39:42 INFO - Running setup.py (path:/tmp/pip-T69nlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:39:42 INFO - Running setup.py (path:/tmp/pip-6Cv6xT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:39:42 INFO - Running setup.py (path:/tmp/pip-Z_SJkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:39:42 INFO - Running setup.py (path:/tmp/pip-QIXMsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:39:42 INFO - Running setup.py (path:/tmp/pip-3YP8x2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:39:42 INFO - Running setup.py (path:/tmp/pip-IJYJb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:39:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:39:43 INFO - Running setup.py install for manifestparser 21:39:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:39:43 INFO - Running setup.py install for mozcrash 21:39:43 INFO - Running setup.py install for mozdebug 21:39:43 INFO - Running setup.py install for mozdevice 21:39:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:39:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:39:43 INFO - Running setup.py install for mozfile 21:39:43 INFO - Running setup.py install for mozhttpd 21:39:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:39:43 INFO - Running setup.py install for mozinfo 21:39:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:39:43 INFO - Running setup.py install for mozInstall 21:39:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:39:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:39:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:39:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:39:43 INFO - Running setup.py install for mozleak 21:39:43 INFO - Running setup.py install for mozlog 21:39:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:39:44 INFO - Running setup.py install for moznetwork 21:39:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:39:44 INFO - Running setup.py install for mozprocess 21:39:44 INFO - Running setup.py install for mozprofile 21:39:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:39:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:39:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:39:44 INFO - Running setup.py install for mozrunner 21:39:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:39:44 INFO - Running setup.py install for mozscreenshot 21:39:44 INFO - Running setup.py install for moztest 21:39:44 INFO - Running setup.py install for mozversion 21:39:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:39:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:39:44 INFO - Cleaning up... 21:39:44 INFO - Return code: 0 21:39:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:39:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:44 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 0x7f10561fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180af60>, '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 0x180bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c1d0>, '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': '0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363', '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:39:44 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:39:44 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:39:44 INFO - Using env: {'DISPLAY': ':0', 21:39:44 INFO - 'HOME': '/home/cltbld', 21:39:44 INFO - 'LANG': 'en_US.UTF-8', 21:39:44 INFO - 'LANGUAGE': 'en_US:en', 21:39:44 INFO - 'LOGNAME': 'cltbld', 21:39:44 INFO - 'MAIL': '/var/mail/cltbld', 21:39:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:44 INFO - 'MOZ_NO_REMOTE': '1', 21:39:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:44 INFO - 'NO_EM_RESTART': '1', 21:39:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:44 INFO - 'PWD': '/builds/slave/test', 21:39:44 INFO - 'SHELL': '/bin/bash', 21:39:44 INFO - 'SHLVL': '1', 21:39:44 INFO - 'TERM': 'linux', 21:39:44 INFO - 'TMOUT': '86400', 21:39:44 INFO - 'USER': 'cltbld', 21:39:44 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363', 21:39:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:44 INFO - '_': '/tools/buildbot/bin/python'} 21:39:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:39:45 INFO - Running setup.py (path:/tmp/pip-5kzCs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:39:45 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:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:39:45 INFO - Running setup.py (path:/tmp/pip-R6FL_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:39:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:39:45 INFO - Running setup.py (path:/tmp/pip-SwDJaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:39:45 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:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:39:45 INFO - Running setup.py (path:/tmp/pip-P8OnvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:39:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:39:45 INFO - Running setup.py (path:/tmp/pip-sfhu64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:39:45 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:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:39:45 INFO - Running setup.py (path:/tmp/pip-rpuW9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:39:45 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:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:39:45 INFO - Running setup.py (path:/tmp/pip-7Ejenw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:39:45 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:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:39:45 INFO - Running setup.py (path:/tmp/pip-ka9G9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:39:45 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:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:39:45 INFO - Running setup.py (path:/tmp/pip-38x4ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:39:45 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:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:39:45 INFO - Running setup.py (path:/tmp/pip-j9_7cZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:39:45 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:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:39:45 INFO - Running setup.py (path:/tmp/pip-oUSi7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:39:45 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:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:39:45 INFO - Running setup.py (path:/tmp/pip-MMtQE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:39:45 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:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:39:45 INFO - Running setup.py (path:/tmp/pip-Txd28d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:39:46 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:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:39:46 INFO - Running setup.py (path:/tmp/pip-QkGuF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:39:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:39:46 INFO - Running setup.py (path:/tmp/pip-7X54Cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:39:46 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:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:39:46 INFO - Running setup.py (path:/tmp/pip-12Yt7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:39:46 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:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:39:46 INFO - Running setup.py (path:/tmp/pip-Y4MVP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:39:46 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:39:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:39:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:39:46 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:39:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:39:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:39:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:48 INFO - Downloading blessings-1.6.tar.gz 21:39:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:39:48 INFO - Installing collected packages: blessings 21:39:48 INFO - Running setup.py install for blessings 21:39:48 INFO - Successfully installed blessings 21:39:48 INFO - Cleaning up... 21:39:48 INFO - Return code: 0 21:39:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:39:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:39:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:39:48 INFO - Reading from file tmpfile_stdout 21:39:48 INFO - Current package versions: 21:39:48 INFO - argparse == 1.2.1 21:39:48 INFO - blessings == 1.6 21:39:48 INFO - blobuploader == 1.2.4 21:39:48 INFO - docopt == 0.6.1 21:39:48 INFO - functools32 == 3.2.3-2 21:39:48 INFO - jsonschema == 2.5.1 21:39:48 INFO - manifestparser == 1.1 21:39:48 INFO - mozInstall == 1.12 21:39:48 INFO - mozcrash == 0.17 21:39:48 INFO - mozdebug == 0.1 21:39:48 INFO - mozdevice == 0.48 21:39:48 INFO - mozfile == 1.2 21:39:48 INFO - mozhttpd == 0.7 21:39:48 INFO - mozinfo == 0.9 21:39:48 INFO - mozleak == 0.1 21:39:48 INFO - mozlog == 3.4 21:39:48 INFO - moznetwork == 0.27 21:39:48 INFO - mozprocess == 0.23 21:39:48 INFO - mozprofile == 0.28 21:39:48 INFO - mozrunner == 6.12 21:39:48 INFO - mozscreenshot == 0.1 21:39:48 INFO - mozsystemmonitor == 0.3 21:39:48 INFO - moztest == 0.7 21:39:48 INFO - mozversion == 1.4 21:39:48 INFO - psutil == 3.1.1 21:39:48 INFO - requests == 1.2.3 21:39:48 INFO - wsgiref == 0.1.2 21:39:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:39:48 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:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:48 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:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:48 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 0x7f10561fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180af60>, '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 0x180bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c1d0>, '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': '0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363', '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:39:48 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:39:48 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:39:48 INFO - Using env: {'DISPLAY': ':0', 21:39:48 INFO - 'HOME': '/home/cltbld', 21:39:48 INFO - 'LANG': 'en_US.UTF-8', 21:39:48 INFO - 'LANGUAGE': 'en_US:en', 21:39:48 INFO - 'LOGNAME': 'cltbld', 21:39:48 INFO - 'MAIL': '/var/mail/cltbld', 21:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:48 INFO - 'MOZ_NO_REMOTE': '1', 21:39:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:48 INFO - 'NO_EM_RESTART': '1', 21:39:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:48 INFO - 'PWD': '/builds/slave/test', 21:39:48 INFO - 'SHELL': '/bin/bash', 21:39:48 INFO - 'SHLVL': '1', 21:39:48 INFO - 'TERM': 'linux', 21:39:48 INFO - 'TMOUT': '86400', 21:39:48 INFO - 'USER': 'cltbld', 21:39:48 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363', 21:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:48 INFO - '_': '/tools/buildbot/bin/python'} 21:39:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:48 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:39:48 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:39:48 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:39:48 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:39:48 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:39:48 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:39:48 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:39:48 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:39:48 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:39:48 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:39:48 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:39:48 INFO - Cleaning up... 21:39:48 INFO - Return code: 0 21:39:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:39:48 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:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:48 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:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:48 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 0x7f10561fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180af60>, '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 0x180bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c1d0>, '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': '0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363', '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:39:48 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:39:48 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:39:48 INFO - Using env: {'DISPLAY': ':0', 21:39:48 INFO - 'HOME': '/home/cltbld', 21:39:48 INFO - 'LANG': 'en_US.UTF-8', 21:39:48 INFO - 'LANGUAGE': 'en_US:en', 21:39:48 INFO - 'LOGNAME': 'cltbld', 21:39:48 INFO - 'MAIL': '/var/mail/cltbld', 21:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:48 INFO - 'MOZ_NO_REMOTE': '1', 21:39:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:48 INFO - 'NO_EM_RESTART': '1', 21:39:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:48 INFO - 'PWD': '/builds/slave/test', 21:39:48 INFO - 'SHELL': '/bin/bash', 21:39:48 INFO - 'SHLVL': '1', 21:39:48 INFO - 'TERM': 'linux', 21:39:48 INFO - 'TMOUT': '86400', 21:39:48 INFO - 'USER': 'cltbld', 21:39:48 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363', 21:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:48 INFO - '_': '/tools/buildbot/bin/python'} 21:39:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:39:49 INFO - Cleaning up... 21:39:49 INFO - Return code: 0 21:39:49 INFO - Running post-action listener: _resource_record_post_action 21:39:49 INFO - Running post-action listener: _start_resource_monitoring 21:39:49 INFO - Starting resource monitoring. 21:39:49 INFO - [mozharness: 2016-09-20 04:39:49.163813Z] Finished create-virtualenv step (success) 21:39:49 INFO - [mozharness: 2016-09-20 04:39:49.164278Z] Running install step. 21:39:49 INFO - Running pre-action listener: _resource_record_pre_action 21:39:49 INFO - Running main action method: install 21:39:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:39:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:39:49 INFO - Reading from file tmpfile_stdout 21:39:49 INFO - Detecting whether we're running mozinstall >=1.0... 21:39:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:39:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:39:49 INFO - Reading from file tmpfile_stdout 21:39:49 INFO - Output received: 21:39:49 INFO - Usage: mozinstall [options] installer 21:39:49 INFO - Options: 21:39:49 INFO - -h, --help show this help message and exit 21:39:49 INFO - -d DEST, --destination=DEST 21:39:49 INFO - Directory to install application into. [default: 21:39:49 INFO - "/builds/slave/test"] 21:39:49 INFO - --app=APP Application being installed. [default: firefox] 21:39:49 INFO - mkdir: /builds/slave/test/build/application 21:39:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:39:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:40:05 INFO - Reading from file tmpfile_stdout 21:40:05 INFO - Output received: 21:40:05 INFO - /builds/slave/test/build/application/firefox/firefox 21:40:05 INFO - Running post-action listener: _resource_record_post_action 21:40:05 INFO - [mozharness: 2016-09-20 04:40:05.533383Z] Finished install step (success) 21:40:05 INFO - [mozharness: 2016-09-20 04:40:05.533635Z] Running run-tests step. 21:40:05 INFO - Running pre-action listener: _resource_record_pre_action 21:40:05 INFO - Running main action method: run_tests 21:40:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:40:05 INFO - Python 2.7.3 21:40:05 INFO - Return code: 0 21:40:05 INFO - grabbing minidump binary from tooltool 21:40:05 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:40:05 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 0x180af60>, '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 0x180bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:40:05 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:40:05 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:40:05 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:40:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:40:05 INFO - Return code: 0 21:40:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:40:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:40:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:40:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:40:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:40:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NwbeHYMjSTGoSkwNnKg2Iw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NwbeHYMjSTGoSkwNnKg2Iw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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:40:05 INFO - Using env: {'DISPLAY': ':0', 21:40:05 INFO - 'HOME': '/home/cltbld', 21:40:05 INFO - 'LANG': 'en_US.UTF-8', 21:40:05 INFO - 'LANGUAGE': 'en_US:en', 21:40:05 INFO - 'LOGNAME': 'cltbld', 21:40:05 INFO - 'MAIL': '/var/mail/cltbld', 21:40:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:40:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:05 INFO - 'MOZ_NO_REMOTE': '1', 21:40:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:40:05 INFO - 'NO_EM_RESTART': '1', 21:40:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:05 INFO - 'PWD': '/builds/slave/test', 21:40:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:40:05 INFO - 'SHELL': '/bin/bash', 21:40:05 INFO - 'SHLVL': '1', 21:40:05 INFO - 'TERM': 'linux', 21:40:05 INFO - 'TMOUT': '86400', 21:40:05 INFO - 'USER': 'cltbld', 21:40:05 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363', 21:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:05 INFO - '_': '/tools/buildbot/bin/python'} 21:40:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NwbeHYMjSTGoSkwNnKg2Iw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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:40:05 INFO - mozversion application_buildid: 20160919200618 21:40:05 INFO - mozversion application_changeset: e1bf663363fd84b7c7c9f3c08bc22bce4874dede 21:40:05 INFO - mozversion application_display_name: Nightly 21:40:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:40:05 INFO - mozversion application_name: Firefox 21:40:05 INFO - mozversion application_remotingname: firefox 21:40:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:40:05 INFO - mozversion application_vendor: Mozilla 21:40:05 INFO - mozversion application_version: 52.0a1 21:40:05 INFO - mozversion platform_buildid: 20160919200618 21:40:05 INFO - mozversion platform_changeset: e1bf663363fd84b7c7c9f3c08bc22bce4874dede 21:40:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:40:05 INFO - mozversion platform_version: 52.0a1 21:40:05 INFO - using testdate: 1474346405 21:40:05 INFO - actual date: 1474346405 21:40:05 INFO - starting webserver on 'localhost:46085' 21:40:05 INFO - SUITE-START | Running 2 tests 21:40:05 INFO - TEST-START | dromaeo_css 21:40:05 INFO - operating with platform_type : linux_ 21:40:05 INFO - Initialising browser for dromaeo_css test... 21:40:05 INFO - TEST-INFO | started process 15232 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYbbYl4/profile http://localhost:46085/getInfo.html) 21:40:10 INFO - PROCESS | 15232 | __metrics Screen width/height:1600/1200 21:40:10 INFO - PROCESS | 15232 | colorDepth:24 21:40:10 INFO - PROCESS | 15232 | Browser inner width/height: 1024/697 21:40:10 INFO - PROCESS | 15232 | __metrics 21:40:10 INFO - PROCESS | 15232 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:40:10 INFO - PROCESS | 15232 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:40:11 INFO - PROCESS | 15232 | console.error: PushService: 21:40:11 INFO - PROCESS | 15232 | stateChangeProcessEnqueue: Error transitioning state 21:40:11 INFO - PROCESS | 15232 | UnknownError 21:40:12 INFO - TEST-INFO | 15232: exit 0 21:40:12 INFO - Browser initialized. 21:40:12 INFO - Running cycle 1/1 for dromaeo_css test... 21:40:12 INFO - TEST-INFO | started process 15314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYbbYl4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:40:24 INFO - PROCESS | 15314 | RSS: Main: 174166016 21:40:24 INFO - PROCESS | 15314 | 21:40:30 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.13341 seconds. 21:40:46 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 21:40:50 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:41:04 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 21:41:10 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 21:41:13 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.05006 seconds. 21:41:15 INFO - PROCESS | 15314 | 1474346475090 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:41:16 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 21:41:19 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.05006 seconds. 21:41:32 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 21:41:44 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.05006 seconds. 21:41:50 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 21:41:52 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 21:41:54 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 21:41:56 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.15004 seconds. 21:42:13 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.06673 seconds. 21:42:22 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 21:42:25 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.03337 seconds. 21:42:27 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.05006 seconds. 21:42:29 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 21:42:30 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 2.00011 seconds. 21:42:31 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:42:38 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 21:42:40 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.05004 seconds. 21:42:47 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 21:42:49 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 21:43:07 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:43:21 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:43:23 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01677 seconds. 21:43:25 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 21:43:28 INFO - PROCESS | 15314 | Cycle 1(1): loaded http://localhost:46085/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46085/tests/dromaeo/cssquery-ext.html) 21:43:29 INFO - PROCESS | 15314 | RSS: Main: 274079744 21:43:29 INFO - PROCESS | 15314 | 21:43:32 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.03341 seconds. 21:43:38 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 21:43:44 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 21:43:46 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 21:43:48 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 21:44:00 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00008 seconds. 21:44:02 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:44:14 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 21:44:20 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 21:44:22 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 21:44:34 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:44:42 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:44:44 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 21:44:46 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 21:44:51 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:45:01 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:45:03 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 21:45:11 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 21:45:12 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 2.01675 seconds. 21:45:19 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:45:35 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01677 seconds. 21:45:47 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:45:51 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:46:00 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.03344 seconds. 21:46:02 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 21:46:03 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:46:22 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 21:46:30 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 21:46:32 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01677 seconds. 21:46:32 INFO - PROCESS | 15314 | Cycle 1(1): loaded http://localhost:46085/tests/dromaeo/cssquery-ext.html (next: http://localhost:46085/tests/dromaeo/cssquery-jquery.html) 21:46:32 INFO - PROCESS | 15314 | RSS: Main: 274493440 21:46:32 INFO - PROCESS | 15314 | 21:46:47 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:46:51 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 21:46:59 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:47:13 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:47:16 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:47:33 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 21:47:37 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:47:39 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:47:41 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:47:45 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:47:55 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:47:57 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 21:48:00 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 21:48:02 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:48:14 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00008 seconds. 21:48:34 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:48:36 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:48:39 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:48:50 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 21:48:54 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01675 seconds. 21:49:04 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 21:49:14 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:49:18 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:49:32 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00009 seconds. 21:49:34 INFO - PROCESS | 15314 | Cycle 1(1): loaded http://localhost:46085/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46085/tests/dromaeo/cssquery-mootools.html) 21:49:35 INFO - PROCESS | 15314 | RSS: Main: 242753536 21:49:35 INFO - PROCESS | 15314 | 21:49:38 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 21:49:56 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:49:58 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:50:00 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:50:04 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:50:08 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 21:50:09 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 2.00012 seconds. 21:50:10 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:50:13 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 21:50:20 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 21:50:22 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01679 seconds. 21:50:26 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 21:50:33 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 21:50:36 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01674 seconds. 21:50:46 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:50:50 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:51:06 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01675 seconds. 21:51:29 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:51:35 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:51:37 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01675 seconds. 21:51:39 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 21:51:47 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:51:49 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:51:53 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 21:51:55 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:52:23 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 21:52:25 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:52:31 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00008 seconds. 21:52:33 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 21:52:35 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:52:37 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01675 seconds. 21:52:37 INFO - PROCESS | 15314 | Cycle 1(1): loaded http://localhost:46085/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46085/tests/dromaeo/cssquery-prototype.html) 21:52:38 INFO - PROCESS | 15314 | RSS: Main: 215801856 21:52:38 INFO - PROCESS | 15314 | 21:52:45 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 21:52:48 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 21:53:05 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 21:53:08 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 21:53:11 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 21:53:34 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:53:35 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:54:08 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 21:54:17 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 21:54:19 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 21:54:22 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:54:24 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:54:37 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 21:54:45 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01677 seconds. 21:54:47 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 21:54:50 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:54:54 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:54:57 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 21:55:10 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:55:11 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 21:55:15 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 21:55:17 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 21:55:19 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 21:55:28 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:55:37 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:55:40 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:55:41 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 21:55:41 INFO - PROCESS | 15314 | Cycle 1(1): loaded http://localhost:46085/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46085/tests/dromaeo/cssquery-yui.html) 21:55:42 INFO - PROCESS | 15314 | RSS: Main: 214933504 21:55:42 INFO - PROCESS | 15314 | 21:55:45 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 21:56:09 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:56:16 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00009 seconds. 21:56:18 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 21:56:36 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 21:56:41 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 21:56:43 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 21:56:55 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 21:57:09 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01667 seconds. 21:57:17 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 21:57:21 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:57:31 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01674 seconds. 21:57:43 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:57:45 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 21:57:46 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 2.00009 seconds. 21:57:49 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 21:57:53 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 21:58:07 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:58:17 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 21:58:26 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:58:44 INFO - PROCESS | 15314 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 21:58:44 INFO - PROCESS | 15314 | Cycle 1(1): loaded http://localhost:46085/tests/dromaeo/cssquery-yui.html (next: http://localhost:46085/tests/dromaeo/cssquery-dojo.html) 21:58:45 INFO - PROCESS | 15314 | RSS: Main: 319479808 21:58:45 INFO - PROCESS | 15314 | 21:58:45 INFO - PROCESS | 15314 | __start_tp_report 21:58:45 INFO - PROCESS | 15314 | _x_x_mozilla_page_load 21:58:45 INFO - PROCESS | 15314 | _x_x_mozilla_page_load_details 21:58:45 INFO - PROCESS | 15314 | |i|pagename|runs| 21:58:45 INFO - PROCESS | 15314 | |0;dojo.html;2569.486102779444;2595.8312709673883;2624;2630.0926180467745;2646.40455897423;4499.032707967786;4573.153966516197;4686;4721.716696998183;4729.952700472994;4587.8623641290815;4622.583967442921;4649.69776964497;4691.577758001779;4737.952620473794;4290.056187638715;4292.1630282095;4330.523642399334;4336;4403.845865394712;4347.043650396908;4366.0831225442535;4383.583559561836;4397.230484665187;4442.11157768446;4205.684573656988;4252.702310838243;4400.581944715247;4407.6914615976575;4409.933850992237;4280.058387154821;4281.079567892918;4308.030693094061;4308.719933204332;4311.547287534795;4284.4430224070675;4298.4197133387215;4364.694471387004;4376.190404775127;4382.189294980439;4596.241620132674;4657.464391594942;4671.929921051187;4699.765011749399;4743.810247590127;4858.441279252896;5002.1746411842005;5023.8492845214705;5027.371578552681;5092.898142037176;4935.6545041847085;4971.701697898102;5035.54680078791;5041.092603331399;5115.335006449175;4685.390899183084;4687.484376718558;4689.155951928686;4737.28940658904;4745.525447455261;5134.101532231844;5137.255098010843;5138;5140.126178549655;5184.248283998799;4742.146413645508;4760.666753327303;4894.461609222983;4912.631552633567;4978.5270399312;4977.65156439053;4980.875478113004;4989.725565093955;5025.120603894304;5034.798608055637;4804.591609713144;4847.3698419205275;4850.927236091461;4908.263760435963;4918.188498897642;4707.811687532529;4748.453927798348;4829.444613869379;4837.395325584302;4897.510248975074;4114.917701645951;4203.159368126387;4217.388478670576;4220.493540775126;4273.166732487197;3693.8337774800198;3695.6858667013066;3697.445383192489;3732.570754363229;3746.2882052409955;4167.74993500391;4323.200207961537;4326.848560300375;4328.653707703376;4374.8906277342685;4878;4935.136351138536;4939.925901111486;4940.011997600494;4994.126027945168;4296.033392486665;4306.655467562588;4307.181635489247;4319.2009478246;4354.869353919387;4478.081993191388;4486.528914463999;4487.528809475023;4538.205813982539;4538.909221815546;4582.793774280232;4636.86089417318;4665.2302370108555;4704.600108990706;4714.528547145395;4895.388076490439;4947.876303092307;4960.727160006234;4969.950300496948;5023.899522009467;4645.907081858411;4647.907041859212;4654.464736555339;4656.627469802475;4720.079584480994;4801.927971080367;4872.512748725099;4878.487758785276;4880.194767863263;4937.604991600735;4887.657863949489;4890.510948905081;4922.4585295616735;4943.456219815889;5001.224810154432;4795.18481858078;4805.5915247204375;4808.783604737725;4813.78337974785;4883.267509873547;4803.687760295569;4812;4822.493638168082;4824.228123500223;4889.828855990023;4634.2121839288075;4688.507706690748;4737.502562231054;4796.904061918673;4815.15734746425;4900.26496025599;4912.435069966857;4913.189323761682;4914.926276105933;4976.850694479172;4880.560749532559;4884.8290309838985;4886.169351210232;4927.802887884588;4942.827001054946 21:58:45 INFO - PROCESS | 15314 | |1;ext.html;525.5165247971865;557.6514678326046;562.2269379603046;573.796302312679;576.4293349583913;27503;30232.546511802342;30321.84839075804;30342.696573034264;37234.06914827131;35310.11724706883;38569.421458678145;38619;38731.419028714525;38751.224975500474;7570.470067095292;7704.8844267336035;7711.691532338699;7714.228577142297;7717.112532058801;7519.135299440552;7537.831636096414;7615.124260710034;7617.124030736453;7619.504732192418;7564.054493188351;7599.392048636123;7607.16321204667;7610.1628820829665;7615.428842836782;7595.544267343949;7618.657160427739;7621.733239336597;7631.1605723370385;7634.434940837115;7543.585102819343;7604.0875094988405;7608.212070163507;7610.733624323122;7620;36634.8168259157;36863.07842303964;37064.81467592645;37083.84787293083;37092.25815483675;2868.584055311968;2898.826070435781;2943.5290353543546;3022.350194708148;3032.6967303269716;25982.22053338384;27343.179704608894;27480.450390992068;27514.44971100567;29073.273168170752;3004.248937765559;3069.938601227985;3108.8911888084035;3130.5304204369527;3162.6362968258486;242041;242099;242575;243076;244800;27287;27862.860685696443;49249.26126108111;49515.75242123767;49587;30903.227419314248;31650.36699266002;31663.683363166074;31677.366452670816;31694.841525792224;13129.540466083641;13235.139715918434;13246.271455070064;13246.602601921957;13258.07193496446;10501.107405870434;10511.316764410441;10514.316569423116;10522.421266830397;10523.52644131016;7488.9625551871895;7557.470977031665;7575.962120189364;7582.696692132253;7600.353969912509;2979.508381117135;3016.638003439601;3043.8782448702245;3055.8624861881267;3085.41377138343;808.3088958940139;819.5328662662225;825.8018075661918;868.9826203476022;911.0889110889111;22842.31473055811;23129.190478333516;23213.651795223086;23427.297181084596;23878.283651490136;703.2861645429892;840.3907167303656;856.2251162697644;859.1709000814119;863.9827203455895;12638.431270592846;13209.669758256121;13297.800532992012;13416.396262168226;13465.865341346656;361540;362272;364174;365283;365615;47254.76372618115;47735;47823.76088119537;47889.29549863022;47924.7603761979;1074.8119079161115;1080.357187473452;1124.9268797528298;1128.1707944660668;1130.9943450282697;24864.37839054038;28402.147935561967;28427.299406556343;28566.57150142708;29105.563416549194;39370;39884.601153988086;39905.60094399019;39924.2015159701;39959;278878;279351;279574;279683;281792;23909;24031.158909438087;24435.38911527226;24707.25878223656;25373.238802835946;39219.80390098031;39608;39797.40303895386;39820.601793982845;40323.59676403316;33760;33989.66010339865;34113.14717132092;34196.82901585476;34202.65797341995;33999.83000085083;34347;34516.65483345134;34748.13129671779;35422;34141.658583413846;34369.48445773265;34425.31149377049;34630.30739385148;35273.118172045906;29425.411491769617;30933.535996960512;31140.532892006184;31205.68794312028;31439;24051.75948240565;24386.756132438448;24527.075667893052;24911.128110516045;24966 21:58:45 INFO - PROCESS | 15314 | |2;jquery.html;333.423177902229;355.58219092566213;361.2612208034569;364.2005797274981;389.55201518254006;12237.265764054164;13238.27189504577;15472.303746331414;15683.686326273482;16453.67092658146;12510.687232819184;12620.305883176421;12660.873391266085;13138.408771605276;14890.25548722565;4953.108440480712;5152.92270615941;5154.252633368159;5155.58755299577;5160.483951604847;4872.6832755870755;5013.122703526887;5041.495850414947;5070.264811602316;5086.491350864921;5041.193409054552;5041.59667226621;5045.772940217699;5047.369078865142;5053.115704751672;4885.340479035321;4910.607151427877;4962.87592810179;4987.177115775893;5020.0963826511215;4474.955250447519;4477.619402350804;4480.283154695233;4482.574155455259;4482.663800214997;16265.756013659804;17835.840670356516;17976.19107140182;18751.06244687774;18763.90618046901;1731.2988239762917;1790.811964743696;1845.6770065238663;1872.691005984011;2027.8986050697406;8943;8980.685676001309;9137.725868223964;9279.675211367638;9417.576209070608;1678.7146185148554;1733.3153404405189;1736.7915850097943;1742.5904912345588;1774.272548255222;65035;67376.66311668459;67415.3258467414;68049.65975170092;69981;9837.475191345353;9857.35927164732;9883.604655813688;10155;10279.537420816081;13678.179309241477;13681.452741890413;13707.109037912503;13710.108842925178;13716.588502344946;6872.931270687229;7215.242399548077;7246.130464344207;7406.8888966665545;7415.443841711894;6527.34726527353;6531.248906375733;6538.248101468392;6702;6843.213030501456;4206.4646404062905;4250.341197114452;4263.424437700933;4355.520892701864;4422.181896349186;1776.3072401763322;1797.1373740604583;1803.8827476214003;1814.963700725978;1851.7500137481536;670.1790306874137;670.215847458465;697.0722963553097;712.2148300710791;727.5489196698081;14093.85906140946;14351.64120896965;14410.495632652806;14967;14994.47519336818;717.1931576975902;740.1820987808394;752.6537792615459;760.422079219797;793.2741541489472;7702.152763196044;8031.9920019995;8292.668293268202;8393.790155246168;8434.114417986146;368934;373458;381489;382640;382949;70042.64978675176;72904.63547682228;74533.25466745372;75433;75556.24443755602;929.2333824594737;930.0885132569985;969.3214749675255;971.820213260549;972.9270304727174;14382.712345752818;14491.347889345216;14595.635109122357;14646.340914659078;15179.772303415237;25558.744412555636;27549.58675619827;35418.64581354154;37385.81307093447;37482;40972;42282.78858605687;47353.52646473491;48411.75794121007;49309.506904930495;5162.6386152968935;6586.571872828251;6730.6971186297715;7361.411087113125;7389.224131466119;9980.401175929468;11656.125790565571;11713.707157321136;11779.705507362385;12344.382780860742;9899.455529945923;10017.749556261151;10207.591696332063;10391.064804167661;10410.115140212863;10126.392416455037;10220.233482488695;10273.434961077213;10513.89486105129;10543.89456105429;9908.752281193028;10211.7447063824;10241.231907607109;10582.312149710244;10630.415327157081;6834.863302733818;6923.861522769617;6931.618760967994;6949.687264073028;6990.860182796418;7934.603269836601;10175.236857235588;10378.273520853469;10451.68644940653;10483.423411712123 21:58:45 INFO - PROCESS | 15314 | |3;mootools.html;1218.20816469295;1336.5455745046681;1363.6113707593336;1401.880840128589;1673.983260167398;6728.86542269155;7505.437092218085;7547.396208303343;7626.847463050735;7800.1419843817275;7615.77152685419;7682.078150621933;7692.423068269874;7693.422993275512;7696.114946781122;2135.2313167259813;2160.5246845693923;2161.5136594266323;2164.8592841465334;2167.3497950614833;2087.499000239947;2116.354511873878;2158.3740715192653;2160.567886422714;2169.652855543113;2059.938201853947;2096.8951552422395;2101.663733802592;2112.968305475419;2142.1003178664996;2092.466421062627;2098.213170061227;2099.5695882344085;2102.1696429910253;2102.4113248290505;2018.9596208075902;2096.3501314592527;2097.9055942482623;2098.076846187688;2099.653557163066;7636.579988100652;7688.846223075507;7810.297073263377;7935.444518883681;7943.920560794434;4496.910061798746;4660.580547750718;4666.580007799281;4709.764511774431;4711.882202944919;2821.6755073166437;2984.19426754775;3031.863566139529;3032.120685001347;3034.1201051694984;974.2644303550774;975.1857199238644;986.3490096536324;993.6919554937992;1008.2790804574691;10536.525856336406;10548.20888433363;10592.576296948113;10601.787964240671;10619.41593212373;3981.646240278319;4014.1770936957855;4106.815193316308;4140.861263152658;4160.729552579072;8334.916650833535;8337.291330236876;8343.624536895733;8346.707865224687;8347.373946954003;4574.336721175411;4581.496035436099;4584.4498660161;4585.312203169551;4585.862424127282;3563.7849248484986;3711.9072023199637;3849.8075096245634;4290.099079193405;4291.50647675515;3157.8105313681253;3542.6811586957297;3572.2676851245433;3593;3605.963940360563;1021.4790456867051;1053.173258991703;1055.4142450939803;1056.1497994114811;1068.514764477377;624.950003999679;705.989410158848;737.1485933746532;761.588742079271;762.6796745366959;4926.211806111077;4963.925541116886;5020.648554601143;5097.8725531861255;5140.074786538385;399.3849471813433;423.581003637817;424.67512353049943;425.1836473969985;429.8044389802695;3598.7300952428673;3656.7074634029213;3659.1766852457986;3692.409214525663;3857.1321452672923;8941.910580894108;9262.814743705088;9561.760955976157;9567.61729530811;9573.042695730372;8873.334499912533;9164.404313719588;9251.67619133327;9516.476593787409;9518.762030949281;7072.292770722989;7182.7486037989465;7279.745208917662;7285.854282914312;7287.927120728831;5088.974555127201;5307.336582927134;5310.840674779763;5314.362276526842;5504.724763761876;8621.353398495012;8706.521141337034;8793.252573531321;8873.378863479495;8875.378723489293;8899.955500222457;8976.326775491994;8980.146886045815;9051.90948090537;9057.18485336323;7319.304666056716;7358.337749602348;7364.66858991336;7370.410367170721;7383.2985866342615;7251;7449.962750186214;7501.474896757175;7525.88711169322;7583.544987300779;6535.379138981789;6602.075709400592;6623.503237257129;6625;6701.061851340914;6811.489138314745;6871.347222013901;6887.414569761627;6891.517593768388;6901.896471553031;6033.607815492154;6103.115048318058;6117.959946809142;6121.357257488078;6121.908171377522;4334.696571240109;4338.392625032435;4442.133783912235;4451.59935605797;4509.030558429953;4368.716033457815;4435.489918659396;4500.932486012778;4557.498675145797;4619.099275641218 21:58:45 INFO - PROCESS | 15314 | |4;prototype.html;294.201243623562;296.0659120474901;302.08618927743566;305.25669993565657;305.9801112927661;4696.42669705649;4730.4559975602815;4743.7153770773775;4749.928751068728;4767.0465906818645;4657.997061263655;4679.88300292492;4685.531446855312;4705.505921878204;4709.5055019223;3792.1467669774356;3812.90467738306;3823.7896915669626;3825.713071519633;3840.1743625120594;3465.6534346565395;3822.3502004659135;3834.789086600236;3837.3860182370686;3840.7119466040017;3650.3064417760543;3653.963460365402;3660.7254455915913;3676.6212670248656;3680.1719613086975;3617.385044542434;3633.109888077425;3639.854405823777;3651.3062518121474;3693.464447655102;3055.633324001134;3122.2818751687014;3132.201288671374;3253.9511907321407;3257.5439438478634;4521.751303678297;4563.931541026887;4574.559013910641;4578.88552786183;4592.609628181609;4192.392103145057;4196.538380778143;4200.235900921621;4203.43253660758;4205.306124489455;4605.700629459108;4678.438587369504;4791.185498465269;4931.284963680282;4953.380827396575;3492.947605785915;3495.178633021238;3511.17487390463;3527.735419843522;3535.8939231823088;5139.61452891031;5168.715720635363;5185.507376799198;5186.507281808223;5192.039472697563;3435.484677298425;3636.7636103653176;3638.490611314418;3640.10817349751;3646.3801153803915;3662;3666.1934374438115;3674.926501470009;3681.337359275356;3684.9815750921075;4136.73111247768;4138;4182.6824550266565;4193.511303487279;4201.138766552849;4877.365942427462;4930.161872481687;4939.629527785359;4969.229769385751;4974.353334066548;1243.2913239453426;1259.9433025513874;1261.9558315458914;1274.5539061328645;1275.8851703346743;795.3796039089403;804.1958041958042;822.2476434062885;826.9828111422984;836.6028732017545;3890.9650472631392;3922.627350401707;3938.980305098456;3942.8817135485983;4004.4983131325753;4476.597106260452;4495.707778994421;4500.707454015478;4540.228161212602;4549.840755573539;3935.2326296372507;3937.586553411908;3963.7514183032254;3978.8806335809973;3990.446114486731;2340.3447034830274;2349.150354491143;2386.296042667417;2395.2694428199566;2435.403326185096;4256.977935480622;4270.487541494978;4587.564181402761;4647.907041859212;4718.150732868116;5164.586833053347;5176.8964620707375;5198.766055527511;5214.869628259324;5222.216667499905;4802.375691160127;4817.927731083966;4820.3492528508905;4827;4827.517248275144;4949.7030178189425;5020.974895125501;5036.866704991347;5104.566111880532;5105.183170692671;4902.656814022984;4996.525330093636;5005.7997680092385;5006.199008158677;5033.370828646419;4760.428748550196;4811.687240329367;4826.855194344175;4850;4857.8299759508245;3410.710089642408;3633.709303255786;3642.307961487415;3652.817359132086;3679.5584529856587;5072.289879416959;5076.390833100052;5090.389153301628;5097.847064588068;5099.745012749422;4937.530934561211;4954.851354459372;4965.907500349917;4974.228994505857;5013.674111182761;4739.976300118477;4940.6788558743565;4946.406431228275;4979.576735977337;5014.247862820606;4870.147724148189;4873.439554451142;4880.341153944172;4880.95119048805;4885.169521181479;4994.926090890476;5019.698818070781;5024.422191447884;5053.823116190915;5064.848054558369;4666.253399456206;4895.7062576245535;4906.239532872411;4924.72913989734;4932.605391568594 21:58:45 INFO - PROCESS | 15314 | |5;yui.html;622.2532960447464;633.5565104426901;642.7589653879795;647.8445173158442;722.3534936232072;12040;13175.275359855204;13422.261775602337;13533.729325413486;13700.862991370082;12139.393030348492;12170.148089633729;12176.75646487072;12184.451699673515;12189.26864388135;723.5803234124195;753.1414187825856;758.0789340950744;759.4380158682591;761.6191904047976;597.4503456819715;614.7203022624695;744.57559191261;768.4160038370823;771.7684694591628;790.182161462886;793.4485532554877;795.0062421972534;795.2286282306154;795.5942469340649;787.3268355556003;790.5335851847437;791.3906292155009;791.5171745235431;791.7466410748563;469.751031953062;476.4615983938128;477.57018683185413;478.8467690339093;555.9916601250984;12388.132830701854;12948.676283092904;12987.545435909698;12988.610341689764;13024;11776.646700598996;12221.205621634565;12255.571055013032;12337.753244935051;12346.074044446703;11130.49912753928;11152.442377881074;11464.541418343257;11519.654410367702;11634.30194188343;4003.679705623543;4027.8791636250958;4053.371727382231;4095.6723462123255;4116.011203698611;64947.35052649507;65187;65327.673361633366;65660.67169664169;65787.3421265786;9200.493972831558;9312.953435232916;9420.90579094214;9473.242140628734;9480.099390557885;17846.821531784517;18219;18351;18359.17383717736;18472;6164.907526387108;6183;6284.780032698834;6385.425311721968;6475.32009139043;3494.6236559139948;3502.5796904371637;3512.5609298837644;3543.557055368079;3633.3278343506536;2659.6675415573054;2756.8897244110412;2778.4165325281515;2779.847108409057;2780.263230243987;488.14087206516785;490.53399270692984;491.6558409113635;493.45966167047027;500.9874753131201;456.2380824023888;497.6864575317527;519.187471606934;525.6294312509672;535.3522238091953;7397.482176247611;7593.506422082547;7617.847643047108;7779;7840.923719834131;438.7893810970752;470.1372980580604;480.5050797678397;513.473689468298;527.4909712127738;3517.2086280586664;3520.436730123168;3640.9817950910074;3709.647583479565;3770.6040865709256;27570.5864412034;94544.52727736317;101785.49107254416;103231.4838425803;103320.48339758403;87858.56070719734;88312;89432.5528372354;89715.55142224378;92379.53810230906;62701.05948410778;63305.68347158235;74868.62565687245;79267.60366198132;83453.58273208595;7766.883496747666;8257.21556452136;8340.499570025819;8377.45546539473;8404.537750423786;30539.847300763355;38168.61831381762;42218;42550;45768.31347529723;34913;52515;52913.47086529085;55403.44596554144;60514.39485605264;10356.430396328275;10366.481675916324;10569;10576.206784491347;10988.450577471254;11659.358735269641;11734.11994100463;11894.226875253082;11931.224470409743;11969;10906.672799816019;10980.341179529254;11139.554417823196;11227;11841.940790296338;9241.399309044891;10020.398776073458;10485.52815123306;11072.944635276772;11088;10055.949720251352;10107.7473063174;10263.12763415118;10390.168786496912;10483.685489435024;9085.22775564058;9438.799452679888;9541.666041688508;9839.40963542161;9855.11303982645;9542.236621070158;9740.951295243478;9741.756456088655;9775.169110625677;9828.901710982798 21:58:45 INFO - PROCESS | 15314 | __end_tp_report 21:58:45 INFO - PROCESS | 15314 | __start_cc_report 21:58:45 INFO - PROCESS | 15314 | _x_x_mozilla_cycle_collect,774 21:58:45 INFO - PROCESS | 15314 | __end_cc_report 21:58:45 INFO - PROCESS | 15314 | __startTimestamp1474347525021__endTimestamp 21:58:45 INFO - PROCESS | 15314 | 21:58:45 INFO - PROCESS | 15314 | ------- Summary: start ------- 21:58:45 INFO - PROCESS | 15314 | Number of tests: 6 21:58:45 INFO - PROCESS | 15314 | 21:58:45 INFO - PROCESS | 15314 | [#0] dojo.html Cycles:165 Average:4605.18 Median:4721.72 stddev:469.86 (10.0%) stddev-sans-first:443.33 21:58:45 INFO - PROCESS | 15314 | Values: 2569.5 2595.8 2624.0 2630.1 2646.4 4499.0 4573.2 4686.0 4721.7 4730.0 4587.9 4622.6 4649.7 4691.6 4738.0 4290.1 4292.2 4330.5 4336.0 4403.8 4347.0 4366.1 4383.6 4397.2 4442.1 4205.7 4252.7 4400.6 4407.7 4409.9 4280.1 4281.1 4308.0 4308.7 4311.5 4284.4 4298.4 4364.7 4376.2 4382.2 4596.2 4657.5 4671.9 4699.8 4743.8 4858.4 5002.2 5023.8 5027.4 5092.9 4935.7 4971.7 5035.5 5041.1 5115.3 4685.4 4687.5 4689.2 4737.3 4745.5 5134.1 5137.3 5138.0 5140.1 5184.2 4742.1 4760.7 4894.5 4912.6 4978.5 4977.7 4980.9 4989.7 5025.1 5034.8 4804.6 4847.4 4850.9 4908.3 4918.2 4707.8 4748.5 4829.4 4837.4 4897.5 4114.9 4203.2 4217.4 4220.5 4273.2 3693.8 3695.7 3697.4 3732.6 3746.3 4167.7 4323.2 4326.8 4328.7 4374.9 4878.0 4935.1 4939.9 4940.0 4994.1 4296.0 4306.7 4307.2 4319.2 4354.9 4478.1 4486.5 4487.5 4538.2 4538.9 4582.8 4636.9 4665.2 4704.6 4714.5 4895.4 4947.9 4960.7 4970.0 5023.9 4645.9 4647.9 4654.5 4656.6 4720.1 4801.9 4872.5 4878.5 4880.2 4937.6 4887.7 4890.5 4922.5 4943.5 5001.2 4795.2 4805.6 4808.8 4813.8 4883.3 4803.7 4812.0 4822.5 4824.2 4889.8 4634.2 4688.5 4737.5 4796.9 4815.2 4900.3 4912.4 4913.2 4914.9 4976.9 4880.6 4884.8 4886.2 4927.8 4942.8 21:58:45 INFO - PROCESS | 15314 | 21:58:45 INFO - PROCESS | 15314 | [#1] ext.html Cycles:180 Average:43025.09 Median:34169.24 stddev:79038.57 (231.3%) stddev-sans-first:79195.89 21:58:45 INFO - PROCESS | 15314 | Values: 525.5 557.7 562.2 573.8 576.4 27503.0 30232.5 30321.8 30342.7 37234.1 35310.1 38569.4 38619.0 38731.4 38751.2 7570.5 7704.9 7711.7 7714.2 7717.1 7519.1 7537.8 7615.1 7617.1 7619.5 7564.1 7599.4 7607.2 7610.2 7615.4 7595.5 7618.7 7621.7 7631.2 7634.4 7543.6 7604.1 7608.2 7610.7 7620.0 36634.8 36863.1 37064.8 37083.8 37092.3 2868.6 2898.8 2943.5 3022.4 3032.7 25982.2 27343.2 27480.5 27514.4 29073.3 3004.2 3069.9 3108.9 3130.5 3162.6 242041.0 242099.0 242575.0 243076.0 244800.0 27287.0 27862.9 49249.3 49515.8 49587.0 30903.2 31650.4 31663.7 31677.4 31694.8 13129.5 13235.1 13246.3 13246.6 13258.1 10501.1 10511.3 10514.3 10522.4 10523.5 7489.0 7557.5 7576.0 7582.7 7600.4 2979.5 3016.6 3043.9 3055.9 3085.4 808.3 819.5 825.8 869.0 911.1 22842.3 23129.2 23213.7 23427.3 23878.3 703.3 840.4 856.2 859.2 864.0 12638.4 13209.7 13297.8 13416.4 13465.9 361540.0 362272.0 364174.0 365283.0 365615.0 47254.8 47735.0 47823.8 47889.3 47924.8 1074.8 1080.4 1124.9 1128.2 1131.0 24864.4 28402.1 28427.3 28566.6 29105.6 39370.0 39884.6 39905.6 39924.2 39959.0 278878.0 279351.0 279574.0 279683.0 281792.0 23909.0 24031.2 24435.4 24707.3 25373.2 39219.8 39608.0 39797.4 39820.6 40323.6 33760.0 33989.7 34113.1 34196.8 34202.7 33999.8 34347.0 34516.7 34748.1 35422.0 34141.7 34369.5 34425.3 34630.3 35273.1 29425.4 30933.5 31140.5 31205.7 31439.0 24051.8 24386.8 24527.1 24911.1 24966.0 21:58:45 INFO - PROCESS | 15314 | 21:58:45 INFO - PROCESS | 15314 | [#2] jquery.html Cycles:180 Average:23060.21 Median:4476.29 stddev:62390.34 (1393.8%) stddev-sans-first:62542.02 21:58:45 INFO - PROCESS | 15314 | Values: 333.4 355.6 361.3 364.2 389.6 12237.3 13238.3 15472.3 15683.7 16453.7 12510.7 12620.3 12660.9 13138.4 14890.3 4953.1 5152.9 5154.3 5155.6 5160.5 4872.7 5013.1 5041.5 5070.3 5086.5 5041.2 5041.6 5045.8 5047.4 5053.1 4885.3 4910.6 4962.9 4987.2 5020.1 4475.0 4477.6 4480.3 4482.6 4482.7 16265.8 17835.8 17976.2 18751.1 18763.9 1731.3 1790.8 1845.7 1872.7 2027.9 8943.0 8980.7 9137.7 9279.7 9417.6 1678.7 1733.3 1736.8 1742.6 1774.3 65035.0 67376.7 67415.3 68049.7 69981.0 9837.5 9857.4 9883.6 10155.0 10279.5 13678.2 13681.5 13707.1 13710.1 13716.6 6872.9 7215.2 7246.1 7406.9 7415.4 6527.3 6531.2 6538.2 6702.0 6843.2 4206.5 4250.3 4263.4 4355.5 4422.2 1776.3 1797.1 1803.9 1815.0 1851.8 670.2 670.2 697.1 712.2 727.5 14093.9 14351.6 14410.5 14967.0 14994.5 717.2 740.2 752.7 760.4 793.3 7702.2 8032.0 8292.7 8393.8 8434.1 368934.0 373458.0 381489.0 382640.0 382949.0 70042.6 72904.6 74533.3 75433.0 75556.2 929.2 930.1 969.3 971.8 972.9 14382.7 14491.3 14595.6 14646.3 15179.8 25558.7 27549.6 35418.6 37385.8 37482.0 40972.0 42282.8 47353.5 48411.8 49309.5 5162.6 6586.6 6730.7 7361.4 7389.2 9980.4 11656.1 11713.7 11779.7 12344.4 9899.5 10017.7 10207.6 10391.1 10410.1 10126.4 10220.2 10273.4 10513.9 10543.9 9908.8 10211.7 10241.2 10582.3 10630.4 6834.9 6923.9 6931.6 6949.7 6990.9 7934.6 10175.2 10378.3 10451.7 10483.4 21:58:45 INFO - PROCESS | 15314 | 21:58:45 INFO - PROCESS | 15314 | [#3] mootools.html Cycles:180 Average:5047.60 Median:4819.05 stddev:2854.75 (59.2%) stddev-sans-first:2848.25 21:58:45 INFO - PROCESS | 15314 | Values: 1218.2 1336.5 1363.6 1401.9 1674.0 6728.9 7505.4 7547.4 7626.8 7800.1 7615.8 7682.1 7692.4 7693.4 7696.1 2135.2 2160.5 2161.5 2164.9 2167.3 2087.5 2116.4 2158.4 2160.6 2169.7 2059.9 2096.9 2101.7 2113.0 2142.1 2092.5 2098.2 2099.6 2102.2 2102.4 2019.0 2096.4 2097.9 2098.1 2099.7 7636.6 7688.8 7810.3 7935.4 7943.9 4496.9 4660.6 4666.6 4709.8 4711.9 2821.7 2984.2 3031.9 3032.1 3034.1 974.3 975.2 986.3 993.7 1008.3 10536.5 10548.2 10592.6 10601.8 10619.4 3981.6 4014.2 4106.8 4140.9 4160.7 8334.9 8337.3 8343.6 8346.7 8347.4 4574.3 4581.5 4584.4 4585.3 4585.9 3563.8 3711.9 3849.8 4290.1 4291.5 3157.8 3542.7 3572.3 3593.0 3606.0 1021.5 1053.2 1055.4 1056.1 1068.5 625.0 706.0 737.1 761.6 762.7 4926.2 4963.9 5020.6 5097.9 5140.1 399.4 423.6 424.7 425.2 429.8 3598.7 3656.7 3659.2 3692.4 3857.1 8941.9 9262.8 9561.8 9567.6 9573.0 8873.3 9164.4 9251.7 9516.5 9518.8 7072.3 7182.7 7279.7 7285.9 7287.9 5089.0 5307.3 5310.8 5314.4 5504.7 8621.4 8706.5 8793.3 8873.4 8875.4 8900.0 8976.3 8980.1 9051.9 9057.2 7319.3 7358.3 7364.7 7370.4 7383.3 7251.0 7450.0 7501.5 7525.9 7583.5 6535.4 6602.1 6623.5 6625.0 6701.1 6811.5 6871.3 6887.4 6891.5 6901.9 6033.6 6103.1 6118.0 6121.4 6121.9 4334.7 4338.4 4442.1 4451.6 4509.0 4368.7 4435.5 4500.9 4557.5 4619.1 21:58:45 INFO - PROCESS | 15314 | 21:58:45 INFO - PROCESS | 15314 | [#4] prototype.html Cycles:180 Average:4055.74 Median:4583.22 stddev:1191.77 (26.0%) stddev-sans-first:1161.19 21:58:45 INFO - PROCESS | 15314 | Values: 294.2 296.1 302.1 305.3 306.0 4696.4 4730.5 4743.7 4749.9 4767.0 4658.0 4679.9 4685.5 4705.5 4709.5 3792.1 3812.9 3823.8 3825.7 3840.2 3465.7 3822.4 3834.8 3837.4 3840.7 3650.3 3654.0 3660.7 3676.6 3680.2 3617.4 3633.1 3639.9 3651.3 3693.5 3055.6 3122.3 3132.2 3254.0 3257.5 4521.8 4563.9 4574.6 4578.9 4592.6 4192.4 4196.5 4200.2 4203.4 4205.3 4605.7 4678.4 4791.2 4931.3 4953.4 3492.9 3495.2 3511.2 3527.7 3535.9 5139.6 5168.7 5185.5 5186.5 5192.0 3435.5 3636.8 3638.5 3640.1 3646.4 3662.0 3666.2 3674.9 3681.3 3685.0 4136.7 4138.0 4182.7 4193.5 4201.1 4877.4 4930.2 4939.6 4969.2 4974.4 1243.3 1259.9 1262.0 1274.6 1275.9 795.4 804.2 822.2 827.0 836.6 3891.0 3922.6 3939.0 3942.9 4004.5 4476.6 4495.7 4500.7 4540.2 4549.8 3935.2 3937.6 3963.8 3978.9 3990.4 2340.3 2349.2 2386.3 2395.3 2435.4 4257.0 4270.5 4587.6 4647.9 4718.2 5164.6 5176.9 5198.8 5214.9 5222.2 4802.4 4817.9 4820.3 4827.0 4827.5 4949.7 5021.0 5036.9 5104.6 5105.2 4902.7 4996.5 5005.8 5006.2 5033.4 4760.4 4811.7 4826.9 4850.0 4857.8 3410.7 3633.7 3642.3 3652.8 3679.6 5072.3 5076.4 5090.4 5097.8 5099.7 4937.5 4954.9 4965.9 4974.2 5013.7 4740.0 4940.7 4946.4 4979.6 5014.2 4870.1 4873.4 4880.3 4881.0 4885.2 4994.9 5019.7 5024.4 5053.8 5064.8 4666.3 4895.7 4906.2 4924.7 4932.6 21:58:45 INFO - PROCESS | 15314 | 21:58:45 INFO - PROCESS | 15314 | [#5] yui.html Cycles:180 Average:16933.56 Median:479.68 stddev:24851.12 (5180.8%) stddev-sans-first:24890.66 21:58:45 INFO - PROCESS | 15314 | Values: 622.3 633.6 642.8 647.8 722.4 12040.0 13175.3 13422.3 13533.7 13700.9 12139.4 12170.1 12176.8 12184.5 12189.3 723.6 753.1 758.1 759.4 761.6 597.5 614.7 744.6 768.4 771.8 790.2 793.4 795.0 795.2 795.6 787.3 790.5 791.4 791.5 791.7 469.8 476.5 477.6 478.8 556.0 12388.1 12948.7 12987.5 12988.6 13024.0 11776.6 12221.2 12255.6 12337.8 12346.1 11130.5 11152.4 11464.5 11519.7 11634.3 4003.7 4027.9 4053.4 4095.7 4116.0 64947.4 65187.0 65327.7 65660.7 65787.3 9200.5 9313.0 9420.9 9473.2 9480.1 17846.8 18219.0 18351.0 18359.2 18472.0 6164.9 6183.0 6284.8 6385.4 6475.3 3494.6 3502.6 3512.6 3543.6 3633.3 2659.7 2756.9 2778.4 2779.8 2780.3 488.1 490.5 491.7 493.5 501.0 456.2 497.7 519.2 525.6 535.4 7397.5 7593.5 7617.8 7779.0 7840.9 438.8 470.1 480.5 513.5 527.5 3517.2 3520.4 3641.0 3709.6 3770.6 27570.6 94544.5 101785.5 103231.5 103320.5 87858.6 88312.0 89432.6 89715.6 92379.5 62701.1 63305.7 74868.6 79267.6 83453.6 7766.9 8257.2 8340.5 8377.5 8404.5 30539.8 38168.6 42218.0 42550.0 45768.3 34913.0 52515.0 52913.5 55403.4 60514.4 10356.4 10366.5 10569.0 10576.2 10988.5 11659.4 11734.1 11894.2 11931.2 11969.0 10906.7 10980.3 11139.6 11227.0 11841.9 9241.4 10020.4 10485.5 11072.9 11088.0 10055.9 10107.7 10263.1 10390.2 10483.7 9085.2 9438.8 9541.7 9839.4 9855.1 9542.2 9741.0 9741.8 9775.2 9828.9 21:58:45 INFO - PROCESS | 15314 | -------- Summary: end -------- 21:58:45 INFO - PROCESS | 15314 | 21:58:46 INFO - TEST-INFO | 15314: exit 0 21:58:46 INFO - TEST-OK | dromaeo_css | took 1120266ms 21:58:46 INFO - TEST-START | kraken 21:58:46 INFO - operating with platform_type : linux_ 21:58:46 INFO - Initialising browser for kraken test... 21:58:46 INFO - TEST-INFO | started process 15619 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkL9LD4/profile http://localhost:46085/getInfo.html) 21:58:50 INFO - PROCESS | 15619 | __metrics Screen width/height:1600/1200 21:58:50 INFO - PROCESS | 15619 | colorDepth:24 21:58:50 INFO - PROCESS | 15619 | Browser inner width/height: 1024/697 21:58:50 INFO - PROCESS | 15619 | __metrics 21:58:51 INFO - PROCESS | 15619 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:58:51 INFO - PROCESS | 15619 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:58:51 INFO - PROCESS | 15619 | console.error: PushService: 21:58:51 INFO - PROCESS | 15619 | stateChangeProcessEnqueue: Error transitioning state 21:58:51 INFO - PROCESS | 15619 | UnknownError 21:58:52 INFO - TEST-INFO | 15619: exit 0 21:58:52 INFO - Browser initialized. 21:58:52 INFO - Running cycle 1/1 for kraken test... 21:58:52 INFO - TEST-INFO | started process 15699 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkL9LD4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:59:04 INFO - PROCESS | 15699 | RSS: Main: 174764032 21:59:04 INFO - PROCESS | 15699 | 21:59:07 INFO - PROCESS | 15699 | Cycle 1(1): loaded http://localhost:46085/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46085/tests/kraken/driver.html?testName=audio-beat-detection) 21:59:08 INFO - PROCESS | 15699 | RSS: Main: 242118656 21:59:08 INFO - PROCESS | 15699 | 21:59:11 INFO - PROCESS | 15699 | Cycle 1(1): loaded http://localhost:46085/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46085/tests/kraken/driver.html?testName=audio-dft) 21:59:11 INFO - PROCESS | 15699 | RSS: Main: 218570752 21:59:11 INFO - PROCESS | 15699 | 21:59:15 INFO - PROCESS | 15699 | Cycle 1(1): loaded http://localhost:46085/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46085/tests/kraken/driver.html?testName=audio-fft) 21:59:15 INFO - PROCESS | 15699 | RSS: Main: 300277760 21:59:15 INFO - PROCESS | 15699 | 21:59:17 INFO - PROCESS | 15699 | Cycle 1(1): loaded http://localhost:46085/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46085/tests/kraken/driver.html?testName=audio-oscillator) 21:59:18 INFO - PROCESS | 15699 | RSS: Main: 210141184 21:59:18 INFO - PROCESS | 15699 | 21:59:20 INFO - PROCESS | 15699 | Cycle 1(1): loaded http://localhost:46085/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46085/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:59:21 INFO - PROCESS | 15699 | RSS: Main: 213979136 21:59:21 INFO - PROCESS | 15699 | 21:59:24 INFO - PROCESS | 15699 | Cycle 1(1): loaded http://localhost:46085/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46085/tests/kraken/driver.html?testName=imaging-darkroom) 21:59:25 INFO - PROCESS | 15699 | RSS: Main: 250322944 21:59:25 INFO - PROCESS | 15699 | 21:59:28 INFO - PROCESS | 15699 | Cycle 1(1): loaded http://localhost:46085/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46085/tests/kraken/driver.html?testName=imaging-desaturate) 21:59:29 INFO - PROCESS | 15699 | RSS: Main: 244752384 21:59:29 INFO - PROCESS | 15699 | 21:59:32 INFO - PROCESS | 15699 | Cycle 1(1): loaded http://localhost:46085/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46085/tests/kraken/driver.html?testName=json-parse-financial) 21:59:32 INFO - PROCESS | 15699 | RSS: Main: 247046144 21:59:32 INFO - PROCESS | 15699 | 21:59:34 INFO - PROCESS | 15699 | Cycle 1(1): loaded http://localhost:46085/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46085/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:59:35 INFO - PROCESS | 15699 | RSS: Main: 210837504 21:59:35 INFO - PROCESS | 15699 | 21:59:36 INFO - PROCESS | 15699 | Cycle 1(1): loaded http://localhost:46085/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46085/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:59:37 INFO - PROCESS | 15699 | RSS: Main: 218185728 21:59:37 INFO - PROCESS | 15699 | 21:59:39 INFO - PROCESS | 15699 | Cycle 1(1): loaded http://localhost:46085/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46085/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:59:40 INFO - PROCESS | 15699 | RSS: Main: 222011392 21:59:40 INFO - PROCESS | 15699 | 21:59:43 INFO - PROCESS | 15699 | Cycle 1(1): loaded http://localhost:46085/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46085/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:59:43 INFO - PROCESS | 15699 | RSS: Main: 223318016 21:59:43 INFO - PROCESS | 15699 | 21:59:46 INFO - PROCESS | 15699 | Cycle 1(1): loaded http://localhost:46085/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46085/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:59:47 INFO - PROCESS | 15699 | RSS: Main: 220860416 21:59:47 INFO - PROCESS | 15699 | 21:59:49 INFO - PROCESS | 15699 | Cycle 1(1): loaded http://localhost:46085/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46085/tests/kraken/driver.html?testName=ai-astar) 21:59:49 INFO - PROCESS | 15699 | RSS: Main: 272670720 21:59:49 INFO - PROCESS | 15699 | 21:59:49 INFO - PROCESS | 15699 | __start_tp_report 21:59:49 INFO - PROCESS | 15699 | _x_x_mozilla_page_load 21:59:49 INFO - PROCESS | 15699 | _x_x_mozilla_page_load_details 21:59:49 INFO - PROCESS | 15699 | |i|pagename|runs| 21:59:49 INFO - PROCESS | 15699 | |0;ai-astar;114;118;116;119;116;117;116;116;116;116 21:59:49 INFO - PROCESS | 15699 | |1;audio-beat-detection;155;127;125;163;130;127;134;122;174;125 21:59:49 INFO - PROCESS | 15699 | |2;audio-dft;165;165;163;163;162;162;162;161;161;161 21:59:49 INFO - PROCESS | 15699 | |3;audio-fft;76;84;77;117;76;78;78;78;109;76 21:59:49 INFO - PROCESS | 15699 | |4;audio-oscillator;84;84;117;84;85;84;105;84;83;118 21:59:49 INFO - PROCESS | 15699 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;116;118 21:59:49 INFO - PROCESS | 15699 | |6;imaging-darkroom;147;147;146;147;147;147;146;147;146;148 21:59:49 INFO - PROCESS | 15699 | |7;imaging-desaturate;95;95;95;95;96;96;95;95;94;95 21:59:49 INFO - PROCESS | 15699 | |8;json-parse-financial;72;64;64;63;64;64;65;64;64;64 21:59:49 INFO - PROCESS | 15699 | |9;json-stringify-tinderbox;67;66;65;66;67;66;66;65;66;65 21:59:49 INFO - PROCESS | 15699 | |10;stanford-crypto-aes;83;83;82;83;89;85;89;83;83;83 21:59:49 INFO - PROCESS | 15699 | |11;stanford-crypto-ccm;137;132;134;133;132;135;143;134;172;141 21:59:49 INFO - PROCESS | 15699 | |12;stanford-crypto-pbkdf2;177;175;174;175;172;171;183;174;176;171 21:59:49 INFO - PROCESS | 15699 | |13;stanford-crypto-sha256-iterative;72;70;69;69;69;69;70;68;70;71 21:59:49 INFO - PROCESS | 15699 | __end_tp_report 21:59:49 INFO - PROCESS | 15699 | __start_cc_report 21:59:49 INFO - PROCESS | 15699 | _x_x_mozilla_cycle_collect,1932 21:59:49 INFO - PROCESS | 15699 | __end_cc_report 21:59:49 INFO - PROCESS | 15699 | __startTimestamp1474347589570__endTimestamp 21:59:49 INFO - PROCESS | 15699 | 21:59:49 INFO - PROCESS | 15699 | ------- Summary: start ------- 21:59:49 INFO - PROCESS | 15699 | Number of tests: 14 21:59:49 INFO - PROCESS | 15699 | 21:59:49 INFO - PROCESS | 15699 | [#0] ai-astar Cycles:10 Average:116.40 Median:116.00 stddev:1.35 (1.2%) stddev-sans-first:1.12 21:59:49 INFO - PROCESS | 15699 | Values: 114.0 118.0 116.0 119.0 116.0 117.0 116.0 116.0 116.0 116.0 21:59:49 INFO - PROCESS | 15699 | 21:59:49 INFO - PROCESS | 15699 | [#1] audio-beat-detection Cycles:10 Average:138.20 Median:132.00 stddev:18.64 (14.1%) stddev-sans-first:18.75 21:59:49 INFO - PROCESS | 15699 | Values: 155.0 127.0 125.0 163.0 130.0 127.0 134.0 122.0 174.0 125.0 21:59:49 INFO - PROCESS | 15699 | 21:59:49 INFO - PROCESS | 15699 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:1.51 (0.9%) stddev-sans-first:1.30 21:59:49 INFO - PROCESS | 15699 | Values: 165.0 165.0 163.0 163.0 162.0 162.0 162.0 161.0 161.0 161.0 21:59:49 INFO - PROCESS | 15699 | 21:59:49 INFO - PROCESS | 15699 | [#3] audio-fft Cycles:10 Average:84.90 Median:77.50 stddev:15.11 (19.5%) stddev-sans-first:15.68 21:59:49 INFO - PROCESS | 15699 | Values: 76.0 84.0 77.0 117.0 76.0 78.0 78.0 78.0 109.0 76.0 21:59:49 INFO - PROCESS | 15699 | 21:59:49 INFO - PROCESS | 15699 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:84.00 stddev:14.58 (17.4%) stddev-sans-first:15.11 21:59:49 INFO - PROCESS | 15699 | Values: 84.0 84.0 117.0 84.0 85.0 84.0 105.0 84.0 83.0 118.0 21:59:49 INFO - PROCESS | 15699 | 21:59:49 INFO - PROCESS | 15699 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 21:59:49 INFO - PROCESS | 15699 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 116.0 118.0 21:59:49 INFO - PROCESS | 15699 | 21:59:49 INFO - PROCESS | 15699 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 21:59:49 INFO - PROCESS | 15699 | Values: 147.0 147.0 146.0 147.0 147.0 147.0 146.0 147.0 146.0 148.0 21:59:49 INFO - PROCESS | 15699 | 21:59:49 INFO - PROCESS | 15699 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 21:59:49 INFO - PROCESS | 15699 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 94.0 95.0 21:59:49 INFO - PROCESS | 15699 | 21:59:49 INFO - PROCESS | 15699 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:64.00 stddev:2.57 (4.0%) stddev-sans-first:0.50 21:59:49 INFO - PROCESS | 15699 | Values: 72.0 64.0 64.0 63.0 64.0 64.0 65.0 64.0 64.0 64.0 21:59:49 INFO - PROCESS | 15699 | 21:59:49 INFO - PROCESS | 15699 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 21:59:49 INFO - PROCESS | 15699 | Values: 67.0 66.0 65.0 66.0 67.0 66.0 66.0 65.0 66.0 65.0 21:59:49 INFO - PROCESS | 15699 | 21:59:49 INFO - PROCESS | 15699 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.00 stddev:2.58 (3.1%) stddev-sans-first:2.70 21:59:49 INFO - PROCESS | 15699 | Values: 83.0 83.0 82.0 83.0 89.0 85.0 89.0 83.0 83.0 83.0 21:59:49 INFO - PROCESS | 15699 | 21:59:49 INFO - PROCESS | 15699 | [#11] stanford-crypto-ccm Cycles:10 Average:139.30 Median:136.00 stddev:12.07 (8.9%) stddev-sans-first:12.78 21:59:49 INFO - PROCESS | 15699 | Values: 137.0 132.0 134.0 133.0 132.0 135.0 143.0 134.0 172.0 141.0 21:59:49 INFO - PROCESS | 15699 | 21:59:49 INFO - PROCESS | 15699 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:175.00 stddev:3.52 (2.0%) stddev-sans-first:3.64 21:59:49 INFO - PROCESS | 15699 | Values: 177.0 175.0 174.0 175.0 172.0 171.0 183.0 174.0 176.0 171.0 21:59:49 INFO - PROCESS | 15699 | 21:59:49 INFO - PROCESS | 15699 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:1.16 (1.7%) stddev-sans-first:0.88 21:59:49 INFO - PROCESS | 15699 | Values: 72.0 70.0 69.0 69.0 69.0 69.0 70.0 68.0 70.0 71.0 21:59:49 INFO - PROCESS | 15699 | -------- Summary: end -------- 21:59:49 INFO - PROCESS | 15699 | 21:59:50 INFO - TEST-INFO | 15699: exit 0 21:59:50 INFO - TEST-OK | kraken | took 64830ms 21:59:50 INFO - SUITE-END | took 1185s 21:59:51 INFO - Completed test suite (00:19:45) 21:59:51 INFO - javascript benchmark 21:59:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2569.486102779444, 2595.8312709673883, 2624.0, 2630.0926180467745, 2646.40455897423, 4499.032707967786, 4573.153966516197, 4686.0, 4721.716696998183, 4729.952700472994, 4587.8623641290815, 4622.583967442921, 4649.69776964497, 4691.577758001779, 4737.952620473794, 4290.056187638715, 4292.1630282095, 4330.523642399334, 4336.0, 4403.845865394712, 4347.043650396908, 4366.0831225442535, 4383.583559561836, 4397.230484665187, 4442.11157768446, 4205.684573656988, 4252.702310838243, 4400.581944715247, 4407.6914615976575, 4409.933850992237, 4280.058387154821, 4281.079567892918, 4308.030693094061, 4308.719933204332, 4311.547287534795, 4284.4430224070675, 4298.4197133387215, 4364.694471387004, 4376.190404775127, 4382.189294980439, 4596.241620132674, 4657.464391594942, 4671.929921051187, 4699.765011749399, 4743.810247590127, 4858.441279252896, 5002.1746411842005, 5023.8492845214705, 5027.371578552681, 5092.898142037176, 4935.6545041847085, 4971.701697898102, 5035.54680078791, 5041.092603331399, 5115.335006449175, 4685.390899183084, 4687.484376718558, 4689.155951928686, 4737.28940658904, 4745.525447455261, 5134.101532231844, 5137.255098010843, 5138.0, 5140.126178549655, 5184.248283998799, 4742.146413645508, 4760.666753327303, 4894.461609222983, 4912.631552633567, 4978.5270399312, 4977.65156439053, 4980.875478113004, 4989.725565093955, 5025.120603894304, 5034.798608055637, 4804.591609713144, 4847.3698419205275, 4850.927236091461, 4908.263760435963, 4918.188498897642, 4707.811687532529, 4748.453927798348, 4829.444613869379, 4837.395325584302, 4897.510248975074, 4114.917701645951, 4203.159368126387, 4217.388478670576, 4220.493540775126, 4273.166732487197, 3693.8337774800198, 3695.6858667013066, 3697.445383192489, 3732.570754363229, 3746.2882052409955, 4167.74993500391, 4323.200207961537, 4326.848560300375, 4328.653707703376, 4374.8906277342685, 4878.0, 4935.136351138536, 4939.925901111486, 4940.011997600494, 4994.126027945168, 4296.033392486665, 4306.655467562588, 4307.181635489247, 4319.2009478246, 4354.869353919387, 4478.081993191388, 4486.528914463999, 4487.528809475023, 4538.205813982539, 4538.909221815546, 4582.793774280232, 4636.86089417318, 4665.2302370108555, 4704.600108990706, 4714.528547145395, 4895.388076490439, 4947.876303092307, 4960.727160006234, 4969.950300496948, 5023.899522009467, 4645.907081858411, 4647.907041859212, 4654.464736555339, 4656.627469802475, 4720.079584480994, 4801.927971080367, 4872.512748725099, 4878.487758785276, 4880.194767863263, 4937.604991600735, 4887.657863949489, 4890.510948905081, 4922.4585295616735, 4943.456219815889, 5001.224810154432, 4795.18481858078, 4805.5915247204375, 4808.783604737725, 4813.78337974785, 4883.267509873547, 4803.687760295569, 4812.0, 4822.493638168082, 4824.228123500223, 4889.828855990023, 4634.2121839288075, 4688.507706690748, 4737.502562231054, 4796.904061918673, 4815.15734746425, 4900.26496025599, 4912.435069966857, 4913.189323761682, 4914.926276105933, 4976.850694479172, 4880.560749532559, 4884.8290309838985, 4886.169351210232, 4927.802887884588, 4942.827001054946], "value": 4575.839793497619, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [525.5165247971865, 557.6514678326046, 562.2269379603046, 573.796302312679, 576.4293349583913, 27503.0, 30232.546511802342, 30321.84839075804, 30342.696573034264, 37234.06914827131, 35310.11724706883, 38569.421458678145, 38619.0, 38731.419028714525, 38751.224975500474, 7570.470067095292, 7704.8844267336035, 7711.691532338699, 7714.228577142297, 7717.112532058801, 7519.135299440552, 7537.831636096414, 7615.124260710034, 7617.124030736453, 7619.504732192418, 7564.054493188351, 7599.392048636123, 7607.16321204667, 7610.1628820829665, 7615.428842836782, 7595.544267343949, 7618.657160427739, 7621.733239336597, 7631.1605723370385, 7634.434940837115, 7543.585102819343, 7604.0875094988405, 7608.212070163507, 7610.733624323122, 7620.0, 36634.8168259157, 36863.07842303964, 37064.81467592645, 37083.84787293083, 37092.25815483675, 2868.584055311968, 2898.826070435781, 2943.5290353543546, 3022.350194708148, 3032.6967303269716, 25982.22053338384, 27343.179704608894, 27480.450390992068, 27514.44971100567, 29073.273168170752, 3004.248937765559, 3069.938601227985, 3108.8911888084035, 3130.5304204369527, 3162.6362968258486, 242041.0, 242099.0, 242575.0, 243076.0, 244800.0, 27287.0, 27862.860685696443, 49249.26126108111, 49515.75242123767, 49587.0, 30903.227419314248, 31650.36699266002, 31663.683363166074, 31677.366452670816, 31694.841525792224, 13129.540466083641, 13235.139715918434, 13246.271455070064, 13246.602601921957, 13258.07193496446, 10501.107405870434, 10511.316764410441, 10514.316569423116, 10522.421266830397, 10523.52644131016, 7488.9625551871895, 7557.470977031665, 7575.962120189364, 7582.696692132253, 7600.353969912509, 2979.508381117135, 3016.638003439601, 3043.8782448702245, 3055.8624861881267, 3085.41377138343, 808.3088958940139, 819.5328662662225, 825.8018075661918, 868.9826203476022, 911.0889110889111, 22842.31473055811, 23129.190478333516, 23213.651795223086, 23427.297181084596, 23878.283651490136, 703.2861645429892, 840.3907167303656, 856.2251162697644, 859.1709000814119, 863.9827203455895, 12638.431270592846, 13209.669758256121, 13297.800532992012, 13416.396262168226, 13465.865341346656, 361540.0, 362272.0, 364174.0, 365283.0, 365615.0, 47254.76372618115, 47735.0, 47823.76088119537, 47889.29549863022, 47924.7603761979, 1074.8119079161115, 1080.357187473452, 1124.9268797528298, 1128.1707944660668, 1130.9943450282697, 24864.37839054038, 28402.147935561967, 28427.299406556343, 28566.57150142708, 29105.563416549194, 39370.0, 39884.601153988086, 39905.60094399019, 39924.2015159701, 39959.0, 278878.0, 279351.0, 279574.0, 279683.0, 281792.0, 23909.0, 24031.158909438087, 24435.38911527226, 24707.25878223656, 25373.238802835946, 39219.80390098031, 39608.0, 39797.40303895386, 39820.601793982845, 40323.59676403316, 33760.0, 33989.66010339865, 34113.14717132092, 34196.82901585476, 34202.65797341995, 33999.83000085083, 34347.0, 34516.65483345134, 34748.13129671779, 35422.0, 34141.658583413846, 34369.48445773265, 34425.31149377049, 34630.30739385148, 35273.118172045906, 29425.411491769617, 30933.535996960512, 31140.532892006184, 31205.68794312028, 31439.0, 24051.75948240565, 24386.756132438448, 24527.075667893052, 24911.128110516045, 24966.0], "value": 15431.433455548511, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.423177902229, 355.58219092566213, 361.2612208034569, 364.2005797274981, 389.55201518254006, 12237.265764054164, 13238.27189504577, 15472.303746331414, 15683.686326273482, 16453.67092658146, 12510.687232819184, 12620.305883176421, 12660.873391266085, 13138.408771605276, 14890.25548722565, 4953.108440480712, 5152.92270615941, 5154.252633368159, 5155.58755299577, 5160.483951604847, 4872.6832755870755, 5013.122703526887, 5041.495850414947, 5070.264811602316, 5086.491350864921, 5041.193409054552, 5041.59667226621, 5045.772940217699, 5047.369078865142, 5053.115704751672, 4885.340479035321, 4910.607151427877, 4962.87592810179, 4987.177115775893, 5020.0963826511215, 4474.955250447519, 4477.619402350804, 4480.283154695233, 4482.574155455259, 4482.663800214997, 16265.756013659804, 17835.840670356516, 17976.19107140182, 18751.06244687774, 18763.90618046901, 1731.2988239762917, 1790.811964743696, 1845.6770065238663, 1872.691005984011, 2027.8986050697406, 8943.0, 8980.685676001309, 9137.725868223964, 9279.675211367638, 9417.576209070608, 1678.7146185148554, 1733.3153404405189, 1736.7915850097943, 1742.5904912345588, 1774.272548255222, 65035.0, 67376.66311668459, 67415.3258467414, 68049.65975170092, 69981.0, 9837.475191345353, 9857.35927164732, 9883.604655813688, 10155.0, 10279.537420816081, 13678.179309241477, 13681.452741890413, 13707.109037912503, 13710.108842925178, 13716.588502344946, 6872.931270687229, 7215.242399548077, 7246.130464344207, 7406.8888966665545, 7415.443841711894, 6527.34726527353, 6531.248906375733, 6538.248101468392, 6702.0, 6843.213030501456, 4206.4646404062905, 4250.341197114452, 4263.424437700933, 4355.520892701864, 4422.181896349186, 1776.3072401763322, 1797.1373740604583, 1803.8827476214003, 1814.963700725978, 1851.7500137481536, 670.1790306874137, 670.215847458465, 697.0722963553097, 712.2148300710791, 727.5489196698081, 14093.85906140946, 14351.64120896965, 14410.495632652806, 14967.0, 14994.47519336818, 717.1931576975902, 740.1820987808394, 752.6537792615459, 760.422079219797, 793.2741541489472, 7702.152763196044, 8031.9920019995, 8292.668293268202, 8393.790155246168, 8434.114417986146, 368934.0, 373458.0, 381489.0, 382640.0, 382949.0, 70042.64978675176, 72904.63547682228, 74533.25466745372, 75433.0, 75556.24443755602, 929.2333824594737, 930.0885132569985, 969.3214749675255, 971.820213260549, 972.9270304727174, 14382.712345752818, 14491.347889345216, 14595.635109122357, 14646.340914659078, 15179.772303415237, 25558.744412555636, 27549.58675619827, 35418.64581354154, 37385.81307093447, 37482.0, 40972.0, 42282.78858605687, 47353.52646473491, 48411.75794121007, 49309.506904930495, 5162.6386152968935, 6586.571872828251, 6730.6971186297715, 7361.411087113125, 7389.224131466119, 9980.401175929468, 11656.125790565571, 11713.707157321136, 11779.705507362385, 12344.382780860742, 9899.455529945923, 10017.749556261151, 10207.591696332063, 10391.064804167661, 10410.115140212863, 10126.392416455037, 10220.233482488695, 10273.434961077213, 10513.89486105129, 10543.89456105429, 9908.752281193028, 10211.7447063824, 10241.231907607109, 10582.312149710244, 10630.415327157081, 6834.863302733818, 6923.861522769617, 6931.618760967994, 6949.687264073028, 6990.860182796418, 7934.603269836601, 10175.236857235588, 10378.273520853469, 10451.68644940653, 10483.423411712123], "value": 7681.390926985072, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1218.20816469295, 1336.5455745046681, 1363.6113707593336, 1401.880840128589, 1673.983260167398, 6728.86542269155, 7505.437092218085, 7547.396208303343, 7626.847463050735, 7800.1419843817275, 7615.77152685419, 7682.078150621933, 7692.423068269874, 7693.422993275512, 7696.114946781122, 2135.2313167259813, 2160.5246845693923, 2161.5136594266323, 2164.8592841465334, 2167.3497950614833, 2087.499000239947, 2116.354511873878, 2158.3740715192653, 2160.567886422714, 2169.652855543113, 2059.938201853947, 2096.8951552422395, 2101.663733802592, 2112.968305475419, 2142.1003178664996, 2092.466421062627, 2098.213170061227, 2099.5695882344085, 2102.1696429910253, 2102.4113248290505, 2018.9596208075902, 2096.3501314592527, 2097.9055942482623, 2098.076846187688, 2099.653557163066, 7636.579988100652, 7688.846223075507, 7810.297073263377, 7935.444518883681, 7943.920560794434, 4496.910061798746, 4660.580547750718, 4666.580007799281, 4709.764511774431, 4711.882202944919, 2821.6755073166437, 2984.19426754775, 3031.863566139529, 3032.120685001347, 3034.1201051694984, 974.2644303550774, 975.1857199238644, 986.3490096536324, 993.6919554937992, 1008.2790804574691, 10536.525856336406, 10548.20888433363, 10592.576296948113, 10601.787964240671, 10619.41593212373, 3981.646240278319, 4014.1770936957855, 4106.815193316308, 4140.861263152658, 4160.729552579072, 8334.916650833535, 8337.291330236876, 8343.624536895733, 8346.707865224687, 8347.373946954003, 4574.336721175411, 4581.496035436099, 4584.4498660161, 4585.312203169551, 4585.862424127282, 3563.7849248484986, 3711.9072023199637, 3849.8075096245634, 4290.099079193405, 4291.50647675515, 3157.8105313681253, 3542.6811586957297, 3572.2676851245433, 3593.0, 3605.963940360563, 1021.4790456867051, 1053.173258991703, 1055.4142450939803, 1056.1497994114811, 1068.514764477377, 624.950003999679, 705.989410158848, 737.1485933746532, 761.588742079271, 762.6796745366959, 4926.211806111077, 4963.925541116886, 5020.648554601143, 5097.8725531861255, 5140.074786538385, 399.3849471813433, 423.581003637817, 424.67512353049943, 425.1836473969985, 429.8044389802695, 3598.7300952428673, 3656.7074634029213, 3659.1766852457986, 3692.409214525663, 3857.1321452672923, 8941.910580894108, 9262.814743705088, 9561.760955976157, 9567.61729530811, 9573.042695730372, 8873.334499912533, 9164.404313719588, 9251.67619133327, 9516.476593787409, 9518.762030949281, 7072.292770722989, 7182.7486037989465, 7279.745208917662, 7285.854282914312, 7287.927120728831, 5088.974555127201, 5307.336582927134, 5310.840674779763, 5314.362276526842, 5504.724763761876, 8621.353398495012, 8706.521141337034, 8793.252573531321, 8873.378863479495, 8875.378723489293, 8899.955500222457, 8976.326775491994, 8980.146886045815, 9051.90948090537, 9057.18485336323, 7319.304666056716, 7358.337749602348, 7364.66858991336, 7370.410367170721, 7383.2985866342615, 7251.0, 7449.962750186214, 7501.474896757175, 7525.88711169322, 7583.544987300779, 6535.379138981789, 6602.075709400592, 6623.503237257129, 6625.0, 6701.061851340914, 6811.489138314745, 6871.347222013901, 6887.414569761627, 6891.517593768388, 6901.896471553031, 6033.607815492154, 6103.115048318058, 6117.959946809142, 6121.357257488078, 6121.908171377522, 4334.696571240109, 4338.392625032435, 4442.133783912235, 4451.59935605797, 4509.030558429953, 4368.716033457815, 4435.489918659396, 4500.932486012778, 4557.498675145797, 4619.099275641218], "value": 3977.994281844551, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.201243623562, 296.0659120474901, 302.08618927743566, 305.25669993565657, 305.9801112927661, 4696.42669705649, 4730.4559975602815, 4743.7153770773775, 4749.928751068728, 4767.0465906818645, 4657.997061263655, 4679.88300292492, 4685.531446855312, 4705.505921878204, 4709.5055019223, 3792.1467669774356, 3812.90467738306, 3823.7896915669626, 3825.713071519633, 3840.1743625120594, 3465.6534346565395, 3822.3502004659135, 3834.789086600236, 3837.3860182370686, 3840.7119466040017, 3650.3064417760543, 3653.963460365402, 3660.7254455915913, 3676.6212670248656, 3680.1719613086975, 3617.385044542434, 3633.109888077425, 3639.854405823777, 3651.3062518121474, 3693.464447655102, 3055.633324001134, 3122.2818751687014, 3132.201288671374, 3253.9511907321407, 3257.5439438478634, 4521.751303678297, 4563.931541026887, 4574.559013910641, 4578.88552786183, 4592.609628181609, 4192.392103145057, 4196.538380778143, 4200.235900921621, 4203.43253660758, 4205.306124489455, 4605.700629459108, 4678.438587369504, 4791.185498465269, 4931.284963680282, 4953.380827396575, 3492.947605785915, 3495.178633021238, 3511.17487390463, 3527.735419843522, 3535.8939231823088, 5139.61452891031, 5168.715720635363, 5185.507376799198, 5186.507281808223, 5192.039472697563, 3435.484677298425, 3636.7636103653176, 3638.490611314418, 3640.10817349751, 3646.3801153803915, 3662.0, 3666.1934374438115, 3674.926501470009, 3681.337359275356, 3684.9815750921075, 4136.73111247768, 4138.0, 4182.6824550266565, 4193.511303487279, 4201.138766552849, 4877.365942427462, 4930.161872481687, 4939.629527785359, 4969.229769385751, 4974.353334066548, 1243.2913239453426, 1259.9433025513874, 1261.9558315458914, 1274.5539061328645, 1275.8851703346743, 795.3796039089403, 804.1958041958042, 822.2476434062885, 826.9828111422984, 836.6028732017545, 3890.9650472631392, 3922.627350401707, 3938.980305098456, 3942.8817135485983, 4004.4983131325753, 4476.597106260452, 4495.707778994421, 4500.707454015478, 4540.228161212602, 4549.840755573539, 3935.2326296372507, 3937.586553411908, 3963.7514183032254, 3978.8806335809973, 3990.446114486731, 2340.3447034830274, 2349.150354491143, 2386.296042667417, 2395.2694428199566, 2435.403326185096, 4256.977935480622, 4270.487541494978, 4587.564181402761, 4647.907041859212, 4718.150732868116, 5164.586833053347, 5176.8964620707375, 5198.766055527511, 5214.869628259324, 5222.216667499905, 4802.375691160127, 4817.927731083966, 4820.3492528508905, 4827.0, 4827.517248275144, 4949.7030178189425, 5020.974895125501, 5036.866704991347, 5104.566111880532, 5105.183170692671, 4902.656814022984, 4996.525330093636, 5005.7997680092385, 5006.199008158677, 5033.370828646419, 4760.428748550196, 4811.687240329367, 4826.855194344175, 4850.0, 4857.8299759508245, 3410.710089642408, 3633.709303255786, 3642.307961487415, 3652.817359132086, 3679.5584529856587, 5072.289879416959, 5076.390833100052, 5090.389153301628, 5097.847064588068, 5099.745012749422, 4937.530934561211, 4954.851354459372, 4965.907500349917, 4974.228994505857, 5013.674111182761, 4739.976300118477, 4940.6788558743565, 4946.406431228275, 4979.576735977337, 5014.247862820606, 4870.147724148189, 4873.439554451142, 4880.341153944172, 4880.95119048805, 4885.169521181479, 4994.926090890476, 5019.698818070781, 5024.422191447884, 5053.823116190915, 5064.848054558369, 4666.253399456206, 4895.7062576245535, 4906.239532872411, 4924.72913989734, 4932.605391568594], "value": 3679.8563680553525, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.2532960447464, 633.5565104426901, 642.7589653879795, 647.8445173158442, 722.3534936232072, 12040.0, 13175.275359855204, 13422.261775602337, 13533.729325413486, 13700.862991370082, 12139.393030348492, 12170.148089633729, 12176.75646487072, 12184.451699673515, 12189.26864388135, 723.5803234124195, 753.1414187825856, 758.0789340950744, 759.4380158682591, 761.6191904047976, 597.4503456819715, 614.7203022624695, 744.57559191261, 768.4160038370823, 771.7684694591628, 790.182161462886, 793.4485532554877, 795.0062421972534, 795.2286282306154, 795.5942469340649, 787.3268355556003, 790.5335851847437, 791.3906292155009, 791.5171745235431, 791.7466410748563, 469.751031953062, 476.4615983938128, 477.57018683185413, 478.8467690339093, 555.9916601250984, 12388.132830701854, 12948.676283092904, 12987.545435909698, 12988.610341689764, 13024.0, 11776.646700598996, 12221.205621634565, 12255.571055013032, 12337.753244935051, 12346.074044446703, 11130.49912753928, 11152.442377881074, 11464.541418343257, 11519.654410367702, 11634.30194188343, 4003.679705623543, 4027.8791636250958, 4053.371727382231, 4095.6723462123255, 4116.011203698611, 64947.35052649507, 65187.0, 65327.673361633366, 65660.67169664169, 65787.3421265786, 9200.493972831558, 9312.953435232916, 9420.90579094214, 9473.242140628734, 9480.099390557885, 17846.821531784517, 18219.0, 18351.0, 18359.17383717736, 18472.0, 6164.907526387108, 6183.0, 6284.780032698834, 6385.425311721968, 6475.32009139043, 3494.6236559139948, 3502.5796904371637, 3512.5609298837644, 3543.557055368079, 3633.3278343506536, 2659.6675415573054, 2756.8897244110412, 2778.4165325281515, 2779.847108409057, 2780.263230243987, 488.14087206516785, 490.53399270692984, 491.6558409113635, 493.45966167047027, 500.9874753131201, 456.2380824023888, 497.6864575317527, 519.187471606934, 525.6294312509672, 535.3522238091953, 7397.482176247611, 7593.506422082547, 7617.847643047108, 7779.0, 7840.923719834131, 438.7893810970752, 470.1372980580604, 480.5050797678397, 513.473689468298, 527.4909712127738, 3517.2086280586664, 3520.436730123168, 3640.9817950910074, 3709.647583479565, 3770.6040865709256, 27570.5864412034, 94544.52727736317, 101785.49107254416, 103231.4838425803, 103320.48339758403, 87858.56070719734, 88312.0, 89432.5528372354, 89715.55142224378, 92379.53810230906, 62701.05948410778, 63305.68347158235, 74868.62565687245, 79267.60366198132, 83453.58273208595, 7766.883496747666, 8257.21556452136, 8340.499570025819, 8377.45546539473, 8404.537750423786, 30539.847300763355, 38168.61831381762, 42218.0, 42550.0, 45768.31347529723, 34913.0, 52515.0, 52913.47086529085, 55403.44596554144, 60514.39485605264, 10356.430396328275, 10366.481675916324, 10569.0, 10576.206784491347, 10988.450577471254, 11659.358735269641, 11734.11994100463, 11894.226875253082, 11931.224470409743, 11969.0, 10906.672799816019, 10980.341179529254, 11139.554417823196, 11227.0, 11841.940790296338, 9241.399309044891, 10020.398776073458, 10485.52815123306, 11072.944635276772, 11088.0, 10055.949720251352, 10107.7473063174, 10263.12763415118, 10390.168786496912, 10483.685489435024, 9085.22775564058, 9438.799452679888, 9541.666041688508, 9839.40963542161, 9855.11303982645, 9542.236621070158, 9740.951295243478, 9741.756456088655, 9775.169110625677, 9828.901710982798], "value": 6220.0618251458745, "unit": "score"}], "name": "dromaeo_css", "value": 6057.250195872194, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 118.0, 116.0, 119.0, 116.0, 117.0, 116.0, 116.0, 116.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 125.0, 163.0, 130.0, 127.0, 134.0, 122.0, 174.0, 125.0], "value": 138.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 163.0, 163.0, 162.0, 162.0, 162.0, 161.0, 161.0, 161.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 84.0, 77.0, 117.0, 76.0, 78.0, 78.0, 78.0, 109.0, 76.0], "value": 84.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 117.0, 84.0, 85.0, 84.0, 105.0, 84.0, 83.0, 118.0], "value": 92.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 148.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 94.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 64.0, 64.0, 63.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 66.0, 67.0, 66.0, 66.0, 65.0, 66.0, 65.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 83.0, 89.0, 85.0, 89.0, 83.0, 83.0, 83.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 132.0, 134.0, 133.0, 132.0, 135.0, 143.0, 134.0, 172.0, 141.0], "value": 139.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 175.0, 174.0, 175.0, 172.0, 171.0, 183.0, 174.0, 176.0, 171.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 69.0, 69.0, 69.0, 69.0, 70.0, 68.0, 70.0, 71.0], "value": 69.7, "unit": "score"}], "name": "kraken", "value": 1552.6, "alertThreshold": 2.0}]} 21:59:51 INFO - Return code: 0 21:59:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:59:51 INFO - # TBPL SUCCESS # 21:59:51 INFO - Running post-action listener: _resource_record_post_action 21:59:51 INFO - [mozharness: 2016-09-20 04:59:51.386501Z] Finished run-tests step (success) 21:59:51 INFO - Running post-run listener: _resource_record_post_run 21:59:51 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 0; Write bytes: 410382336; Read time: 0; Write time: 264040 21:59:51 INFO - TinderboxPrint: CPU usage
13.1% 21:59:51 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 21:59:51 INFO - TinderboxPrint: I/O write bytes / time
410,382,336 / 264,040 21:59:51 INFO - TinderboxPrint: CPU idle
8,334.2 (86.9%) 21:59:51 INFO - TinderboxPrint: CPU user
1,203.6 (12.5%) 21:59:51 INFO - TinderboxPrint: Swap in / out
0 / 0 21:59:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 109629440; Read time: 0; Write time: 78644 21:59:51 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 293707776; Read time: 0; Write time: 185100 21:59:52 INFO - Running post-run listener: _upload_blobber_files 21:59:52 INFO - Blob upload gear active. 21:59:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:59:52 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:59:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:59:52 INFO - (blobuploader) - INFO - Open directory for files ... 21:59:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:59:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:59:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:59:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:59:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:59:53 INFO - (blobuploader) - INFO - Done attempting. 21:59:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:59:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:59:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:59:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:59:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:59:54 INFO - (blobuploader) - INFO - Done attempting. 21:59:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:59:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:59:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:00:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:00:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:00:00 INFO - (blobuploader) - INFO - Done attempting. 22:00:00 INFO - (blobuploader) - INFO - Iteration through files over. 22:00:00 INFO - Return code: 0 22:00:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:00:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:00:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/689e3acfd7b3f4c7cfdd1de2d6ec341a37aabc5114ea0020d40d0e8c92c01074ec665288174f731e96c23b6bfd199e86187a0ac7a11cf43f536029a6f0dddc7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1e6a6da0e6f2f4789ef15c0d0568e69e4983a19f3e7fac8d4e51946b090e810a1e4dde0bb6d370ecb3ad6855d1817100211edfa4904135db48e01adbe3f89ee5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/261d0b48e25ec107ee49ce99841fcd643af192ba931fc7d47f10d6b0d1e2d8f4887d73573c65716852d4443ceb2562dd3eefaf7a466ad01f6d941a73cac820d8"} 22:00:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:00:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:00:00 INFO - Contents: 22:00:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/689e3acfd7b3f4c7cfdd1de2d6ec341a37aabc5114ea0020d40d0e8c92c01074ec665288174f731e96c23b6bfd199e86187a0ac7a11cf43f536029a6f0dddc7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1e6a6da0e6f2f4789ef15c0d0568e69e4983a19f3e7fac8d4e51946b090e810a1e4dde0bb6d370ecb3ad6855d1817100211edfa4904135db48e01adbe3f89ee5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/261d0b48e25ec107ee49ce99841fcd643af192ba931fc7d47f10d6b0d1e2d8f4887d73573c65716852d4443ceb2562dd3eefaf7a466ad01f6d941a73cac820d8"} 22:00:00 INFO - Running post-run listener: copy_logs_to_upload_dir 22:00:00 INFO - Copying logs to upload dir... 22:00:00 INFO - mkdir: /builds/slave/test/build/upload/logs 22:00:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.331562 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-09-19 22:00:00.430436) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-19 22:00:00.436930) ========= 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=0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/689e3acfd7b3f4c7cfdd1de2d6ec341a37aabc5114ea0020d40d0e8c92c01074ec665288174f731e96c23b6bfd199e86187a0ac7a11cf43f536029a6f0dddc7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1e6a6da0e6f2f4789ef15c0d0568e69e4983a19f3e7fac8d4e51946b090e810a1e4dde0bb6d370ecb3ad6855d1817100211edfa4904135db48e01adbe3f89ee5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/261d0b48e25ec107ee49ce99841fcd643af192ba931fc7d47f10d6b0d1e2d8f4887d73573c65716852d4443ceb2562dd3eefaf7a466ad01f6d941a73cac820d8"} build_url:https://queue.taskcluster.net/v1/task/NwbeHYMjSTGoSkwNnKg2Iw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011488 build_url: 'https://queue.taskcluster.net/v1/task/NwbeHYMjSTGoSkwNnKg2Iw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/689e3acfd7b3f4c7cfdd1de2d6ec341a37aabc5114ea0020d40d0e8c92c01074ec665288174f731e96c23b6bfd199e86187a0ac7a11cf43f536029a6f0dddc7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1e6a6da0e6f2f4789ef15c0d0568e69e4983a19f3e7fac8d4e51946b090e810a1e4dde0bb6d370ecb3ad6855d1817100211edfa4904135db48e01adbe3f89ee5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/261d0b48e25ec107ee49ce99841fcd643af192ba931fc7d47f10d6b0d1e2d8f4887d73573c65716852d4443ceb2562dd3eefaf7a466ad01f6d941a73cac820d8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-19 22:00:00.467265) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 22:00:00.467619) ========= 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=0e2a256762fed810e2f0f810000001b3-1474346187.785884-880689363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 22:00:00.554533) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-19 22:00:00.555317) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-19 22:00:00.556051) ========= ========= Total master_lag: 0.44 =========