builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-020 starttime: 1474200366.69 results: success (0) buildid: 20160918000553 builduid: e66f368b4db4489a8f57c64eacec42df revision: fd81de7deaaba19cb7a899b08da0472e32bd215b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-18 05:06:06.688450) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-18 05:06:06.689083) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-18 05:06:06.689532) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-18 05:06:06.705595) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-18 05:06:06.706123) ========= 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=af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-18 05:06:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-09-18 05:06:07 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125240 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-18 05:06:06.850030) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-18 05:06:06.850669) ========= 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=af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023958 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-18 05:06:06.901862) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-18 05:06:06.902234) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fd81de7deaaba19cb7a899b08da0472e32bd215b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev fd81de7deaaba19cb7a899b08da0472e32bd215b --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=af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-18 05:06:07,618 truncating revision to first 12 chars 2016-09-18 05:06:07,618 Setting DEBUG logging. 2016-09-18 05:06:07,618 attempt 1/10 2016-09-18 05:06:07,618 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fd81de7deaab?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-18 05:06:09,041 unpacking tar archive at: fx-team-fd81de7deaab/testing/mozharness/ program finished with exit code 0 elapsedTime=1.773690 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-18 05:06:08.693333) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-18 05:06:08.694145) ========= script_repo_revision: fd81de7deaaba19cb7a899b08da0472e32bd215b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-18 05:06:08.694794) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-18 05:06:08.695117) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-18 05:06:08.706558) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-09-18 05:06:08.707216) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:06:09 INFO - MultiFileLogger online at 20160918 05:06:09 in /builds/slave/test 05:06:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:06:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:06:09 INFO - {'append_to_log': False, 05:06:09 INFO - 'base_work_dir': '/builds/slave/test', 05:06:09 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:06:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:06:09 INFO - 'branch': 'Fx-Team-Non-PGO', 05:06:09 INFO - 'buildbot_json_path': 'buildprops.json', 05:06:09 INFO - 'config_files': ('talos/linux_config.py',), 05:06:09 INFO - 'default_actions': ('clobber', 05:06:09 INFO - 'read-buildbot-config', 05:06:09 INFO - 'download-and-extract', 05:06:09 INFO - 'populate-webroot', 05:06:09 INFO - 'create-virtualenv', 05:06:09 INFO - 'install', 05:06:09 INFO - 'run-tests'), 05:06:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:06:09 INFO - 'download_minidump_stackwalk': True, 05:06:09 INFO - 'download_symbols': 'ondemand', 05:06:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:06:09 INFO - 'tooltool.py': '/tools/tooltool.py', 05:06:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:06:09 INFO - '/tools/misc-python/virtualenv.py')}, 05:06:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:06:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:06:09 INFO - 'installer_path': 'installer.exe', 05:06:09 INFO - 'log_level': 'info', 05:06:09 INFO - 'log_name': 'talos', 05:06:09 INFO - 'log_to_console': True, 05:06:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:06:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:06:09 INFO - 'opt_config_files': (), 05:06:09 INFO - 'pip_index': False, 05:06:09 INFO - 'sps_profile': False, 05:06:09 INFO - 'sps_profile_interval': 0, 05:06:09 INFO - 'suite': 'dromaeojs', 05:06:09 INFO - 'system_bits': '32', 05:06:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:06:09 INFO - 'title': 'talos-linux64-ix-020', 05:06:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:06:09 INFO - 'use_talos_json': True, 05:06:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:06:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:06:09 INFO - 'work_dir': 'build'} 05:06:09 INFO - [mozharness: 2016-09-18 12:06:09.526838Z] Running clobber step. 05:06:09 INFO - Running pre-action listener: _resource_record_pre_action 05:06:09 INFO - Running main action method: clobber 05:06:09 INFO - rmtree: /builds/slave/test/build 05:06:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:06:09 INFO - Running post-action listener: _resource_record_post_action 05:06:09 INFO - [mozharness: 2016-09-18 12:06:09.978277Z] Finished clobber step (success) 05:06:09 INFO - [mozharness: 2016-09-18 12:06:09.978377Z] Running read-buildbot-config step. 05:06:09 INFO - Running pre-action listener: _resource_record_pre_action 05:06:09 INFO - Running main action method: read_buildbot_config 05:06:09 INFO - Using buildbot properties: 05:06:09 INFO - { 05:06:09 INFO - "project": "", 05:06:09 INFO - "product": "firefox", 05:06:09 INFO - "script_repo_revision": "production", 05:06:09 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:06:09 INFO - "repository": "", 05:06:09 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:06:09 INFO - "buildid": "20160918000553", 05:06:09 INFO - "pgo_build": "False", 05:06:09 INFO - "basedir": "/builds/slave/test", 05:06:09 INFO - "buildnumber": 2168, 05:06:09 INFO - "slavename": "talos-linux64-ix-020", 05:06:09 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:06:09 INFO - "platform": "ubuntu64_hw", 05:06:09 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:06:09 INFO - "branch": "fx-team", 05:06:09 INFO - "repo_path": "integration/fx-team", 05:06:09 INFO - "revision": "fd81de7deaaba19cb7a899b08da0472e32bd215b", 05:06:09 INFO - "stage_platform": "linux64", 05:06:09 INFO - "builduid": "e66f368b4db4489a8f57c64eacec42df", 05:06:09 INFO - "slavebuilddir": "test" 05:06:09 INFO - } 05:06:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZWpeDrdrStO8u-yJAoJw3A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:06:09 INFO - Running post-action listener: _resource_record_post_action 05:06:09 INFO - [mozharness: 2016-09-18 12:06:09.980815Z] Finished read-buildbot-config step (success) 05:06:09 INFO - [mozharness: 2016-09-18 12:06:09.980902Z] Running download-and-extract step. 05:06:09 INFO - Running pre-action listener: _resource_record_pre_action 05:06:09 INFO - Running main action method: download_and_extract 05:06:09 INFO - mkdir: /builds/slave/test/build/tests 05:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:09 INFO - trying https://queue.taskcluster.net/v1/task/ZWpeDrdrStO8u-yJAoJw3A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:06:09 INFO - Downloading https://queue.taskcluster.net/v1/task/ZWpeDrdrStO8u-yJAoJw3A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:06:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZWpeDrdrStO8u-yJAoJw3A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:06:10 INFO - Downloaded 1361 bytes. 05:06:10 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:06:10 INFO - Using the following test package requirements: 05:06:10 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:06:10 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:10 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:06:10 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:10 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:06:10 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:10 INFO - u'jsshell-linux-x86_64.zip'], 05:06:10 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:10 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:06:10 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:06:10 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:10 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:06:10 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:10 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:06:10 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:10 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:06:10 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:10 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:06:10 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:06:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZWpeDrdrStO8u-yJAoJw3A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:06:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZWpeDrdrStO8u-yJAoJw3A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:06:10 INFO - Fetch https://queue.taskcluster.net/v1/task/ZWpeDrdrStO8u-yJAoJw3A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:06:11 INFO - Expected file size: 20365610 05:06:15 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:06:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZWpeDrdrStO8u-yJAoJw3A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:06:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZWpeDrdrStO8u-yJAoJw3A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:06:15 INFO - Fetch https://queue.taskcluster.net/v1/task/ZWpeDrdrStO8u-yJAoJw3A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:06:15 INFO - Expected file size: 20365610 05:06:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZWpeDrdrStO8u-yJAoJw3A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:06:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZWpeDrdrStO8u-yJAoJw3A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:06:20 INFO - Fetch https://queue.taskcluster.net/v1/task/ZWpeDrdrStO8u-yJAoJw3A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:06:21 INFO - Expected file size: 14414059 05:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:21 INFO - trying https://queue.taskcluster.net/v1/task/ZWpeDrdrStO8u-yJAoJw3A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:06:21 INFO - Downloading https://queue.taskcluster.net/v1/task/ZWpeDrdrStO8u-yJAoJw3A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:06:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZWpeDrdrStO8u-yJAoJw3A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:06:22 INFO - Downloaded 55602959 bytes. 05:06:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZWpeDrdrStO8u-yJAoJw3A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:06:22 INFO - mkdir: /builds/slave/test/properties 05:06:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:06:22 INFO - Writing to file /builds/slave/test/properties/build_url 05:06:22 INFO - Contents: 05:06:22 INFO - build_url:https://queue.taskcluster.net/v1/task/ZWpeDrdrStO8u-yJAoJw3A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:06:23 INFO - Running post-action listener: _resource_record_post_action 05:06:23 INFO - Running post-action listener: set_extra_try_arguments 05:06:23 INFO - [mozharness: 2016-09-18 12:06:23.440073Z] Finished download-and-extract step (success) 05:06:23 INFO - [mozharness: 2016-09-18 12:06:23.440299Z] Running populate-webroot step. 05:06:23 INFO - Running pre-action listener: _resource_record_pre_action 05:06:23 INFO - Running main action method: populate_webroot 05:06:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:06:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:06:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:06:23 INFO - '--tppagecycles', 05:06:23 INFO - '7'], 05:06:23 INFO - 'tests': ['tsvgm']}}, 05:06:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:06:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:06:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:06:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:06:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:06:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:06:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:23 INFO - 'talos_options': ['--disable-e10s'], 05:06:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:06:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:06:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:23 INFO - 'talos_options': ['--disable-e10s'], 05:06:23 INFO - 'tests': ['damp', 'tps']}, 05:06:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:23 INFO - 'tests': ['damp', 'tps']}, 05:06:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:06:23 INFO - 'tests': ['dromaeo_dom']}, 05:06:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:06:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:06:23 INFO - 'tests': ['basic_compositor_video']}, 05:06:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:06:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:06:23 INFO - 'tests': ['a11yr', 05:06:23 INFO - 'ts_paint', 05:06:23 INFO - 'tpaint', 05:06:23 INFO - 'sessionrestore', 05:06:23 INFO - 'sessionrestore_no_auto_restore', 05:06:23 INFO - 'tabpaint']}, 05:06:23 INFO - 'other-e10s': {'tests': ['a11yr', 05:06:23 INFO - 'ts_paint', 05:06:23 INFO - 'tpaint', 05:06:23 INFO - 'sessionrestore', 05:06:23 INFO - 'sessionrestore_no_auto_restore', 05:06:23 INFO - 'tabpaint']}, 05:06:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:06:23 INFO - 'ts_paint', 05:06:23 INFO - 'tpaint', 05:06:23 INFO - 'sessionrestore', 05:06:23 INFO - 'sessionrestore_no_auto_restore', 05:06:23 INFO - 'tabpaint']}, 05:06:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:06:23 INFO - 'ts_paint', 05:06:23 INFO - 'tpaint', 05:06:23 INFO - 'sessionrestore', 05:06:23 INFO - 'sessionrestore_no_auto_restore', 05:06:23 INFO - 'tabpaint']}, 05:06:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:06:23 INFO - 'tests': ['a11yr', 05:06:23 INFO - 'ts_paint', 05:06:23 INFO - 'tpaint', 05:06:23 INFO - 'sessionrestore', 05:06:23 INFO - 'sessionrestore_no_auto_restore', 05:06:23 INFO - 'tabpaint']}, 05:06:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:06:23 INFO - 'tests': ['a11yr', 05:06:23 INFO - 'ts_paint', 05:06:23 INFO - 'tpaint', 05:06:23 INFO - 'sessionrestore', 05:06:23 INFO - 'sessionrestore_no_auto_restore', 05:06:23 INFO - 'tabpaint']}, 05:06:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:06:23 INFO - 'tests': ['tsvgx', 05:06:23 INFO - 'tsvgr_opacity', 05:06:23 INFO - 'tart', 05:06:23 INFO - 'tscrollx', 05:06:23 INFO - 'cart']}, 05:06:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:06:23 INFO - 'tsvgr_opacity', 05:06:23 INFO - 'tart', 05:06:23 INFO - 'tscrollx', 05:06:23 INFO - 'cart']}, 05:06:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:23 INFO - 'talos_options': ['--disable-e10s'], 05:06:23 INFO - 'tests': ['tp5o']}, 05:06:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:23 INFO - 'tests': ['tp5o']}, 05:06:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:23 INFO - 'talos_options': ['--disable-e10s', 05:06:23 INFO - '--xperf_path', 05:06:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:06:23 INFO - 'tests': ['tp5n']}, 05:06:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:23 INFO - 'talos_options': ['--xperf_path', 05:06:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:06:23 INFO - 'tests': ['tp5n']}}, 05:06:23 INFO - 'talos.zip': {'path': '', 05:06:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:06:23 INFO - Running post-action listener: _resource_record_post_action 05:06:23 INFO - [mozharness: 2016-09-18 12:06:23.457143Z] Finished populate-webroot step (success) 05:06:23 INFO - [mozharness: 2016-09-18 12:06:23.457231Z] Running create-virtualenv step. 05:06:23 INFO - Running pre-action listener: _resource_record_pre_action 05:06:23 INFO - Running main action method: create_virtualenv 05:06:23 INFO - Creating virtualenv /builds/slave/test/build/venv 05:06:23 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:06:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:06:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:06:23 INFO - Using real prefix '/usr' 05:06:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:06:24 INFO - Installing distribute.............................................................................................................................................................................................done. 05:06:26 INFO - Installing pip.................done. 05:06:26 INFO - Return code: 0 05:06:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe5291cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1334ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1331f60>, '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 0x1332d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13331d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:06:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:06:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:06:26 INFO - Using env: {'DISPLAY': ':0', 05:06:26 INFO - 'HOME': '/home/cltbld', 05:06:26 INFO - 'LANG': 'en_US.UTF-8', 05:06:26 INFO - 'LANGUAGE': 'en_US:en', 05:06:26 INFO - 'LOGNAME': 'cltbld', 05:06:26 INFO - 'MAIL': '/var/mail/cltbld', 05:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:26 INFO - 'MOZ_NO_REMOTE': '1', 05:06:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:26 INFO - 'NO_EM_RESTART': '1', 05:06:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:26 INFO - 'PWD': '/builds/slave/test', 05:06:26 INFO - 'SHELL': '/bin/bash', 05:06:26 INFO - 'SHLVL': '1', 05:06:26 INFO - 'TERM': 'linux', 05:06:26 INFO - 'TMOUT': '86400', 05:06:26 INFO - 'USER': 'cltbld', 05:06:26 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694', 05:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:26 INFO - '_': '/tools/buildbot/bin/python'} 05:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:06:26 INFO - Cleaning up... 05:06:26 INFO - Return code: 0 05:06:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe5291cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1334ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1331f60>, '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 0x1332d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13331d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:06:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:06:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:06:26 INFO - Using env: {'DISPLAY': ':0', 05:06:26 INFO - 'HOME': '/home/cltbld', 05:06:26 INFO - 'LANG': 'en_US.UTF-8', 05:06:26 INFO - 'LANGUAGE': 'en_US:en', 05:06:26 INFO - 'LOGNAME': 'cltbld', 05:06:26 INFO - 'MAIL': '/var/mail/cltbld', 05:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:26 INFO - 'MOZ_NO_REMOTE': '1', 05:06:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:26 INFO - 'NO_EM_RESTART': '1', 05:06:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:26 INFO - 'PWD': '/builds/slave/test', 05:06:26 INFO - 'SHELL': '/bin/bash', 05:06:26 INFO - 'SHLVL': '1', 05:06:26 INFO - 'TERM': 'linux', 05:06:26 INFO - 'TMOUT': '86400', 05:06:26 INFO - 'USER': 'cltbld', 05:06:26 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694', 05:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:26 INFO - '_': '/tools/buildbot/bin/python'} 05:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:26 INFO - Downloading/unpacking psutil>=3.1.1 05:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:06:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:28 INFO - Installing collected packages: psutil 05:06:28 INFO - Running setup.py install for psutil 05:06:28 INFO - building 'psutil._psutil_linux' extension 05:06:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:06:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:06:28 INFO - building 'psutil._psutil_posix' extension 05:06:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:06:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:06:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:29 INFO - Successfully installed psutil 05:06:29 INFO - Cleaning up... 05:06:29 INFO - Return code: 0 05:06:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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')]} 05:06:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe5291cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1334ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1331f60>, '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 0x1332d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13331d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:06:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:06:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:06:29 INFO - Using env: {'DISPLAY': ':0', 05:06:29 INFO - 'HOME': '/home/cltbld', 05:06:29 INFO - 'LANG': 'en_US.UTF-8', 05:06:29 INFO - 'LANGUAGE': 'en_US:en', 05:06:29 INFO - 'LOGNAME': 'cltbld', 05:06:29 INFO - 'MAIL': '/var/mail/cltbld', 05:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:29 INFO - 'MOZ_NO_REMOTE': '1', 05:06:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:29 INFO - 'NO_EM_RESTART': '1', 05:06:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:29 INFO - 'PWD': '/builds/slave/test', 05:06:29 INFO - 'SHELL': '/bin/bash', 05:06:29 INFO - 'SHLVL': '1', 05:06:29 INFO - 'TERM': 'linux', 05:06:29 INFO - 'TMOUT': '86400', 05:06:29 INFO - 'USER': 'cltbld', 05:06:29 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694', 05:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:29 INFO - '_': '/tools/buildbot/bin/python'} 05:06:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:06:31 INFO - Installing collected packages: mozsystemmonitor 05:06:31 INFO - Running setup.py install for mozsystemmonitor 05:06:31 INFO - Successfully installed mozsystemmonitor 05:06:31 INFO - Cleaning up... 05:06:31 INFO - Return code: 0 05:06:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe5291cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1334ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1331f60>, '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 0x1332d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13331d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:06:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:06:31 INFO - Using env: {'DISPLAY': ':0', 05:06:31 INFO - 'HOME': '/home/cltbld', 05:06:31 INFO - 'LANG': 'en_US.UTF-8', 05:06:31 INFO - 'LANGUAGE': 'en_US:en', 05:06:31 INFO - 'LOGNAME': 'cltbld', 05:06:31 INFO - 'MAIL': '/var/mail/cltbld', 05:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:31 INFO - 'MOZ_NO_REMOTE': '1', 05:06:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:31 INFO - 'NO_EM_RESTART': '1', 05:06:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:31 INFO - 'PWD': '/builds/slave/test', 05:06:31 INFO - 'SHELL': '/bin/bash', 05:06:31 INFO - 'SHLVL': '1', 05:06:31 INFO - 'TERM': 'linux', 05:06:31 INFO - 'TMOUT': '86400', 05:06:31 INFO - 'USER': 'cltbld', 05:06:31 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694', 05:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:31 INFO - '_': '/tools/buildbot/bin/python'} 05:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:31 INFO - Downloading/unpacking jsonschema==2.5.1 05:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:06:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06:33 INFO - Downloading functools32-3.2.3-2.tar.gz 05:06:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:06:33 INFO - warning: no files found matching '*.txt' 05:06:33 INFO - no previously-included directories found matching 'build' 05:06:33 INFO - no previously-included directories found matching 'dist' 05:06:33 INFO - no previously-included directories found matching '.git*' 05:06:33 INFO - Installing collected packages: jsonschema, functools32 05:06:33 INFO - Running setup.py install for functools32 05:06:33 INFO - warning: no files found matching '*.txt' 05:06:33 INFO - no previously-included directories found matching 'build' 05:06:33 INFO - no previously-included directories found matching 'dist' 05:06:33 INFO - no previously-included directories found matching '.git*' 05:06:33 INFO - Successfully installed jsonschema functools32 05:06:33 INFO - Cleaning up... 05:06:33 INFO - Return code: 0 05:06:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:33 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 0x7ffe5291cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1334ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1331f60>, '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 0x1332d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13331d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:06:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:06:33 INFO - Using env: {'DISPLAY': ':0', 05:06:33 INFO - 'HOME': '/home/cltbld', 05:06:33 INFO - 'LANG': 'en_US.UTF-8', 05:06:33 INFO - 'LANGUAGE': 'en_US:en', 05:06:33 INFO - 'LOGNAME': 'cltbld', 05:06:33 INFO - 'MAIL': '/var/mail/cltbld', 05:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:33 INFO - 'MOZ_NO_REMOTE': '1', 05:06:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:33 INFO - 'NO_EM_RESTART': '1', 05:06:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:33 INFO - 'PWD': '/builds/slave/test', 05:06:33 INFO - 'SHELL': '/bin/bash', 05:06:33 INFO - 'SHLVL': '1', 05:06:33 INFO - 'TERM': 'linux', 05:06:33 INFO - 'TMOUT': '86400', 05:06:33 INFO - 'USER': 'cltbld', 05:06:33 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694', 05:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:33 INFO - '_': '/tools/buildbot/bin/python'} 05:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:06:34 INFO - Cleaning up... 05:06:34 INFO - Return code: 0 05:06:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe5291cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1334ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1331f60>, '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 0x1332d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13331d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:06:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:06:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:06:34 INFO - Using env: {'DISPLAY': ':0', 05:06:34 INFO - 'HOME': '/home/cltbld', 05:06:34 INFO - 'LANG': 'en_US.UTF-8', 05:06:34 INFO - 'LANGUAGE': 'en_US:en', 05:06:34 INFO - 'LOGNAME': 'cltbld', 05:06:34 INFO - 'MAIL': '/var/mail/cltbld', 05:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:34 INFO - 'MOZ_NO_REMOTE': '1', 05:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:34 INFO - 'NO_EM_RESTART': '1', 05:06:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:34 INFO - 'PWD': '/builds/slave/test', 05:06:34 INFO - 'SHELL': '/bin/bash', 05:06:34 INFO - 'SHLVL': '1', 05:06:34 INFO - 'TERM': 'linux', 05:06:34 INFO - 'TMOUT': '86400', 05:06:34 INFO - 'USER': 'cltbld', 05:06:34 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694', 05:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:34 INFO - '_': '/tools/buildbot/bin/python'} 05:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:34 INFO - Downloading/unpacking blobuploader==1.2.4 05:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:36 INFO - Downloading blobuploader-1.2.4.tar.gz 05:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:06:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:06:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:36 INFO - Downloading docopt-0.6.1.tar.gz 05:06:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:06:37 INFO - Installing collected packages: blobuploader, requests, docopt 05:06:37 INFO - Running setup.py install for blobuploader 05:06:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:06:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:06:37 INFO - Running setup.py install for requests 05:06:37 INFO - Running setup.py install for docopt 05:06:37 INFO - Successfully installed blobuploader requests docopt 05:06:37 INFO - Cleaning up... 05:06:37 INFO - Return code: 0 05:06:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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')]} 05:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:37 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 0x7ffe5291cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1334ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1331f60>, '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 0x1332d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13331d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:06:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:06:37 INFO - Using env: {'DISPLAY': ':0', 05:06:37 INFO - 'HOME': '/home/cltbld', 05:06:37 INFO - 'LANG': 'en_US.UTF-8', 05:06:37 INFO - 'LANGUAGE': 'en_US:en', 05:06:37 INFO - 'LOGNAME': 'cltbld', 05:06:37 INFO - 'MAIL': '/var/mail/cltbld', 05:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:37 INFO - 'MOZ_NO_REMOTE': '1', 05:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:37 INFO - 'NO_EM_RESTART': '1', 05:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:37 INFO - 'PWD': '/builds/slave/test', 05:06:37 INFO - 'SHELL': '/bin/bash', 05:06:37 INFO - 'SHLVL': '1', 05:06:37 INFO - 'TERM': 'linux', 05:06:37 INFO - 'TMOUT': '86400', 05:06:37 INFO - 'USER': 'cltbld', 05:06:37 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694', 05:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:37 INFO - '_': '/tools/buildbot/bin/python'} 05:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:37 INFO - Running setup.py (path:/tmp/pip-uETr61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:37 INFO - Running setup.py (path:/tmp/pip-WdEWZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:38 INFO - Running setup.py (path:/tmp/pip-9WgJqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:38 INFO - Running setup.py (path:/tmp/pip-ChUA9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:38 INFO - Running setup.py (path:/tmp/pip-Z64rgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:38 INFO - Running setup.py (path:/tmp/pip-Nj3Dob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:38 INFO - Running setup.py (path:/tmp/pip-B4A3I5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:38 INFO - Running setup.py (path:/tmp/pip-m5VzTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:38 INFO - Running setup.py (path:/tmp/pip-a8ilHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:38 INFO - Running setup.py (path:/tmp/pip-Qa2Fxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:38 INFO - Running setup.py (path:/tmp/pip-SOnzmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:38 INFO - Running setup.py (path:/tmp/pip-w3WK58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:38 INFO - Running setup.py (path:/tmp/pip-8keCuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:38 INFO - Running setup.py (path:/tmp/pip-D3mLci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:38 INFO - Running setup.py (path:/tmp/pip-3OTN5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:38 INFO - Running setup.py (path:/tmp/pip-M30U0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:39 INFO - Running setup.py (path:/tmp/pip-eEkfnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:06:39 INFO - Running setup.py install for manifestparser 05:06:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:06:39 INFO - Running setup.py install for mozcrash 05:06:39 INFO - Running setup.py install for mozdebug 05:06:39 INFO - Running setup.py install for mozdevice 05:06:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:06:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:06:39 INFO - Running setup.py install for mozfile 05:06:39 INFO - Running setup.py install for mozhttpd 05:06:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:06:39 INFO - Running setup.py install for mozinfo 05:06:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:06:39 INFO - Running setup.py install for mozInstall 05:06:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:06:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:06:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:06:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:06:39 INFO - Running setup.py install for mozleak 05:06:40 INFO - Running setup.py install for mozlog 05:06:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:06:40 INFO - Running setup.py install for moznetwork 05:06:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:06:40 INFO - Running setup.py install for mozprocess 05:06:40 INFO - Running setup.py install for mozprofile 05:06:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:06:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:06:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:06:40 INFO - Running setup.py install for mozrunner 05:06:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:06:40 INFO - Running setup.py install for mozscreenshot 05:06:40 INFO - Running setup.py install for moztest 05:06:40 INFO - Running setup.py install for mozversion 05:06:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:06:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:06:40 INFO - Cleaning up... 05:06:40 INFO - Return code: 0 05:06:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:40 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 0x7ffe5291cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1334ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1331f60>, '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 0x1332d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13331d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:06:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:06:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:06:40 INFO - Using env: {'DISPLAY': ':0', 05:06:40 INFO - 'HOME': '/home/cltbld', 05:06:40 INFO - 'LANG': 'en_US.UTF-8', 05:06:40 INFO - 'LANGUAGE': 'en_US:en', 05:06:40 INFO - 'LOGNAME': 'cltbld', 05:06:40 INFO - 'MAIL': '/var/mail/cltbld', 05:06:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:40 INFO - 'MOZ_NO_REMOTE': '1', 05:06:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:40 INFO - 'NO_EM_RESTART': '1', 05:06:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:40 INFO - 'PWD': '/builds/slave/test', 05:06:40 INFO - 'SHELL': '/bin/bash', 05:06:40 INFO - 'SHLVL': '1', 05:06:40 INFO - 'TERM': 'linux', 05:06:40 INFO - 'TMOUT': '86400', 05:06:40 INFO - 'USER': 'cltbld', 05:06:40 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694', 05:06:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:40 INFO - '_': '/tools/buildbot/bin/python'} 05:06:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:41 INFO - Running setup.py (path:/tmp/pip-fZCz_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:41 INFO - Running setup.py (path:/tmp/pip-TRxXF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:41 INFO - Running setup.py (path:/tmp/pip-tjOsfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:41 INFO - Running setup.py (path:/tmp/pip-QSrPfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:41 INFO - Running setup.py (path:/tmp/pip-aMwzg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:41 INFO - Running setup.py (path:/tmp/pip-BFkUma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:41 INFO - Running setup.py (path:/tmp/pip-9ow_YC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:41 INFO - Running setup.py (path:/tmp/pip-NGS4oy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:41 INFO - Running setup.py (path:/tmp/pip-fTbvkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:41 INFO - Running setup.py (path:/tmp/pip-dbnPGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06:41 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)) 05:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:41 INFO - Running setup.py (path:/tmp/pip-tNckbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:41 INFO - Running setup.py (path:/tmp/pip-mnyDku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:42 INFO - Running setup.py (path:/tmp/pip-XJT120-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:42 INFO - Running setup.py (path:/tmp/pip-XX93e4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:42 INFO - Running setup.py (path:/tmp/pip-78j7xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:42 INFO - Running setup.py (path:/tmp/pip-dLLYev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:42 INFO - Running setup.py (path:/tmp/pip-8_4hur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:06:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:44 INFO - Downloading blessings-1.6.tar.gz 05:06:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:06:44 INFO - Installing collected packages: blessings 05:06:44 INFO - Running setup.py install for blessings 05:06:44 INFO - Successfully installed blessings 05:06:44 INFO - Cleaning up... 05:06:44 INFO - Return code: 0 05:06:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:06:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:06:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:06:44 INFO - Reading from file tmpfile_stdout 05:06:44 INFO - Current package versions: 05:06:44 INFO - argparse == 1.2.1 05:06:44 INFO - blessings == 1.6 05:06:44 INFO - blobuploader == 1.2.4 05:06:44 INFO - docopt == 0.6.1 05:06:44 INFO - functools32 == 3.2.3-2 05:06:44 INFO - jsonschema == 2.5.1 05:06:44 INFO - manifestparser == 1.1 05:06:44 INFO - mozInstall == 1.12 05:06:44 INFO - mozcrash == 0.17 05:06:44 INFO - mozdebug == 0.1 05:06:44 INFO - mozdevice == 0.48 05:06:44 INFO - mozfile == 1.2 05:06:44 INFO - mozhttpd == 0.7 05:06:44 INFO - mozinfo == 0.9 05:06:44 INFO - mozleak == 0.1 05:06:44 INFO - mozlog == 3.4 05:06:44 INFO - moznetwork == 0.27 05:06:44 INFO - mozprocess == 0.23 05:06:44 INFO - mozprofile == 0.28 05:06:44 INFO - mozrunner == 6.12 05:06:44 INFO - mozscreenshot == 0.1 05:06:44 INFO - mozsystemmonitor == 0.3 05:06:44 INFO - moztest == 0.7 05:06:44 INFO - mozversion == 1.4 05:06:44 INFO - psutil == 3.1.1 05:06:44 INFO - requests == 1.2.3 05:06:44 INFO - wsgiref == 0.1.2 05:06:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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')]} 05:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:44 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 0x7ffe5291cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1334ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1331f60>, '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 0x1332d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13331d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:06:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:06:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:06:44 INFO - Using env: {'DISPLAY': ':0', 05:06:44 INFO - 'HOME': '/home/cltbld', 05:06:44 INFO - 'LANG': 'en_US.UTF-8', 05:06:44 INFO - 'LANGUAGE': 'en_US:en', 05:06:44 INFO - 'LOGNAME': 'cltbld', 05:06:44 INFO - 'MAIL': '/var/mail/cltbld', 05:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:44 INFO - 'MOZ_NO_REMOTE': '1', 05:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:44 INFO - 'NO_EM_RESTART': '1', 05:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:44 INFO - 'PWD': '/builds/slave/test', 05:06:44 INFO - 'SHELL': '/bin/bash', 05:06:44 INFO - 'SHLVL': '1', 05:06:44 INFO - 'TERM': 'linux', 05:06:44 INFO - 'TMOUT': '86400', 05:06:44 INFO - 'USER': 'cltbld', 05:06:44 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694', 05:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:44 INFO - '_': '/tools/buildbot/bin/python'} 05:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:06:44 INFO - Cleaning up... 05:06:44 INFO - Return code: 0 05:06:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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')]} 05:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe5291cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1334ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1331f60>, '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 0x1332d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13331d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:06:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:06:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:06:44 INFO - Using env: {'DISPLAY': ':0', 05:06:44 INFO - 'HOME': '/home/cltbld', 05:06:44 INFO - 'LANG': 'en_US.UTF-8', 05:06:44 INFO - 'LANGUAGE': 'en_US:en', 05:06:44 INFO - 'LOGNAME': 'cltbld', 05:06:44 INFO - 'MAIL': '/var/mail/cltbld', 05:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:44 INFO - 'MOZ_NO_REMOTE': '1', 05:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:44 INFO - 'NO_EM_RESTART': '1', 05:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:44 INFO - 'PWD': '/builds/slave/test', 05:06:44 INFO - 'SHELL': '/bin/bash', 05:06:44 INFO - 'SHLVL': '1', 05:06:44 INFO - 'TERM': 'linux', 05:06:44 INFO - 'TMOUT': '86400', 05:06:44 INFO - 'USER': 'cltbld', 05:06:44 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694', 05:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:44 INFO - '_': '/tools/buildbot/bin/python'} 05:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:06:45 INFO - Cleaning up... 05:06:45 INFO - Return code: 0 05:06:45 INFO - Running post-action listener: _resource_record_post_action 05:06:45 INFO - Running post-action listener: _start_resource_monitoring 05:06:45 INFO - Starting resource monitoring. 05:06:45 INFO - [mozharness: 2016-09-18 12:06:45.207105Z] Finished create-virtualenv step (success) 05:06:45 INFO - [mozharness: 2016-09-18 12:06:45.207553Z] Running install step. 05:06:45 INFO - Running pre-action listener: _resource_record_pre_action 05:06:45 INFO - Running main action method: install 05:06:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:06:45 INFO - Reading from file tmpfile_stdout 05:06:45 INFO - Detecting whether we're running mozinstall >=1.0... 05:06:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:06:45 INFO - Reading from file tmpfile_stdout 05:06:45 INFO - Output received: 05:06:45 INFO - Usage: mozinstall [options] installer 05:06:45 INFO - Options: 05:06:45 INFO - -h, --help show this help message and exit 05:06:45 INFO - -d DEST, --destination=DEST 05:06:45 INFO - Directory to install application into. [default: 05:06:45 INFO - "/builds/slave/test"] 05:06:45 INFO - --app=APP Application being installed. [default: firefox] 05:06:45 INFO - mkdir: /builds/slave/test/build/application 05:06:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:07:02 INFO - Reading from file tmpfile_stdout 05:07:02 INFO - Output received: 05:07:02 INFO - /builds/slave/test/build/application/firefox/firefox 05:07:02 INFO - Running post-action listener: _resource_record_post_action 05:07:02 INFO - [mozharness: 2016-09-18 12:07:02.468471Z] Finished install step (success) 05:07:02 INFO - [mozharness: 2016-09-18 12:07:02.468714Z] Running run-tests step. 05:07:02 INFO - Running pre-action listener: _resource_record_pre_action 05:07:02 INFO - Running main action method: run_tests 05:07:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:07:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:07:02 INFO - Python 2.7.3 05:07:02 INFO - Return code: 0 05:07:02 INFO - grabbing minidump binary from tooltool 05:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:02 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1331f60>, '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 0x1332d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13331d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:07:02 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:07:02 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:07:02 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:07:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:07:02 INFO - Return code: 0 05:07:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:07:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:07:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:07:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:07:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:07:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZWpeDrdrStO8u-yJAoJw3A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 05:07:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZWpeDrdrStO8u-yJAoJw3A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 05:07:02 INFO - Using env: {'DISPLAY': ':0', 05:07:02 INFO - 'HOME': '/home/cltbld', 05:07:02 INFO - 'LANG': 'en_US.UTF-8', 05:07:02 INFO - 'LANGUAGE': 'en_US:en', 05:07:02 INFO - 'LOGNAME': 'cltbld', 05:07:02 INFO - 'MAIL': '/var/mail/cltbld', 05:07:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:07:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:02 INFO - 'MOZ_NO_REMOTE': '1', 05:07:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:02 INFO - 'NO_EM_RESTART': '1', 05:07:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:02 INFO - 'PWD': '/builds/slave/test', 05:07:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:07:02 INFO - 'SHELL': '/bin/bash', 05:07:02 INFO - 'SHLVL': '1', 05:07:02 INFO - 'TERM': 'linux', 05:07:02 INFO - 'TMOUT': '86400', 05:07:02 INFO - 'USER': 'cltbld', 05:07:02 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694', 05:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:02 INFO - '_': '/tools/buildbot/bin/python'} 05:07:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZWpeDrdrStO8u-yJAoJw3A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 05:07:02 INFO - mozversion application_buildid: 20160918000553 05:07:02 INFO - mozversion application_changeset: fd81de7deaaba19cb7a899b08da0472e32bd215b 05:07:02 INFO - mozversion application_display_name: Nightly 05:07:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:07:02 INFO - mozversion application_name: Firefox 05:07:02 INFO - mozversion application_remotingname: firefox 05:07:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:07:02 INFO - mozversion application_vendor: Mozilla 05:07:02 INFO - mozversion application_version: 51.0a1 05:07:02 INFO - mozversion platform_buildid: 20160918000553 05:07:02 INFO - mozversion platform_changeset: fd81de7deaaba19cb7a899b08da0472e32bd215b 05:07:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:07:02 INFO - mozversion platform_version: 51.0a1 05:07:02 INFO - using testdate: 1474200422 05:07:02 INFO - actual date: 1474200422 05:07:02 INFO - starting webserver on 'localhost:35997' 05:07:02 INFO - SUITE-START | Running 2 tests 05:07:02 INFO - TEST-START | dromaeo_css 05:07:02 INFO - operating with platform_type : linux_ 05:07:02 INFO - Initialising browser for dromaeo_css test... 05:07:02 INFO - TEST-INFO | started process 27959 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgle0k0/profile http://localhost:35997/getInfo.html) 05:07:07 INFO - PROCESS | 27959 | __metrics Screen width/height:1600/1200 05:07:07 INFO - PROCESS | 27959 | colorDepth:24 05:07:07 INFO - PROCESS | 27959 | Browser inner width/height: 1024/697 05:07:07 INFO - PROCESS | 27959 | __metrics 05:07:08 INFO - PROCESS | 27959 | 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" 05:07:08 INFO - PROCESS | 27959 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:07:09 INFO - PROCESS | 27959 | console.error: PushService: 05:07:09 INFO - PROCESS | 27959 | stateChangeProcessEnqueue: Error transitioning state 05:07:09 INFO - PROCESS | 27959 | UnknownError 05:07:09 INFO - TEST-INFO | 27959: exit 0 05:07:09 INFO - Browser initialized. 05:07:09 INFO - Running cycle 1/1 for dromaeo_css test... 05:07:09 INFO - TEST-INFO | started process 28040 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgle0k0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:07:22 INFO - PROCESS | 28040 | RSS: Main: 174792704 05:07:22 INFO - PROCESS | 28040 | 05:07:44 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 05:08:00 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.05003 seconds. 05:08:05 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.05005 seconds. 05:08:08 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01666 seconds. 05:08:10 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01667 seconds. 05:08:13 INFO - PROCESS | 28040 | 1474200493897 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:08:26 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 05:08:28 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 05:08:36 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.05007 seconds. 05:08:47 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 05:08:52 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.03333 seconds. 05:08:59 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01675 seconds. 05:09:05 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.05005 seconds. 05:09:17 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.05004 seconds. 05:09:22 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.05005 seconds. 05:09:40 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.03335 seconds. 05:09:44 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 05:09:45 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 2.01674 seconds. 05:09:50 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 05:09:52 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 05:10:09 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00124 seconds. 05:10:11 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 05:10:18 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 05:10:19 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 2.00006 seconds. 05:10:24 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 05:10:26 INFO - PROCESS | 28040 | Cycle 1(1): loaded http://localhost:35997/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35997/tests/dromaeo/cssquery-ext.html) 05:10:27 INFO - PROCESS | 28040 | RSS: Main: 289374208 05:10:27 INFO - PROCESS | 28040 | 05:10:30 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.03337 seconds. 05:10:44 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 05:10:48 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:10:50 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:10:58 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:11:04 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:11:24 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 05:11:32 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:11:46 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 05:11:48 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:11:50 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 05:12:01 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 05:12:03 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:12:05 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:12:12 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 05:12:27 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01674 seconds. 05:12:29 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 05:12:35 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:12:51 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:13:06 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 05:13:09 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:13:11 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:13:25 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 05:13:30 INFO - PROCESS | 28040 | Cycle 1(1): loaded http://localhost:35997/tests/dromaeo/cssquery-ext.html (next: http://localhost:35997/tests/dromaeo/cssquery-jquery.html) 05:13:30 INFO - PROCESS | 28040 | RSS: Main: 278024192 05:13:30 INFO - PROCESS | 28040 | 05:13:34 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 05:13:38 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 05:13:39 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 05:13:41 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:13:47 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:13:49 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 05:14:06 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 05:14:13 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 05:14:15 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:14:17 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 05:14:19 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:14:23 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 05:14:35 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 05:14:37 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:14:43 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 05:14:51 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:15:02 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:15:15 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 05:15:18 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 05:15:21 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01676 seconds. 05:15:32 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:15:34 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:15:52 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:15:56 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:15:58 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:16:01 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 05:16:06 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:16:08 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:16:10 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:16:14 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:16:16 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:16:20 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 05:16:22 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:16:26 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 05:16:28 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:16:30 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:16:31 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 2.01674 seconds. 05:16:32 INFO - PROCESS | 28040 | Cycle 1(1): loaded http://localhost:35997/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35997/tests/dromaeo/cssquery-mootools.html) 05:16:33 INFO - PROCESS | 28040 | RSS: Main: 219717632 05:16:33 INFO - PROCESS | 28040 | 05:16:39 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.03335 seconds. 05:16:51 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 05:16:52 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00008 seconds. 05:16:54 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 05:16:58 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:17:00 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 05:17:01 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 2.00011 seconds. 05:17:04 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:17:05 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 2.00007 seconds. 05:17:06 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 05:17:10 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:17:12 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:17:19 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.03339 seconds. 05:17:26 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:17:43 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 05:17:44 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:18:09 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:18:31 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 05:18:33 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:18:35 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:18:45 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 05:18:50 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 05:18:59 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 05:19:05 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 05:19:19 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:19:32 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:19:33 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 05:19:35 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:19:35 INFO - PROCESS | 28040 | Cycle 1(1): loaded http://localhost:35997/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35997/tests/dromaeo/cssquery-prototype.html) 05:19:36 INFO - PROCESS | 28040 | RSS: Main: 218456064 05:19:36 INFO - PROCESS | 28040 | 05:19:52 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 05:19:56 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 05:20:03 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 05:20:17 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:20:26 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 05:20:31 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:20:33 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 05:20:46 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 05:20:50 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 05:20:56 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:21:04 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 05:21:06 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:21:30 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 05:21:32 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.05005 seconds. 05:21:36 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 05:21:38 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 05:21:42 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01674 seconds. 05:21:44 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01678 seconds. 05:21:47 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:21:59 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:22:02 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 05:22:05 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 05:22:15 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:22:17 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.03331 seconds. 05:22:23 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 05:22:29 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 05:22:33 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.03339 seconds. 05:22:39 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:22:39 INFO - PROCESS | 28040 | Cycle 1(1): loaded http://localhost:35997/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35997/tests/dromaeo/cssquery-yui.html) 05:22:40 INFO - PROCESS | 28040 | RSS: Main: 219586560 05:22:40 INFO - PROCESS | 28040 | 05:22:43 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.03341 seconds. 05:22:46 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 05:22:52 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 05:22:56 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01666 seconds. 05:23:01 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 05:23:08 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:23:11 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:23:13 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:23:15 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:23:23 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:24:13 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:24:19 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:24:25 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 05:24:28 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:24:42 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 05:24:44 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:24:48 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:24:50 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 05:24:52 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:24:54 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:25:02 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 05:25:40 INFO - PROCESS | 28040 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 05:25:42 INFO - PROCESS | 28040 | Cycle 1(1): loaded http://localhost:35997/tests/dromaeo/cssquery-yui.html (next: http://localhost:35997/tests/dromaeo/cssquery-dojo.html) 05:25:43 INFO - PROCESS | 28040 | RSS: Main: 306380800 05:25:43 INFO - PROCESS | 28040 | 05:25:43 INFO - PROCESS | 28040 | __start_tp_report 05:25:43 INFO - PROCESS | 28040 | _x_x_mozilla_page_load 05:25:43 INFO - PROCESS | 28040 | _x_x_mozilla_page_load_details 05:25:43 INFO - PROCESS | 28040 | |i|pagename|runs| 05:25:43 INFO - PROCESS | 28040 | |0;dojo.html;2553.9106131285403;2565.666463359763;2607.009336452148;2607.960880586791;2617.908373206938;4550.590446859782;4627.097715945392;4684.18026845302;4705.482396936339;4725.054989002196;4639.65202609804;4668.113058518879;4686.695364801286;4743.976280118594;4744.454387745411;4283.528811830696;4314.288142456507;4325.437693099892;4348.565143485642;4417.668674849383;4363.214621368153;4409.911801763963;4440.888977775549;4455.376247325377;4500.8874778130485;4203.26442872496;4251.192273468062;4321.286987647034;4363.956360436403;4382.211201983641;4274.5939135782055;4297.935530967038;4311.310190369526;4342.066455712037;4397.780110994469;4263.040815816447;4272.914541709149;4289.785510724482;4300.935485967713;4346.521882592944;4675.462321832999;4708.693934894255;4708.788104535304;4723.409573803275;4743.217369134089;4828.179209534387;4886.828960986384;4887.315775791392;4982.153033984195;5013.423456302536;5043.646944713872;5046.394432668103;5053.140966035783;5099.796008159669;5105.310783044279;4719.646026548023;4720.173969555314;4720.33915251865;4724.929126063112;4783.1868582341085;4940.110780059624;4988.825391111366;5086.898262034739;5131.666441681279;5185.533302002837;4942.555170034714;4960.975195124073;4966.8758281043265;5022.422421421583;5024.974875125601;5019.824306149268;5028.949710502849;5029.396472423333;5029.622778291569;5089.872753181126;4876.561109500162;4990.10178167926;5004.374453193351;5062.190049592121;5064.772085256172;4864.805407783649;4969.701817890938;4988.6757360771435;4990.850274491771;4992.176290911959;4145.751254924714;4182.874513764531;4191.245575796386;4192.874213773592;4274.786260686953;3686.060054686038;3689.2805902849223;3693.501377314028;3739.420389839579;3740.7942563159286;4228.302330115496;4230.915381692349;4232.026633874226;4233.1956928183545;4283.0363168286885;4952.975235123801;5013.498650134958;5019.82430614934;5072.188449848007;5075.137226671474;4222.852200172979;4251.404803327537;4253.787310634456;4293.0769884474985;4303.053328267776;4540.77296135192;4548.499665036843;4552.453705555288;4553.2942393929;4605.792739326671;4591.104734576859;4617.215073437456;4739.549742774431;4793.185158523129;4830.420349558076;5105.055564720538;5109.770060347368;5110.540051395392;5153.098207813692;5168.638195326291;4793.664443488922;4796.352492413619;4800.639952003544;4808.134535783593;4861.902761944671;4798.73606951621;4802.73584952831;4921.163402221559;5020.6234532410945;5079.9238011429115;5012.8496145115705;5030.0945829751;5038.269450929668;5096.490350964874;5103.132467480612;4895.118878601886;4901.3138160658245;4906.509349065065;4928.802847886044;4969.900601988013;4759.0719809636785;4798.928016079692;4922.138625740553;4923.876903077308;4983.601311894967;4818.036392721539;4841.176999909953;4855.295982082649;4857.125717370907;4905.852824415273;4952.133376659142;4955.083309587738;4956.653034287565;4961.6030717543235;4990.72551009698;4646.721196728207;4669.159551280666;4693.366395536696;4718.891060600825;4804.8318308859025 05:25:43 INFO - PROCESS | 28040 | |1;ext.html;556.043604999401;567.8466813960231;571.6170165988785;577.4543056811312;578.6759414727755;29519.55720664192;38831.41752873705;40246.39630405546;40273;43232.35151472731;39973.60026399735;40347.59652403475;40358.59641403585;40468.392974105336;40513.797431012805;7591.810204744884;7725.459217854753;7737;7738.380929525624;7738.922610773877;7557.848843023164;7635.847283054336;7640.235976402371;7649.923500764977;7654.387648988096;7671.961640191791;7721.459497835153;7745;7764.340031097336;7772.455928085036;7673.309402153805;7691.423143264222;7701.114371847198;7709.421793365464;7711.614419279042;7489.10130784304;7551.509151905108;7551.546907185587;7552.207018263058;7553.7356192533;37514.68581113152;37525.24949500995;37866.62133378686;37886;37905.81047094774;3032.2570970112242;3058.617672790901;3063.111697607691;3295.24209431832;3312.519684645737;28604.85697571499;28753.424931501253;28788.280292992633;28873.56689649657;29644.258893527833;3303.174206448388;3415.043787739437;3467.3758723429773;3513.472979053137;3553.093961039944;257301;258701;259294.70352648303;260485;260959;31135.221619459695;32177.51733723996;54177.18734218911;54589;54751.452485474634;32730.181745456553;33073;33254.50118248228;33281.500777488356;33310;12071.939640301742;12122.636320910387;12190;12207.572734954234;12208.877911220952;9804.068613481708;9830.115289623967;9856.457894815854;9909.157721593745;9942.850857237147;7746.728864489716;7785.688572457151;7803.570803605856;7885.211478852184;7895.447318687751;3073.339232065072;3083.691630836943;3101.1936896406646;3114.8909788157307;3149.1969547765175;825.6986200037063;856.7858035491128;857.6740838481337;881.5768431153083;925.0102390442162;24877.751222487906;26645;27481.587776183373;27557.586636200474;27700.861495692392;909.4952301472614;922.5479515037717;971.145392054987;979.7942432089199;993.9850902236473;14120.788188177186;14211.50259740904;14257.92871035659;14527.273636318141;14600.415983360546;368132;374592;375213;375830;378269.8470629972;47488;48110.27834582484;48158.27762583564;48219.5178048215;48319.27521087186;1038.5638032026568;1100.9669709908555;1101.8292164714483;1154.370867877009;1163.2148299897535;26239.475210496064;27817.304567385978;28632;30601.387972239987;31120.377592448476;46179;46786.29820552762;46838.08200139073;46849.06301874012;46882.296765547864;322816;325392;325597;325791;326197;21213.787862121797;22344.553108938057;24612.138575149784;24629;25056.74943250617;38166;39500.604993949695;40042.79978600088;40089.59910400859;40127;33989.83005084959;34301.48547771835;34648;34846.651533485354;34913.12717182091;33444.83277583597;33650.15874603154;33657;34049.65950340465;34163.14592135217;33713.15717107092;33993.320133597685;34176.120313383006;34888.47667284942;34905.30189396147;28758.856205719676;30636.540451892793;30980.22549436282;31094.22264443407;31157.221069472536;23841.880790595937;24097.03611855506;24221;24434.63348049745;24610.753892460845 05:25:43 INFO - PROCESS | 28040 | |2;jquery.html;359.60084306419867;369.7966118634751;370.3075249283839;383.23520189527244;390.9218156368727;15525.301361438735;17045.488635340946;17385.652286954253;17450.47648570545;17472;16001.119938403383;16365.5908602285;16923.238454269558;17010.06444645544;17020.319187232526;4892.584130348924;5118.07874582575;5121.462246464123;5122.846314610568;5125.666831655949;3708.4993525874065;3774.75464094833;3897.57126716061;5024.949750502485;5118.513741194581;3829.6553310202075;5982.73077711504;5985.521158307325;5989.101634754778;6008.669523176223;5078.21287700407;5350.866228344323;5871.148683440899;5881.441263080001;5882.970585147068;5247.291615631879;5292.364916210079;5297.7880884764945;5300.204969254604;5301.469853014706;11795.764084718343;11846.407679616072;11873.94063029688;11976.520939162423;12084.335361555111;1775.1301862087485;1824.3797108982876;1826.6894627913155;1909.0836398528784;2079.9808094033965;8761.167689069529;9063.41087829289;9411.294152938557;9649.758756031086;9706.369086009387;1658.7346024636001;1660.7757952676475;1667.9332826686918;1684.3094331324098;1687.3503701075174;60851.69574152145;70781.99999999949;71125;71954.64022679852;72166.63916680435;9827.754306142404;10143.137833284254;10153.949230253802;10315.638952636622;10338.793224135476;14053.85946140546;14075;14075.507357242448;14103.576892693236;14115.85884141166;6734.127876471049;6777.525573209927;6814.965925170442;6845.931540684629;7043.718251269995;6209.254889413209;6292.874142517124;6425.775097871552;6434.7747828826705;6444.097826304321;4254.212970600449;4262.552431994596;4305.375720520507;4357.324614684729;4425.734455932655;1733.2061316537324;1791.578978939948;1805.1425572853052;1848.4639454558296;1855;802.2098233240254;806.6249194124761;812.7399232245625;825.2613910550024;857.5326447086353;16162.191890405433;16226.918865405598;16468.6706265874;16836.494905152864;16872.325106995584;794.265304593249;834.8956380452444;840.0717207485641;882.5057967538199;904.4844438669895;9000.36997410175;9471.668491602899;9508.47703376307;9606.608773544944;9633;399258;399725;401338;405284;409082;81735.59132204301;84384.57807711045;84625.57687211524;84804;85911.5704421474;899.6221586933503;905.2531661379388;939.5114540438933;941.6657086734248;946.8911075226437;15359.692806144038;15468.303926323568;16131.596710082342;16345.836541634908;16360.836391635932;37432.81283593565;37677.62322376851;38075.61924380721;38622.80688596539;39087.6091239084;51116.48883511117;52289;52500.474995249555;53785.731071344395;55195.448045520636;6376.489880809617;6541.345865413611;6620.933790662224;7139.535930164523;7196.532225405332;10932.508037138507;11193.944030279796;11524.481398336928;11573.363465009505;12320.938395307967;10107.747306317107;10256.230782691178;10545.367277963347;10710.625128120479;10811.945940270249;10012.148967337858;10027.749306267402;10165.542550585093;10168.593256269962;10562.524686389284;10023.298369114093;10203.795924081625;10270.948645256725;10442.843357349493;10728.678139655824;6561.967190164019;6652.301508341555;6707.698153583003;6790.626515541495;6976.267491913276;9773.804523909339;9986.550605222637;9988.800223995624;10222.948885255526;10804.891951080388 05:25:43 INFO - PROCESS | 28040 | |3;mootools.html;1225.5342969671535;1327.946882124715;1370.2600595678334;1425.5865798918314;1692.7291633338662;6290.4653104486115;7253.637318134092;7503.587302698363;7512.849743005137;7558.395328373731;7413.703451861932;7561.357284630799;7563.432742544317;7809.101953275375;7814.765557033298;2166.155199472207;2203.5923354179527;2205.834562407818;2213.4908970936694;2214.9557008859815;2110.873347599141;2152.5802468518646;2187.223535644847;2189.978100219001;2190.726159230096;2143.9892800535977;2145.495808485005;2151.7848215178515;2157.2665293800105;2194.9122035118576;2104.4002459299104;2115.3230966090705;2117.301290574107;2117.375374264596;2117.6188286108572;2069.3584988653565;2115.386537904006;2116.968245476319;2120;2120.1731324783345;7513.774586762406;7748.263914928073;7770.4560680752365;7806.375489960789;7840.333571646417;4313.805878735465;4514.142312960527;4516.458025037016;4525.185466616008;4528;2707.6344693466326;2836.6737825150167;2876.8417737024665;2878.337982264091;2897.3480966782517;1031.582209205273;1036.740814796301;1037.7976294622551;1049.6693541534391;1053.489057806963;9798.363106398132;9866.80266394668;9885.802283954281;9945.950270248602;9992.45041522716;3845.1732877431486;4212.957870421256;4217.62041416274;4247.66018718508;4262.765547894834;8665.17680820321;8722.520261385558;8741.169588889044;8743.081976392386;8753.956230218935;4518.796654150571;4520.59314661682;4529.8641040768825;4530.569595888385;4531.45622525299;3424.4520876659617;3612.6206748291575;3760.830762615689;4101.26177288091;4103.425520427142;3590.5278835677245;3680.245549662313;3739.2147648994014;3766.548014238309;3771.792551409644;1208.160328571652;1209.848768903887;1225.522046401904;1225.7548490301974;1228.42264135856;728.5519405565645;754.1101500229781;764.3044829205508;766.7163149634559;772.8222508823002;4753.548412900838;4768.403949506312;4822.42130944289;5213.817516386984;5307.6019298552765;809.8825670277777;824.4105464592725;844.3835999720238;869.5217630303308;881.1364862434722;3234.6280177779386;3250.089974807058;3277.836108194581;3333.599968003855;3335.6164041135094;9150.86273705895;9497.382670126557;9558.761030974143;9579.377340472847;9580.904190958141;9309.906900931039;9547.90452095484;9553.665621703207;9554.378965367228;9573.90426095744;7067.92932070683;7257.963710181521;7266.382357499566;7267.818304542323;7269.781906542918;4849.7264346566635;4937.432195297587;4981.078500477423;5050.823221187241;5108.897822043613;8524.232819046316;8688.218060374596;8879.11208879107;8967.372283940322;9051.456912585267;8935.821283574161;9107.908920910706;9109.453432794053;9197.218236449977;9270.072992700676;6546.214454265519;6655.833604159935;6686.53194276396;6705.329467053256;6707.061011458302;7477.252274772479;7518.36093932;7550.90511875764;7559.470837041355;7562.924370756222;6606.484399426139;6687.565308254948;6716.3955244028275;6720.126383570105;6739.224989126314;6370.713317900798;6559.0817285581015;6584.637844918384;6598.37315455031;6629.966850165718;5836.620619659879;5923.911141332969;5937.901488224692;5947.851303717442;5949.19685842423;4172.415861779414;4364.454443194601;4367.606915377632;4472.239719247801;4553.3397657340165;4092.4270602115134;4232;4269.316909294498;4311.396404503309;4312.5687431257875 05:25:43 INFO - PROCESS | 28040 | |4;prototype.html;303.33720820008284;303.6053130929792;310.39473027596193;314.1001032043197;314.2285688634403;4736.786844591993;4745.274959157063;4753.952460475394;4757.310190022449;4762.452317983429;4481.7983190756495;4686.08621318843;4693.2256177730715;4720.221163508026;4735.5974742146955;3639.909002274951;3645.671889529942;3741.644543768338;3761.62383761623;3768.811559422018;3725.9254814903684;3748.3815170496837;3753.7372383933134;3757.7369584129124;3781.1492414206723;3518;3708.332500149972;3714.405695088786;3718.4608231806506;3719.4978677878544;3574.749767516275;3615.132368231619;3639.290338384016;3676.246369494247;3743.4571987061995;3316.5025246213263;3330.467125259971;3331.1505566080737;3331.6335203127637;3343.983280083584;4588.082383523309;4611.377464042345;4612.538746125394;4630.374899388573;4640.584621690383;4081.6326530612387;4296.63478604319;4303.160883627694;4308.612224899774;4330.545292744248;4972.359121489936;4978.576820970222;4991.700497970133;4992.176290911995;4993.425756038066;3698.056995466166;3702.5927148013698;3703.0742314421395;3708.9258214835554;3718.1076541629814;4962.3548938638105;5130.974345128325;5214.582833373359;5223.921641175385;5252.1596544552685;3733.104055026774;3743.9251214975548;3748.175401411685;3753.5495740511315;3763.6989040876665;3809.7333186676665;3817.8091095445116;3846.9807650961566;3857.9421308680394;3859.7877116758846;4303.698741088094;4312.37470566766;4322.891927701832;4331.761753103547;4335.135891566657;4692.507286734844;4858.684185527929;4936.851894443173;4950.2822090796635;4983.9252411213865;1300.947962081525;1318.3671837518045;1322.9007824413206;1327.143992125074;1327.183781974079;848.9278411334982;857.2113655437013;858.2490320969152;864.9015749997594;896.2561074308309;4213.1784302060805;4309.956900430955;4310.762908040025;4313.827446902152;4346.782660866944;5119.283300337956;5119.564836988823;5119.974400127976;5123.927311961132;5141.691498510101;4297.39836422901;4304.182205380967;4309.59058889405;4322.956770432318;4325.935110973338;2582.2253324002722;2712.9555121278054;2715.633389492433;2716.9592456113173;2717.2935036890153;4827.734474603861;4837.7097374157665;4858.82994095205;4876.609871210366;4883.4628190898975;4983.252512123138;5257.211418287287;5267.604929630216;5282.947170528322;5295.258663787073;4822.421309442819;4861.756912154378;4880.75429839153;4884.340614017062;4888.120138375127;5162;5168.741562921764;5182.8963420732125;5204.230561609071;5227.398849132246;4840.507138823579;5002.6498145130945;5069.695818250917;5070.923936141035;5077.517635824591;4843.152448321459;4844.152273352079;4861.295112208781;4868.90262194747;4873.95126048735;3671.5777685565436;3699.6115407881784;3716.7398282121076;3717.107894105341;3721.8697345592773;4917.901641967069;5177.611679124156;5209.7395130244095;5227.163653815372;5227.3465816772905;4990.855760870628;4992.850214493571;4997.900041999213;5007.649464537593;5030.471800461045;4983.800647974041;4994.300797888372;4999.67502112376;5028.421731500778;5059.974700126476;4789.329493870791;4906.754662266943;4925.679830810986;4926.704397736147;4928.531789479994;4786.545278198566;4887.193613053949;4893.314935908905;4971.527704868032;4988.42633097184;4873.220284754422;4876.29293752411;4876.29293752411;4881.951180488291;4908.11653902301 05:25:43 INFO - PROCESS | 28040 | |5;yui.html;603.8520562462197;625.3746253746257;636.9426751592356;682.7542084849454;685.6331862453588;11543.653690389292;13221.20672759635;13360.59918202453;13365.398557064931;13378.130421522606;13070.215787052783;13077.54228601999;13114.278714670689;13151.079424440293;13204.405801738922;754.6717178027576;764.8087978005499;765.334159281426;765.7319938021703;768.5542385416445;609.5732986909159;624.793818040048;747.3871425431149;773.6557232031748;777.8755399136139;809.7327881799022;812.3907069697726;812.7805492517047;812.8536863364592;812.8983877015373;807.2089352434589;808.2281421242758;808.2846680687575;808.4421748993205;808.6603626476865;477.8948631301108;485.912535743566;574.3108270075884;585.4847733994101;595.3718826637895;12061.638150855488;12152.21010634306;12161.209521381083;12166.939165304206;12183.573574924834;11637.185397022211;11972.981589224579;12170.330631815246;12195.573154939624;12490.937545312216;9472.715818525456;9687.51562421876;9742.171915387129;11478.311301321864;11579.305241685526;4030.6775457963295;4083.0404854859084;4084.223997440477;4108.424820525129;4136;61525;61687;62768;62907;63669.68165159145;9277.628894844265;9361.485118318558;9450.952745236229;9550.522473876417;9676.322657414054;16889.32442702278;16936.983780972936;16952.74570881438;16982.830171698126;16985.91507042457;6125.693715314216;6162.845928851814;6416.743330266737;6500.837479062967;6507.707153178024;3437.845296961643;3467.791932484059;3475.878344257939;3483.26851361217;3514.4728290756593;2861.5993760873494;2922.3570814420796;2932.736053755172;2941.720536549067;2987.7908546401545;473.1483330005976;473.8294214082927;478.5836322399465;483.86935527407405;486.23660852461296;400.18362540417803;426.83353492138093;451.8666993237003;490.340492038208;511.4144304771091;6956.756513522002;6975.3374123621115;7133.678984445713;7457.7016919323705;7824.37405007598;491.7983626713102;491.8721132505503;503.3154909323317;506.42715641151295;513.5506431872112;3344.297697483507;3502.3170481755815;3589.2821435712963;3639.5450568678916;3752.249550089993;59874.40125598775;85394.5730271357;101873.49063254637;108681.45659271652;108889;87181.5640921804;88385.55807221051;88458.55770721105;89710.55144724235;93473.5326323364;78207;78588;80034;80112.19887801164;80521;6836.145481814773;7003.154259745575;7111.111111111111;7137.0365000726315;7229.855402892018;46727;47297.29054064123;48479.27281090716;49433.25850112323;50047.74976125096;37382.25235495329;38136;38326.61673383231;59393.40606593879;65725.67137164476;8495.150484951455;8519.872201916853;8558.443701159405;8658.39391242607;8681.045085040514;9865.704028879145;9976.05227503386;10019.398836069859;10067.295289329677;10188.439635820101;8693.739187824376;8909.287257019552;8919.152680495343;8999.055099214489;9276.62893484253;9039.141281578239;9158.862617060617;9272.768180795534;9291.67479138227;9673.613055477703;8395.202455766692;8503.362247831314;8546.700865469678;9125.954370228372;9500.097490738368;8111.391645626483;8207.302379297827;8235.13531079252;8291.129431409856;8371.748847534584;7291.125064992023;7685.961570192113;7817.140114587504;7850.975375759633;8024.719134830487 05:25:43 INFO - PROCESS | 28040 | __end_tp_report 05:25:43 INFO - PROCESS | 28040 | __start_cc_report 05:25:43 INFO - PROCESS | 28040 | _x_x_mozilla_cycle_collect,1003 05:25:43 INFO - PROCESS | 28040 | __end_cc_report 05:25:43 INFO - PROCESS | 28040 | __startTimestamp1474201543140__endTimestamp 05:25:43 INFO - PROCESS | 28040 | 05:25:43 INFO - PROCESS | 28040 | ------- Summary: start ------- 05:25:43 INFO - PROCESS | 28040 | Number of tests: 6 05:25:43 INFO - PROCESS | 28040 | 05:25:43 INFO - PROCESS | 28040 | [#0] dojo.html Cycles:165 Average:4639.00 Median:4783.19 stddev:495.64 (10.4%) stddev-sans-first:469.39 05:25:43 INFO - PROCESS | 28040 | Values: 2553.9 2565.7 2607.0 2608.0 2617.9 4550.6 4627.1 4684.2 4705.5 4725.1 4639.7 4668.1 4686.7 4744.0 4744.5 4283.5 4314.3 4325.4 4348.6 4417.7 4363.2 4409.9 4440.9 4455.4 4500.9 4203.3 4251.2 4321.3 4364.0 4382.2 4274.6 4297.9 4311.3 4342.1 4397.8 4263.0 4272.9 4289.8 4300.9 4346.5 4675.5 4708.7 4708.8 4723.4 4743.2 4828.2 4886.8 4887.3 4982.2 5013.4 5043.6 5046.4 5053.1 5099.8 5105.3 4719.6 4720.2 4720.3 4724.9 4783.2 4940.1 4988.8 5086.9 5131.7 5185.5 4942.6 4961.0 4966.9 5022.4 5025.0 5019.8 5028.9 5029.4 5029.6 5089.9 4876.6 4990.1 5004.4 5062.2 5064.8 4864.8 4969.7 4988.7 4990.9 4992.2 4145.8 4182.9 4191.2 4192.9 4274.8 3686.1 3689.3 3693.5 3739.4 3740.8 4228.3 4230.9 4232.0 4233.2 4283.0 4953.0 5013.5 5019.8 5072.2 5075.1 4222.9 4251.4 4253.8 4293.1 4303.1 4540.8 4548.5 4552.5 4553.3 4605.8 4591.1 4617.2 4739.5 4793.2 4830.4 5105.1 5109.8 5110.5 5153.1 5168.6 4793.7 4796.4 4800.6 4808.1 4861.9 4798.7 4802.7 4921.2 5020.6 5079.9 5012.8 5030.1 5038.3 5096.5 5103.1 4895.1 4901.3 4906.5 4928.8 4969.9 4759.1 4798.9 4922.1 4923.9 4983.6 4818.0 4841.2 4855.3 4857.1 4905.9 4952.1 4955.1 4956.7 4961.6 4990.7 4646.7 4669.2 4693.4 4718.9 4804.8 05:25:43 INFO - PROCESS | 28040 | 05:25:43 INFO - PROCESS | 28040 | [#1] ext.html Cycles:180 Average:45823.41 Median:19213.30 stddev:85271.78 (443.8%) stddev-sans-first:85443.25 05:25:43 INFO - PROCESS | 28040 | Values: 556.0 567.8 571.6 577.5 578.7 29519.6 38831.4 40246.4 40273.0 43232.4 39973.6 40347.6 40358.6 40468.4 40513.8 7591.8 7725.5 7737.0 7738.4 7738.9 7557.8 7635.8 7640.2 7649.9 7654.4 7672.0 7721.5 7745.0 7764.3 7772.5 7673.3 7691.4 7701.1 7709.4 7711.6 7489.1 7551.5 7551.5 7552.2 7553.7 37514.7 37525.2 37866.6 37886.0 37905.8 3032.3 3058.6 3063.1 3295.2 3312.5 28604.9 28753.4 28788.3 28873.6 29644.3 3303.2 3415.0 3467.4 3513.5 3553.1 257301.0 258701.0 259294.7 260485.0 260959.0 31135.2 32177.5 54177.2 54589.0 54751.5 32730.2 33073.0 33254.5 33281.5 33310.0 12071.9 12122.6 12190.0 12207.6 12208.9 9804.1 9830.1 9856.5 9909.2 9942.9 7746.7 7785.7 7803.6 7885.2 7895.4 3073.3 3083.7 3101.2 3114.9 3149.2 825.7 856.8 857.7 881.6 925.0 24877.8 26645.0 27481.6 27557.6 27700.9 909.5 922.5 971.1 979.8 994.0 14120.8 14211.5 14257.9 14527.3 14600.4 368132.0 374592.0 375213.0 375830.0 378269.8 47488.0 48110.3 48158.3 48219.5 48319.3 1038.6 1101.0 1101.8 1154.4 1163.2 26239.5 27817.3 28632.0 30601.4 31120.4 46179.0 46786.3 46838.1 46849.1 46882.3 322816.0 325392.0 325597.0 325791.0 326197.0 21213.8 22344.6 24612.1 24629.0 25056.7 38166.0 39500.6 40042.8 40089.6 40127.0 33989.8 34301.5 34648.0 34846.7 34913.1 33444.8 33650.2 33657.0 34049.7 34163.1 33713.2 33993.3 34176.1 34888.5 34905.3 28758.9 30636.5 30980.2 31094.2 31157.2 23841.9 24097.0 24221.0 24434.6 24610.8 05:25:43 INFO - PROCESS | 28040 | 05:25:43 INFO - PROCESS | 28040 | [#2] jquery.html Cycles:180 Average:24629.27 Median:4258.38 stddev:66717.78 (1566.7%) stddev-sans-first:66880.05 05:25:43 INFO - PROCESS | 28040 | Values: 359.6 369.8 370.3 383.2 390.9 15525.3 17045.5 17385.7 17450.5 17472.0 16001.1 16365.6 16923.2 17010.1 17020.3 4892.6 5118.1 5121.5 5122.8 5125.7 3708.5 3774.8 3897.6 5024.9 5118.5 3829.7 5982.7 5985.5 5989.1 6008.7 5078.2 5350.9 5871.1 5881.4 5883.0 5247.3 5292.4 5297.8 5300.2 5301.5 11795.8 11846.4 11873.9 11976.5 12084.3 1775.1 1824.4 1826.7 1909.1 2080.0 8761.2 9063.4 9411.3 9649.8 9706.4 1658.7 1660.8 1667.9 1684.3 1687.4 60851.7 70782.0 71125.0 71954.6 72166.6 9827.8 10143.1 10153.9 10315.6 10338.8 14053.9 14075.0 14075.5 14103.6 14115.9 6734.1 6777.5 6815.0 6845.9 7043.7 6209.3 6292.9 6425.8 6434.8 6444.1 4254.2 4262.6 4305.4 4357.3 4425.7 1733.2 1791.6 1805.1 1848.5 1855.0 802.2 806.6 812.7 825.3 857.5 16162.2 16226.9 16468.7 16836.5 16872.3 794.3 834.9 840.1 882.5 904.5 9000.4 9471.7 9508.5 9606.6 9633.0 399258.0 399725.0 401338.0 405284.0 409082.0 81735.6 84384.6 84625.6 84804.0 85911.6 899.6 905.3 939.5 941.7 946.9 15359.7 15468.3 16131.6 16345.8 16360.8 37432.8 37677.6 38075.6 38622.8 39087.6 51116.5 52289.0 52500.5 53785.7 55195.4 6376.5 6541.3 6620.9 7139.5 7196.5 10932.5 11193.9 11524.5 11573.4 12320.9 10107.7 10256.2 10545.4 10710.6 10811.9 10012.1 10027.7 10165.5 10168.6 10562.5 10023.3 10203.8 10270.9 10442.8 10728.7 6562.0 6652.3 6707.7 6790.6 6976.3 9773.8 9986.6 9988.8 10222.9 10804.9 05:25:43 INFO - PROCESS | 28040 | 05:25:43 INFO - PROCESS | 28040 | [#3] mootools.html Cycles:180 Average:5003.70 Median:5015.95 stddev:2804.81 (55.9%) stddev-sans-first:2798.31 05:25:43 INFO - PROCESS | 28040 | Values: 1225.5 1327.9 1370.3 1425.6 1692.7 6290.5 7253.6 7503.6 7512.8 7558.4 7413.7 7561.4 7563.4 7809.1 7814.8 2166.2 2203.6 2205.8 2213.5 2215.0 2110.9 2152.6 2187.2 2190.0 2190.7 2144.0 2145.5 2151.8 2157.3 2194.9 2104.4 2115.3 2117.3 2117.4 2117.6 2069.4 2115.4 2117.0 2120.0 2120.2 7513.8 7748.3 7770.5 7806.4 7840.3 4313.8 4514.1 4516.5 4525.2 4528.0 2707.6 2836.7 2876.8 2878.3 2897.3 1031.6 1036.7 1037.8 1049.7 1053.5 9798.4 9866.8 9885.8 9946.0 9992.5 3845.2 4213.0 4217.6 4247.7 4262.8 8665.2 8722.5 8741.2 8743.1 8754.0 4518.8 4520.6 4529.9 4530.6 4531.5 3424.5 3612.6 3760.8 4101.3 4103.4 3590.5 3680.2 3739.2 3766.5 3771.8 1208.2 1209.8 1225.5 1225.8 1228.4 728.6 754.1 764.3 766.7 772.8 4753.5 4768.4 4822.4 5213.8 5307.6 809.9 824.4 844.4 869.5 881.1 3234.6 3250.1 3277.8 3333.6 3335.6 9150.9 9497.4 9558.8 9579.4 9580.9 9309.9 9547.9 9553.7 9554.4 9573.9 7067.9 7258.0 7266.4 7267.8 7269.8 4849.7 4937.4 4981.1 5050.8 5108.9 8524.2 8688.2 8879.1 8967.4 9051.5 8935.8 9107.9 9109.5 9197.2 9270.1 6546.2 6655.8 6686.5 6705.3 6707.1 7477.3 7518.4 7550.9 7559.5 7562.9 6606.5 6687.6 6716.4 6720.1 6739.2 6370.7 6559.1 6584.6 6598.4 6630.0 5836.6 5923.9 5937.9 5947.9 5949.2 4172.4 4364.5 4367.6 4472.2 4553.3 4092.4 4232.0 4269.3 4311.4 4312.6 05:25:43 INFO - PROCESS | 28040 | 05:25:43 INFO - PROCESS | 28040 | [#4] prototype.html Cycles:180 Average:4153.77 Median:4736.19 stddev:1190.04 (25.1%) stddev-sans-first:1157.76 05:25:43 INFO - PROCESS | 28040 | Values: 303.3 303.6 310.4 314.1 314.2 4736.8 4745.3 4754.0 4757.3 4762.5 4481.8 4686.1 4693.2 4720.2 4735.6 3639.9 3645.7 3741.6 3761.6 3768.8 3725.9 3748.4 3753.7 3757.7 3781.1 3518.0 3708.3 3714.4 3718.5 3719.5 3574.7 3615.1 3639.3 3676.2 3743.5 3316.5 3330.5 3331.2 3331.6 3344.0 4588.1 4611.4 4612.5 4630.4 4640.6 4081.6 4296.6 4303.2 4308.6 4330.5 4972.4 4978.6 4991.7 4992.2 4993.4 3698.1 3702.6 3703.1 3708.9 3718.1 4962.4 5131.0 5214.6 5223.9 5252.2 3733.1 3743.9 3748.2 3753.5 3763.7 3809.7 3817.8 3847.0 3857.9 3859.8 4303.7 4312.4 4322.9 4331.8 4335.1 4692.5 4858.7 4936.9 4950.3 4983.9 1300.9 1318.4 1322.9 1327.1 1327.2 848.9 857.2 858.2 864.9 896.3 4213.2 4310.0 4310.8 4313.8 4346.8 5119.3 5119.6 5120.0 5123.9 5141.7 4297.4 4304.2 4309.6 4323.0 4325.9 2582.2 2713.0 2715.6 2717.0 2717.3 4827.7 4837.7 4858.8 4876.6 4883.5 4983.3 5257.2 5267.6 5282.9 5295.3 4822.4 4861.8 4880.8 4884.3 4888.1 5162.0 5168.7 5182.9 5204.2 5227.4 4840.5 5002.6 5069.7 5070.9 5077.5 4843.2 4844.2 4861.3 4868.9 4874.0 3671.6 3699.6 3716.7 3717.1 3721.9 4917.9 5177.6 5209.7 5227.2 5227.3 4990.9 4992.9 4997.9 5007.6 5030.5 4983.8 4994.3 4999.7 5028.4 5060.0 4789.3 4906.8 4925.7 4926.7 4928.5 4786.5 4887.2 4893.3 4971.5 4988.4 4873.2 4876.3 4876.3 4882.0 4908.1 05:25:43 INFO - PROCESS | 28040 | 05:25:43 INFO - PROCESS | 28040 | [#5] yui.html Cycles:180 Average:16939.34 Median:31696.69 stddev:25636.72 (80.9%) stddev-sans-first:25679.30 05:25:43 INFO - PROCESS | 28040 | Values: 603.9 625.4 636.9 682.8 685.6 11543.7 13221.2 13360.6 13365.4 13378.1 13070.2 13077.5 13114.3 13151.1 13204.4 754.7 764.8 765.3 765.7 768.6 609.6 624.8 747.4 773.7 777.9 809.7 812.4 812.8 812.9 812.9 807.2 808.2 808.3 808.4 808.7 477.9 485.9 574.3 585.5 595.4 12061.6 12152.2 12161.2 12166.9 12183.6 11637.2 11973.0 12170.3 12195.6 12490.9 9472.7 9687.5 9742.2 11478.3 11579.3 4030.7 4083.0 4084.2 4108.4 4136.0 61525.0 61687.0 62768.0 62907.0 63669.7 9277.6 9361.5 9451.0 9550.5 9676.3 16889.3 16937.0 16952.7 16982.8 16985.9 6125.7 6162.8 6416.7 6500.8 6507.7 3437.8 3467.8 3475.9 3483.3 3514.5 2861.6 2922.4 2932.7 2941.7 2987.8 473.1 473.8 478.6 483.9 486.2 400.2 426.8 451.9 490.3 511.4 6956.8 6975.3 7133.7 7457.7 7824.4 491.8 491.9 503.3 506.4 513.6 3344.3 3502.3 3589.3 3639.5 3752.2 59874.4 85394.6 101873.5 108681.5 108889.0 87181.6 88385.6 88458.6 89710.6 93473.5 78207.0 78588.0 80034.0 80112.2 80521.0 6836.1 7003.2 7111.1 7137.0 7229.9 46727.0 47297.3 48479.3 49433.3 50047.7 37382.3 38136.0 38326.6 59393.4 65725.7 8495.2 8519.9 8558.4 8658.4 8681.0 9865.7 9976.1 10019.4 10067.3 10188.4 8693.7 8909.3 8919.2 8999.1 9276.6 9039.1 9158.9 9272.8 9291.7 9673.6 8395.2 8503.4 8546.7 9126.0 9500.1 8111.4 8207.3 8235.1 8291.1 8371.7 7291.1 7686.0 7817.1 7851.0 8024.7 05:25:43 INFO - PROCESS | 28040 | -------- Summary: end -------- 05:25:43 INFO - PROCESS | 28040 | 05:25:44 INFO - TEST-INFO | 28040: exit 0 05:25:44 INFO - TEST-OK | dromaeo_css | took 1121365ms 05:25:44 INFO - TEST-START | kraken 05:25:44 INFO - operating with platform_type : linux_ 05:25:44 INFO - Initialising browser for kraken test... 05:25:44 INFO - TEST-INFO | started process 28352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXY4Kpm/profile http://localhost:35997/getInfo.html) 05:25:48 INFO - PROCESS | 28352 | __metrics Screen width/height:1600/1200 05:25:48 INFO - PROCESS | 28352 | colorDepth:24 05:25:48 INFO - PROCESS | 28352 | Browser inner width/height: 1024/697 05:25:48 INFO - PROCESS | 28352 | __metrics 05:25:49 INFO - PROCESS | 28352 | 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" 05:25:49 INFO - PROCESS | 28352 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:25:49 INFO - PROCESS | 28352 | console.error: PushService: 05:25:49 INFO - PROCESS | 28352 | stateChangeProcessEnqueue: Error transitioning state 05:25:49 INFO - PROCESS | 28352 | UnknownError 05:25:50 INFO - TEST-INFO | 28352: exit 0 05:25:50 INFO - Browser initialized. 05:25:50 INFO - Running cycle 1/1 for kraken test... 05:25:50 INFO - TEST-INFO | started process 28433 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXY4Kpm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:26:02 INFO - PROCESS | 28433 | RSS: Main: 174862336 05:26:02 INFO - PROCESS | 28433 | 05:26:05 INFO - PROCESS | 28433 | Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35997/tests/kraken/driver.html?testName=audio-beat-detection) 05:26:06 INFO - PROCESS | 28433 | RSS: Main: 242180096 05:26:06 INFO - PROCESS | 28433 | 05:26:09 INFO - PROCESS | 28433 | Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35997/tests/kraken/driver.html?testName=audio-dft) 05:26:09 INFO - PROCESS | 28433 | RSS: Main: 218394624 05:26:09 INFO - PROCESS | 28433 | 05:26:13 INFO - PROCESS | 28433 | Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35997/tests/kraken/driver.html?testName=audio-fft) 05:26:13 INFO - PROCESS | 28433 | RSS: Main: 300232704 05:26:13 INFO - PROCESS | 28433 | 05:26:15 INFO - PROCESS | 28433 | Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35997/tests/kraken/driver.html?testName=audio-oscillator) 05:26:16 INFO - PROCESS | 28433 | RSS: Main: 210292736 05:26:16 INFO - PROCESS | 28433 | 05:26:18 INFO - PROCESS | 28433 | Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35997/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:26:19 INFO - PROCESS | 28433 | RSS: Main: 213245952 05:26:19 INFO - PROCESS | 28433 | 05:26:22 INFO - PROCESS | 28433 | Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35997/tests/kraken/driver.html?testName=imaging-darkroom) 05:26:23 INFO - PROCESS | 28433 | RSS: Main: 250273792 05:26:23 INFO - PROCESS | 28433 | 05:26:26 INFO - PROCESS | 28433 | Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35997/tests/kraken/driver.html?testName=imaging-desaturate) 05:26:27 INFO - PROCESS | 28433 | RSS: Main: 244211712 05:26:27 INFO - PROCESS | 28433 | 05:26:30 INFO - PROCESS | 28433 | Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35997/tests/kraken/driver.html?testName=json-parse-financial) 05:26:30 INFO - PROCESS | 28433 | RSS: Main: 247185408 05:26:30 INFO - PROCESS | 28433 | 05:26:32 INFO - PROCESS | 28433 | Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35997/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:26:33 INFO - PROCESS | 28433 | RSS: Main: 210427904 05:26:33 INFO - PROCESS | 28433 | 05:26:34 INFO - PROCESS | 28433 | Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35997/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:26:35 INFO - PROCESS | 28433 | RSS: Main: 218050560 05:26:35 INFO - PROCESS | 28433 | 05:26:37 INFO - PROCESS | 28433 | Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35997/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:26:38 INFO - PROCESS | 28433 | RSS: Main: 221683712 05:26:38 INFO - PROCESS | 28433 | 05:26:41 INFO - PROCESS | 28433 | Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35997/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:26:41 INFO - PROCESS | 28433 | RSS: Main: 223723520 05:26:41 INFO - PROCESS | 28433 | 05:26:44 INFO - PROCESS | 28433 | Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35997/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:26:45 INFO - PROCESS | 28433 | RSS: Main: 221507584 05:26:45 INFO - PROCESS | 28433 | 05:26:47 INFO - PROCESS | 28433 | Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35997/tests/kraken/driver.html?testName=ai-astar) 05:26:47 INFO - PROCESS | 28433 | RSS: Main: 271998976 05:26:47 INFO - PROCESS | 28433 | 05:26:47 INFO - PROCESS | 28433 | __start_tp_report 05:26:47 INFO - PROCESS | 28433 | _x_x_mozilla_page_load 05:26:47 INFO - PROCESS | 28433 | _x_x_mozilla_page_load_details 05:26:47 INFO - PROCESS | 28433 | |i|pagename|runs| 05:26:47 INFO - PROCESS | 28433 | |0;ai-astar;114;116;116;114;115;115;113;115;114;115 05:26:47 INFO - PROCESS | 28433 | |1;audio-beat-detection;148;129;131;161;124;123;132;123;164;124 05:26:47 INFO - PROCESS | 28433 | |2;audio-dft;170;161;162;161;161;161;161;161;162;162 05:26:47 INFO - PROCESS | 28433 | |3;audio-fft;76;78;77;110;76;77;78;77;99;77 05:26:47 INFO - PROCESS | 28433 | |4;audio-oscillator;85;85;115;84;84;84;117;85;84;119 05:26:47 INFO - PROCESS | 28433 | |5;imaging-gaussian-blur;117;116;116;117;117;117;116;116;117;117 05:26:47 INFO - PROCESS | 28433 | |6;imaging-darkroom;147;147;146;146;147;146;146;146;147;146 05:26:47 INFO - PROCESS | 28433 | |7;imaging-desaturate;95;95;95;94;95;95;95;95;95;95 05:26:47 INFO - PROCESS | 28433 | |8;json-parse-financial;63;63;62;64;72;66;64;64;64;64 05:26:47 INFO - PROCESS | 28433 | |9;json-stringify-tinderbox;66;66;66;65;66;66;66;66;66;66 05:26:47 INFO - PROCESS | 28433 | |10;stanford-crypto-aes;85;83;83;82;82;83;83;82;83;82 05:26:47 INFO - PROCESS | 28433 | |11;stanford-crypto-ccm;135;146;134;130;131;132;142;133;177;139 05:26:47 INFO - PROCESS | 28433 | |12;stanford-crypto-pbkdf2;179;177;178;177;183;181;184;179;178;175 05:26:47 INFO - PROCESS | 28433 | |13;stanford-crypto-sha256-iterative;70;69;69;69;73;69;69;68;70;67 05:26:47 INFO - PROCESS | 28433 | __end_tp_report 05:26:47 INFO - PROCESS | 28433 | __start_cc_report 05:26:47 INFO - PROCESS | 28433 | _x_x_mozilla_cycle_collect,1915 05:26:47 INFO - PROCESS | 28433 | __end_cc_report 05:26:47 INFO - PROCESS | 28433 | __startTimestamp1474201607473__endTimestamp 05:26:47 INFO - PROCESS | 28433 | 05:26:47 INFO - PROCESS | 28433 | ------- Summary: start ------- 05:26:47 INFO - PROCESS | 28433 | Number of tests: 14 05:26:47 INFO - PROCESS | 28433 | 05:26:47 INFO - PROCESS | 28433 | [#0] ai-astar Cycles:10 Average:114.70 Median:115.00 stddev:0.95 (0.8%) stddev-sans-first:0.97 05:26:47 INFO - PROCESS | 28433 | Values: 114.0 116.0 116.0 114.0 115.0 115.0 113.0 115.0 114.0 115.0 05:26:47 INFO - PROCESS | 28433 | 05:26:47 INFO - PROCESS | 28433 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:131.50 stddev:15.88 (12.1%) stddev-sans-first:16.23 05:26:47 INFO - PROCESS | 28433 | Values: 148.0 129.0 131.0 161.0 124.0 123.0 132.0 123.0 164.0 124.0 05:26:47 INFO - PROCESS | 28433 | 05:26:47 INFO - PROCESS | 28433 | [#2] audio-dft Cycles:10 Average:162.20 Median:161.50 stddev:2.78 (1.7%) stddev-sans-first:0.50 05:26:47 INFO - PROCESS | 28433 | Values: 170.0 161.0 162.0 161.0 161.0 161.0 161.0 161.0 162.0 162.0 05:26:47 INFO - PROCESS | 28433 | 05:26:47 INFO - PROCESS | 28433 | [#3] audio-fft Cycles:10 Average:82.50 Median:77.00 stddev:11.90 (15.5%) stddev-sans-first:12.39 05:26:47 INFO - PROCESS | 28433 | Values: 76.0 78.0 77.0 110.0 76.0 77.0 78.0 77.0 99.0 77.0 05:26:47 INFO - PROCESS | 28433 | 05:26:47 INFO - PROCESS | 28433 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:84.00 stddev:15.77 (18.8%) stddev-sans-first:16.37 05:26:47 INFO - PROCESS | 28433 | Values: 85.0 85.0 115.0 84.0 84.0 84.0 117.0 85.0 84.0 119.0 05:26:47 INFO - PROCESS | 28433 | 05:26:47 INFO - PROCESS | 28433 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:26:47 INFO - PROCESS | 28433 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 05:26:47 INFO - PROCESS | 28433 | 05:26:47 INFO - PROCESS | 28433 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 05:26:47 INFO - PROCESS | 28433 | Values: 147.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 05:26:47 INFO - PROCESS | 28433 | 05:26:47 INFO - PROCESS | 28433 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:26:47 INFO - PROCESS | 28433 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 05:26:47 INFO - PROCESS | 28433 | 05:26:47 INFO - PROCESS | 28433 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:64.00 stddev:2.80 (4.4%) stddev-sans-first:2.91 05:26:47 INFO - PROCESS | 28433 | Values: 63.0 63.0 62.0 64.0 72.0 66.0 64.0 64.0 64.0 64.0 05:26:47 INFO - PROCESS | 28433 | 05:26:47 INFO - PROCESS | 28433 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 05:26:47 INFO - PROCESS | 28433 | Values: 66.0 66.0 66.0 65.0 66.0 66.0 66.0 66.0 66.0 66.0 05:26:47 INFO - PROCESS | 28433 | 05:26:47 INFO - PROCESS | 28433 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:0.92 (1.1%) stddev-sans-first:0.53 05:26:47 INFO - PROCESS | 28433 | Values: 85.0 83.0 83.0 82.0 82.0 83.0 83.0 82.0 83.0 82.0 05:26:47 INFO - PROCESS | 28433 | 05:26:47 INFO - PROCESS | 28433 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:137.00 stddev:14.00 (10.2%) stddev-sans-first:14.74 05:26:47 INFO - PROCESS | 28433 | Values: 135.0 146.0 134.0 130.0 131.0 132.0 142.0 133.0 177.0 139.0 05:26:47 INFO - PROCESS | 28433 | 05:26:47 INFO - PROCESS | 28433 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.10 Median:179.00 stddev:2.81 (1.6%) stddev-sans-first:2.98 05:26:47 INFO - PROCESS | 28433 | Values: 179.0 177.0 178.0 177.0 183.0 181.0 184.0 179.0 178.0 175.0 05:26:47 INFO - PROCESS | 28433 | 05:26:47 INFO - PROCESS | 28433 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:1.57 (2.3%) stddev-sans-first:1.64 05:26:47 INFO - PROCESS | 28433 | Values: 70.0 69.0 69.0 69.0 73.0 69.0 69.0 68.0 70.0 67.0 05:26:47 INFO - PROCESS | 28433 | -------- Summary: end -------- 05:26:47 INFO - PROCESS | 28433 | 05:26:48 INFO - TEST-INFO | 28433: exit 0 05:26:48 INFO - TEST-OK | kraken | took 64704ms 05:26:48 INFO - SUITE-END | took 1186s 05:26:49 INFO - Completed test suite (00:19:46) 05:26:49 INFO - javascript benchmark 05:26:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2553.9106131285403, 2565.666463359763, 2607.009336452148, 2607.960880586791, 2617.908373206938, 4550.590446859782, 4627.097715945392, 4684.18026845302, 4705.482396936339, 4725.054989002196, 4639.65202609804, 4668.113058518879, 4686.695364801286, 4743.976280118594, 4744.454387745411, 4283.528811830696, 4314.288142456507, 4325.437693099892, 4348.565143485642, 4417.668674849383, 4363.214621368153, 4409.911801763963, 4440.888977775549, 4455.376247325377, 4500.8874778130485, 4203.26442872496, 4251.192273468062, 4321.286987647034, 4363.956360436403, 4382.211201983641, 4274.5939135782055, 4297.935530967038, 4311.310190369526, 4342.066455712037, 4397.780110994469, 4263.040815816447, 4272.914541709149, 4289.785510724482, 4300.935485967713, 4346.521882592944, 4675.462321832999, 4708.693934894255, 4708.788104535304, 4723.409573803275, 4743.217369134089, 4828.179209534387, 4886.828960986384, 4887.315775791392, 4982.153033984195, 5013.423456302536, 5043.646944713872, 5046.394432668103, 5053.140966035783, 5099.796008159669, 5105.310783044279, 4719.646026548023, 4720.173969555314, 4720.33915251865, 4724.929126063112, 4783.1868582341085, 4940.110780059624, 4988.825391111366, 5086.898262034739, 5131.666441681279, 5185.533302002837, 4942.555170034714, 4960.975195124073, 4966.8758281043265, 5022.422421421583, 5024.974875125601, 5019.824306149268, 5028.949710502849, 5029.396472423333, 5029.622778291569, 5089.872753181126, 4876.561109500162, 4990.10178167926, 5004.374453193351, 5062.190049592121, 5064.772085256172, 4864.805407783649, 4969.701817890938, 4988.6757360771435, 4990.850274491771, 4992.176290911959, 4145.751254924714, 4182.874513764531, 4191.245575796386, 4192.874213773592, 4274.786260686953, 3686.060054686038, 3689.2805902849223, 3693.501377314028, 3739.420389839579, 3740.7942563159286, 4228.302330115496, 4230.915381692349, 4232.026633874226, 4233.1956928183545, 4283.0363168286885, 4952.975235123801, 5013.498650134958, 5019.82430614934, 5072.188449848007, 5075.137226671474, 4222.852200172979, 4251.404803327537, 4253.787310634456, 4293.0769884474985, 4303.053328267776, 4540.77296135192, 4548.499665036843, 4552.453705555288, 4553.2942393929, 4605.792739326671, 4591.104734576859, 4617.215073437456, 4739.549742774431, 4793.185158523129, 4830.420349558076, 5105.055564720538, 5109.770060347368, 5110.540051395392, 5153.098207813692, 5168.638195326291, 4793.664443488922, 4796.352492413619, 4800.639952003544, 4808.134535783593, 4861.902761944671, 4798.73606951621, 4802.73584952831, 4921.163402221559, 5020.6234532410945, 5079.9238011429115, 5012.8496145115705, 5030.0945829751, 5038.269450929668, 5096.490350964874, 5103.132467480612, 4895.118878601886, 4901.3138160658245, 4906.509349065065, 4928.802847886044, 4969.900601988013, 4759.0719809636785, 4798.928016079692, 4922.138625740553, 4923.876903077308, 4983.601311894967, 4818.036392721539, 4841.176999909953, 4855.295982082649, 4857.125717370907, 4905.852824415273, 4952.133376659142, 4955.083309587738, 4956.653034287565, 4961.6030717543235, 4990.72551009698, 4646.721196728207, 4669.159551280666, 4693.366395536696, 4718.891060600825, 4804.8318308859025], "value": 4606.657447453848, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.043604999401, 567.8466813960231, 571.6170165988785, 577.4543056811312, 578.6759414727755, 29519.55720664192, 38831.41752873705, 40246.39630405546, 40273.0, 43232.35151472731, 39973.60026399735, 40347.59652403475, 40358.59641403585, 40468.392974105336, 40513.797431012805, 7591.810204744884, 7725.459217854753, 7737.0, 7738.380929525624, 7738.922610773877, 7557.848843023164, 7635.847283054336, 7640.235976402371, 7649.923500764977, 7654.387648988096, 7671.961640191791, 7721.459497835153, 7745.0, 7764.340031097336, 7772.455928085036, 7673.309402153805, 7691.423143264222, 7701.114371847198, 7709.421793365464, 7711.614419279042, 7489.10130784304, 7551.509151905108, 7551.546907185587, 7552.207018263058, 7553.7356192533, 37514.68581113152, 37525.24949500995, 37866.62133378686, 37886.0, 37905.81047094774, 3032.2570970112242, 3058.617672790901, 3063.111697607691, 3295.24209431832, 3312.519684645737, 28604.85697571499, 28753.424931501253, 28788.280292992633, 28873.56689649657, 29644.258893527833, 3303.174206448388, 3415.043787739437, 3467.3758723429773, 3513.472979053137, 3553.093961039944, 257301.0, 258701.0, 259294.70352648303, 260485.0, 260959.0, 31135.221619459695, 32177.51733723996, 54177.18734218911, 54589.0, 54751.452485474634, 32730.181745456553, 33073.0, 33254.50118248228, 33281.500777488356, 33310.0, 12071.939640301742, 12122.636320910387, 12190.0, 12207.572734954234, 12208.877911220952, 9804.068613481708, 9830.115289623967, 9856.457894815854, 9909.157721593745, 9942.850857237147, 7746.728864489716, 7785.688572457151, 7803.570803605856, 7885.211478852184, 7895.447318687751, 3073.339232065072, 3083.691630836943, 3101.1936896406646, 3114.8909788157307, 3149.1969547765175, 825.6986200037063, 856.7858035491128, 857.6740838481337, 881.5768431153083, 925.0102390442162, 24877.751222487906, 26645.0, 27481.587776183373, 27557.586636200474, 27700.861495692392, 909.4952301472614, 922.5479515037717, 971.145392054987, 979.7942432089199, 993.9850902236473, 14120.788188177186, 14211.50259740904, 14257.92871035659, 14527.273636318141, 14600.415983360546, 368132.0, 374592.0, 375213.0, 375830.0, 378269.8470629972, 47488.0, 48110.27834582484, 48158.27762583564, 48219.5178048215, 48319.27521087186, 1038.5638032026568, 1100.9669709908555, 1101.8292164714483, 1154.370867877009, 1163.2148299897535, 26239.475210496064, 27817.304567385978, 28632.0, 30601.387972239987, 31120.377592448476, 46179.0, 46786.29820552762, 46838.08200139073, 46849.06301874012, 46882.296765547864, 322816.0, 325392.0, 325597.0, 325791.0, 326197.0, 21213.787862121797, 22344.553108938057, 24612.138575149784, 24629.0, 25056.74943250617, 38166.0, 39500.604993949695, 40042.79978600088, 40089.59910400859, 40127.0, 33989.83005084959, 34301.48547771835, 34648.0, 34846.651533485354, 34913.12717182091, 33444.83277583597, 33650.15874603154, 33657.0, 34049.65950340465, 34163.14592135217, 33713.15717107092, 33993.320133597685, 34176.120313383006, 34888.47667284942, 34905.30189396147, 28758.856205719676, 30636.540451892793, 30980.22549436282, 31094.22264443407, 31157.221069472536, 23841.880790595937, 24097.03611855506, 24221.0, 24434.63348049745, 24610.753892460845], "value": 16043.047510506172, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.60084306419867, 369.7966118634751, 370.3075249283839, 383.23520189527244, 390.9218156368727, 15525.301361438735, 17045.488635340946, 17385.652286954253, 17450.47648570545, 17472.0, 16001.119938403383, 16365.5908602285, 16923.238454269558, 17010.06444645544, 17020.319187232526, 4892.584130348924, 5118.07874582575, 5121.462246464123, 5122.846314610568, 5125.666831655949, 3708.4993525874065, 3774.75464094833, 3897.57126716061, 5024.949750502485, 5118.513741194581, 3829.6553310202075, 5982.73077711504, 5985.521158307325, 5989.101634754778, 6008.669523176223, 5078.21287700407, 5350.866228344323, 5871.148683440899, 5881.441263080001, 5882.970585147068, 5247.291615631879, 5292.364916210079, 5297.7880884764945, 5300.204969254604, 5301.469853014706, 11795.764084718343, 11846.407679616072, 11873.94063029688, 11976.520939162423, 12084.335361555111, 1775.1301862087485, 1824.3797108982876, 1826.6894627913155, 1909.0836398528784, 2079.9808094033965, 8761.167689069529, 9063.41087829289, 9411.294152938557, 9649.758756031086, 9706.369086009387, 1658.7346024636001, 1660.7757952676475, 1667.9332826686918, 1684.3094331324098, 1687.3503701075174, 60851.69574152145, 70781.99999999949, 71125.0, 71954.64022679852, 72166.63916680435, 9827.754306142404, 10143.137833284254, 10153.949230253802, 10315.638952636622, 10338.793224135476, 14053.85946140546, 14075.0, 14075.507357242448, 14103.576892693236, 14115.85884141166, 6734.127876471049, 6777.525573209927, 6814.965925170442, 6845.931540684629, 7043.718251269995, 6209.254889413209, 6292.874142517124, 6425.775097871552, 6434.7747828826705, 6444.097826304321, 4254.212970600449, 4262.552431994596, 4305.375720520507, 4357.324614684729, 4425.734455932655, 1733.2061316537324, 1791.578978939948, 1805.1425572853052, 1848.4639454558296, 1855.0, 802.2098233240254, 806.6249194124761, 812.7399232245625, 825.2613910550024, 857.5326447086353, 16162.191890405433, 16226.918865405598, 16468.6706265874, 16836.494905152864, 16872.325106995584, 794.265304593249, 834.8956380452444, 840.0717207485641, 882.5057967538199, 904.4844438669895, 9000.36997410175, 9471.668491602899, 9508.47703376307, 9606.608773544944, 9633.0, 399258.0, 399725.0, 401338.0, 405284.0, 409082.0, 81735.59132204301, 84384.57807711045, 84625.57687211524, 84804.0, 85911.5704421474, 899.6221586933503, 905.2531661379388, 939.5114540438933, 941.6657086734248, 946.8911075226437, 15359.692806144038, 15468.303926323568, 16131.596710082342, 16345.836541634908, 16360.836391635932, 37432.81283593565, 37677.62322376851, 38075.61924380721, 38622.80688596539, 39087.6091239084, 51116.48883511117, 52289.0, 52500.474995249555, 53785.731071344395, 55195.448045520636, 6376.489880809617, 6541.345865413611, 6620.933790662224, 7139.535930164523, 7196.532225405332, 10932.508037138507, 11193.944030279796, 11524.481398336928, 11573.363465009505, 12320.938395307967, 10107.747306317107, 10256.230782691178, 10545.367277963347, 10710.625128120479, 10811.945940270249, 10012.148967337858, 10027.749306267402, 10165.542550585093, 10168.593256269962, 10562.524686389284, 10023.298369114093, 10203.795924081625, 10270.948645256725, 10442.843357349493, 10728.678139655824, 6561.967190164019, 6652.301508341555, 6707.698153583003, 6790.626515541495, 6976.267491913276, 9773.804523909339, 9986.550605222637, 9988.800223995624, 10222.948885255526, 10804.891951080388], "value": 7978.995886314651, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1225.5342969671535, 1327.946882124715, 1370.2600595678334, 1425.5865798918314, 1692.7291633338662, 6290.4653104486115, 7253.637318134092, 7503.587302698363, 7512.849743005137, 7558.395328373731, 7413.703451861932, 7561.357284630799, 7563.432742544317, 7809.101953275375, 7814.765557033298, 2166.155199472207, 2203.5923354179527, 2205.834562407818, 2213.4908970936694, 2214.9557008859815, 2110.873347599141, 2152.5802468518646, 2187.223535644847, 2189.978100219001, 2190.726159230096, 2143.9892800535977, 2145.495808485005, 2151.7848215178515, 2157.2665293800105, 2194.9122035118576, 2104.4002459299104, 2115.3230966090705, 2117.301290574107, 2117.375374264596, 2117.6188286108572, 2069.3584988653565, 2115.386537904006, 2116.968245476319, 2120.0, 2120.1731324783345, 7513.774586762406, 7748.263914928073, 7770.4560680752365, 7806.375489960789, 7840.333571646417, 4313.805878735465, 4514.142312960527, 4516.458025037016, 4525.185466616008, 4528.0, 2707.6344693466326, 2836.6737825150167, 2876.8417737024665, 2878.337982264091, 2897.3480966782517, 1031.582209205273, 1036.740814796301, 1037.7976294622551, 1049.6693541534391, 1053.489057806963, 9798.363106398132, 9866.80266394668, 9885.802283954281, 9945.950270248602, 9992.45041522716, 3845.1732877431486, 4212.957870421256, 4217.62041416274, 4247.66018718508, 4262.765547894834, 8665.17680820321, 8722.520261385558, 8741.169588889044, 8743.081976392386, 8753.956230218935, 4518.796654150571, 4520.59314661682, 4529.8641040768825, 4530.569595888385, 4531.45622525299, 3424.4520876659617, 3612.6206748291575, 3760.830762615689, 4101.26177288091, 4103.425520427142, 3590.5278835677245, 3680.245549662313, 3739.2147648994014, 3766.548014238309, 3771.792551409644, 1208.160328571652, 1209.848768903887, 1225.522046401904, 1225.7548490301974, 1228.42264135856, 728.5519405565645, 754.1101500229781, 764.3044829205508, 766.7163149634559, 772.8222508823002, 4753.548412900838, 4768.403949506312, 4822.42130944289, 5213.817516386984, 5307.6019298552765, 809.8825670277777, 824.4105464592725, 844.3835999720238, 869.5217630303308, 881.1364862434722, 3234.6280177779386, 3250.089974807058, 3277.836108194581, 3333.599968003855, 3335.6164041135094, 9150.86273705895, 9497.382670126557, 9558.761030974143, 9579.377340472847, 9580.904190958141, 9309.906900931039, 9547.90452095484, 9553.665621703207, 9554.378965367228, 9573.90426095744, 7067.92932070683, 7257.963710181521, 7266.382357499566, 7267.818304542323, 7269.781906542918, 4849.7264346566635, 4937.432195297587, 4981.078500477423, 5050.823221187241, 5108.897822043613, 8524.232819046316, 8688.218060374596, 8879.11208879107, 8967.372283940322, 9051.456912585267, 8935.821283574161, 9107.908920910706, 9109.453432794053, 9197.218236449977, 9270.072992700676, 6546.214454265519, 6655.833604159935, 6686.53194276396, 6705.329467053256, 6707.061011458302, 7477.252274772479, 7518.36093932, 7550.90511875764, 7559.470837041355, 7562.924370756222, 6606.484399426139, 6687.565308254948, 6716.3955244028275, 6720.126383570105, 6739.224989126314, 6370.713317900798, 6559.0817285581015, 6584.637844918384, 6598.37315455031, 6629.966850165718, 5836.620619659879, 5923.911141332969, 5937.901488224692, 5947.851303717442, 5949.19685842423, 4172.415861779414, 4364.454443194601, 4367.606915377632, 4472.239719247801, 4553.3397657340165, 4092.4270602115134, 4232.0, 4269.316909294498, 4311.396404503309, 4312.5687431257875], "value": 4040.4300070012014, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.33720820008284, 303.6053130929792, 310.39473027596193, 314.1001032043197, 314.2285688634403, 4736.786844591993, 4745.274959157063, 4753.952460475394, 4757.310190022449, 4762.452317983429, 4481.7983190756495, 4686.08621318843, 4693.2256177730715, 4720.221163508026, 4735.5974742146955, 3639.909002274951, 3645.671889529942, 3741.644543768338, 3761.62383761623, 3768.811559422018, 3725.9254814903684, 3748.3815170496837, 3753.7372383933134, 3757.7369584129124, 3781.1492414206723, 3518.0, 3708.332500149972, 3714.405695088786, 3718.4608231806506, 3719.4978677878544, 3574.749767516275, 3615.132368231619, 3639.290338384016, 3676.246369494247, 3743.4571987061995, 3316.5025246213263, 3330.467125259971, 3331.1505566080737, 3331.6335203127637, 3343.983280083584, 4588.082383523309, 4611.377464042345, 4612.538746125394, 4630.374899388573, 4640.584621690383, 4081.6326530612387, 4296.63478604319, 4303.160883627694, 4308.612224899774, 4330.545292744248, 4972.359121489936, 4978.576820970222, 4991.700497970133, 4992.176290911995, 4993.425756038066, 3698.056995466166, 3702.5927148013698, 3703.0742314421395, 3708.9258214835554, 3718.1076541629814, 4962.3548938638105, 5130.974345128325, 5214.582833373359, 5223.921641175385, 5252.1596544552685, 3733.104055026774, 3743.9251214975548, 3748.175401411685, 3753.5495740511315, 3763.6989040876665, 3809.7333186676665, 3817.8091095445116, 3846.9807650961566, 3857.9421308680394, 3859.7877116758846, 4303.698741088094, 4312.37470566766, 4322.891927701832, 4331.761753103547, 4335.135891566657, 4692.507286734844, 4858.684185527929, 4936.851894443173, 4950.2822090796635, 4983.9252411213865, 1300.947962081525, 1318.3671837518045, 1322.9007824413206, 1327.143992125074, 1327.183781974079, 848.9278411334982, 857.2113655437013, 858.2490320969152, 864.9015749997594, 896.2561074308309, 4213.1784302060805, 4309.956900430955, 4310.762908040025, 4313.827446902152, 4346.782660866944, 5119.283300337956, 5119.564836988823, 5119.974400127976, 5123.927311961132, 5141.691498510101, 4297.39836422901, 4304.182205380967, 4309.59058889405, 4322.956770432318, 4325.935110973338, 2582.2253324002722, 2712.9555121278054, 2715.633389492433, 2716.9592456113173, 2717.2935036890153, 4827.734474603861, 4837.7097374157665, 4858.82994095205, 4876.609871210366, 4883.4628190898975, 4983.252512123138, 5257.211418287287, 5267.604929630216, 5282.947170528322, 5295.258663787073, 4822.421309442819, 4861.756912154378, 4880.75429839153, 4884.340614017062, 4888.120138375127, 5162.0, 5168.741562921764, 5182.8963420732125, 5204.230561609071, 5227.398849132246, 4840.507138823579, 5002.6498145130945, 5069.695818250917, 5070.923936141035, 5077.517635824591, 4843.152448321459, 4844.152273352079, 4861.295112208781, 4868.90262194747, 4873.95126048735, 3671.5777685565436, 3699.6115407881784, 3716.7398282121076, 3717.107894105341, 3721.8697345592773, 4917.901641967069, 5177.611679124156, 5209.7395130244095, 5227.163653815372, 5227.3465816772905, 4990.855760870628, 4992.850214493571, 4997.900041999213, 5007.649464537593, 5030.471800461045, 4983.800647974041, 4994.300797888372, 4999.67502112376, 5028.421731500778, 5059.974700126476, 4789.329493870791, 4906.754662266943, 4925.679830810986, 4926.704397736147, 4928.531789479994, 4786.545278198566, 4887.193613053949, 4893.314935908905, 4971.527704868032, 4988.42633097184, 4873.220284754422, 4876.29293752411, 4876.29293752411, 4881.951180488291, 4908.11653902301], "value": 3780.946104046568, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.8520562462197, 625.3746253746257, 636.9426751592356, 682.7542084849454, 685.6331862453588, 11543.653690389292, 13221.20672759635, 13360.59918202453, 13365.398557064931, 13378.130421522606, 13070.215787052783, 13077.54228601999, 13114.278714670689, 13151.079424440293, 13204.405801738922, 754.6717178027576, 764.8087978005499, 765.334159281426, 765.7319938021703, 768.5542385416445, 609.5732986909159, 624.793818040048, 747.3871425431149, 773.6557232031748, 777.8755399136139, 809.7327881799022, 812.3907069697726, 812.7805492517047, 812.8536863364592, 812.8983877015373, 807.2089352434589, 808.2281421242758, 808.2846680687575, 808.4421748993205, 808.6603626476865, 477.8948631301108, 485.912535743566, 574.3108270075884, 585.4847733994101, 595.3718826637895, 12061.638150855488, 12152.21010634306, 12161.209521381083, 12166.939165304206, 12183.573574924834, 11637.185397022211, 11972.981589224579, 12170.330631815246, 12195.573154939624, 12490.937545312216, 9472.715818525456, 9687.51562421876, 9742.171915387129, 11478.311301321864, 11579.305241685526, 4030.6775457963295, 4083.0404854859084, 4084.223997440477, 4108.424820525129, 4136.0, 61525.0, 61687.0, 62768.0, 62907.0, 63669.68165159145, 9277.628894844265, 9361.485118318558, 9450.952745236229, 9550.522473876417, 9676.322657414054, 16889.32442702278, 16936.983780972936, 16952.74570881438, 16982.830171698126, 16985.91507042457, 6125.693715314216, 6162.845928851814, 6416.743330266737, 6500.837479062967, 6507.707153178024, 3437.845296961643, 3467.791932484059, 3475.878344257939, 3483.26851361217, 3514.4728290756593, 2861.5993760873494, 2922.3570814420796, 2932.736053755172, 2941.720536549067, 2987.7908546401545, 473.1483330005976, 473.8294214082927, 478.5836322399465, 483.86935527407405, 486.23660852461296, 400.18362540417803, 426.83353492138093, 451.8666993237003, 490.340492038208, 511.4144304771091, 6956.756513522002, 6975.3374123621115, 7133.678984445713, 7457.7016919323705, 7824.37405007598, 491.7983626713102, 491.8721132505503, 503.3154909323317, 506.42715641151295, 513.5506431872112, 3344.297697483507, 3502.3170481755815, 3589.2821435712963, 3639.5450568678916, 3752.249550089993, 59874.40125598775, 85394.5730271357, 101873.49063254637, 108681.45659271652, 108889.0, 87181.5640921804, 88385.55807221051, 88458.55770721105, 89710.55144724235, 93473.5326323364, 78207.0, 78588.0, 80034.0, 80112.19887801164, 80521.0, 6836.145481814773, 7003.154259745575, 7111.111111111111, 7137.0365000726315, 7229.855402892018, 46727.0, 47297.29054064123, 48479.27281090716, 49433.25850112323, 50047.74976125096, 37382.25235495329, 38136.0, 38326.61673383231, 59393.40606593879, 65725.67137164476, 8495.150484951455, 8519.872201916853, 8558.443701159405, 8658.39391242607, 8681.045085040514, 9865.704028879145, 9976.05227503386, 10019.398836069859, 10067.295289329677, 10188.439635820101, 8693.739187824376, 8909.287257019552, 8919.152680495343, 8999.055099214489, 9276.62893484253, 9039.141281578239, 9158.862617060617, 9272.768180795534, 9291.67479138227, 9673.613055477703, 8395.202455766692, 8503.362247831314, 8546.700865469678, 9125.954370228372, 9500.097490738368, 8111.391645626483, 8207.302379297827, 8235.13531079252, 8291.129431409856, 8371.748847534584, 7291.125064992023, 7685.961570192113, 7817.140114587504, 7850.975375759633, 8024.719134830487], "value": 6006.162485842243, "unit": "score"}], "name": "dromaeo_css", "value": 6150.0996281622365, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 116.0, 114.0, 115.0, 115.0, 113.0, 115.0, 114.0, 115.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 129.0, 131.0, 161.0, 124.0, 123.0, 132.0, 123.0, 164.0, 124.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 161.0, 162.0, 161.0, 161.0, 161.0, 161.0, 161.0, 162.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 77.0, 110.0, 76.0, 77.0, 78.0, 77.0, 99.0, 77.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 115.0, 84.0, 84.0, 84.0, 117.0, 85.0, 84.0, 119.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 64.0, 72.0, 66.0, 64.0, 64.0, 64.0, 64.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 83.0, 82.0, 82.0, 83.0, 83.0, 82.0, 83.0, 82.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 146.0, 134.0, 130.0, 131.0, 132.0, 142.0, 133.0, 177.0, 139.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 177.0, 178.0, 177.0, 183.0, 181.0, 184.0, 179.0, 178.0, 175.0], "value": 179.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 69.0, 73.0, 69.0, 69.0, 68.0, 70.0, 67.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1549.0, "alertThreshold": 2.0}]} 05:26:49 INFO - Return code: 0 05:26:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:26:49 INFO - # TBPL SUCCESS # 05:26:49 INFO - Running post-action listener: _resource_record_post_action 05:26:49 INFO - [mozharness: 2016-09-18 12:26:49.264306Z] Finished run-tests step (success) 05:26:49 INFO - Running post-run listener: _resource_record_post_run 05:26:49 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 401391616; Read time: 0; Write time: 457164 05:26:49 INFO - TinderboxPrint: CPU usage
13.1% 05:26:49 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:26:49 INFO - TinderboxPrint: I/O write bytes / time
401,391,616 / 457,164 05:26:49 INFO - TinderboxPrint: CPU idle
8,342.8 (86.9%) 05:26:49 INFO - TinderboxPrint: CPU user
1,199.8 (12.5%) 05:26:49 INFO - TinderboxPrint: Swap in / out
0 / 0 05:26:49 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110854144; Read time: 0; Write time: 154376 05:26:49 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 289923072; Read time: 0; Write time: 302788 05:26:49 INFO - Running post-run listener: _upload_blobber_files 05:26:49 INFO - Blob upload gear active. 05:26:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:26:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:26:49 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:26:49 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:26:50 INFO - (blobuploader) - INFO - Open directory for files ... 05:26:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:26:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:26:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:55 INFO - (blobuploader) - INFO - Done attempting. 05:26:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:26:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:26:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:55 INFO - (blobuploader) - INFO - Done attempting. 05:26:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:26:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:26:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:56 INFO - (blobuploader) - INFO - Done attempting. 05:26:56 INFO - (blobuploader) - INFO - Iteration through files over. 05:26:56 INFO - Return code: 0 05:26:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:26:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:26:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/23ab1a711c49a56790c04bc0107f0ed8e82b465df06087f90af16956b2e02f55c0cefe70f7f6c3125f7eb8b30e2d3caa130afd761095b5933291a47783bf0bc3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cac0ac601ee4a9f48d5080f6cf0899fcdcb50a756933f4c3a04d7b9ffdfdc56df5b0fd784535baa896543bde8f5d9629d7dd64ce5aee60674f725a3c59358504", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d0acc01c49f9481a9383ce96a4f9cdf08d7b89febdafa7f0fb9a38511e395274cb03a1bed2e41272a5e93033fea322fee688f56ccf57ef32a2f7c312b2b8714f"} 05:26:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:26:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:26:56 INFO - Contents: 05:26:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/23ab1a711c49a56790c04bc0107f0ed8e82b465df06087f90af16956b2e02f55c0cefe70f7f6c3125f7eb8b30e2d3caa130afd761095b5933291a47783bf0bc3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cac0ac601ee4a9f48d5080f6cf0899fcdcb50a756933f4c3a04d7b9ffdfdc56df5b0fd784535baa896543bde8f5d9629d7dd64ce5aee60674f725a3c59358504", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d0acc01c49f9481a9383ce96a4f9cdf08d7b89febdafa7f0fb9a38511e395274cb03a1bed2e41272a5e93033fea322fee688f56ccf57ef32a2f7c312b2b8714f"} 05:26:56 INFO - Running post-run listener: copy_logs_to_upload_dir 05:26:56 INFO - Copying logs to upload dir... 05:26:56 INFO - mkdir: /builds/slave/test/build/upload/logs 05:26:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.384742 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-09-18 05:26:56.106579) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-18 05:26:56.110444) ========= 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=af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/23ab1a711c49a56790c04bc0107f0ed8e82b465df06087f90af16956b2e02f55c0cefe70f7f6c3125f7eb8b30e2d3caa130afd761095b5933291a47783bf0bc3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cac0ac601ee4a9f48d5080f6cf0899fcdcb50a756933f4c3a04d7b9ffdfdc56df5b0fd784535baa896543bde8f5d9629d7dd64ce5aee60674f725a3c59358504", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d0acc01c49f9481a9383ce96a4f9cdf08d7b89febdafa7f0fb9a38511e395274cb03a1bed2e41272a5e93033fea322fee688f56ccf57ef32a2f7c312b2b8714f"} build_url:https://queue.taskcluster.net/v1/task/ZWpeDrdrStO8u-yJAoJw3A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011487 build_url: 'https://queue.taskcluster.net/v1/task/ZWpeDrdrStO8u-yJAoJw3A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/23ab1a711c49a56790c04bc0107f0ed8e82b465df06087f90af16956b2e02f55c0cefe70f7f6c3125f7eb8b30e2d3caa130afd761095b5933291a47783bf0bc3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cac0ac601ee4a9f48d5080f6cf0899fcdcb50a756933f4c3a04d7b9ffdfdc56df5b0fd784535baa896543bde8f5d9629d7dd64ce5aee60674f725a3c59358504", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d0acc01c49f9481a9383ce96a4f9cdf08d7b89febdafa7f0fb9a38511e395274cb03a1bed2e41272a5e93033fea322fee688f56ccf57ef32a2f7c312b2b8714f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-18 05:26:56.135423) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-18 05:26:56.135726) ========= 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=af724c981e2a0f424dbabf99000001e7-1474200366.476725-782286694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-18 05:26:56.219843) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-18 05:26:56.220164) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-18 05:26:56.220481) ========= ========= Total master_lag: 0.17 =========