builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-028 starttime: 1474338755.98 results: success (0) buildid: 20160919185918 builduid: 395402b6c03c4639a221909d35b970a7 revision: 270611a85c6f0a0bdcd3dcad732f2e98da61206c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-19 19:32:35.979084) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-19 19:32:35.979593) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-19 19:32:35.979886) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-19 19:32:35.994910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 19:32:35.995207) ========= 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=836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-19 19:32:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-09-19 19:32:36 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106549 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 19:32:36.122278) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 19:32:36.122612) ========= 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=836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020134 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 19:32:36.172872) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 19:32:36.173288) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 270611a85c6f0a0bdcd3dcad732f2e98da61206c --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 270611a85c6f0a0bdcd3dcad732f2e98da61206c --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=836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-19 19:32:36,528 truncating revision to first 12 chars 2016-09-19 19:32:36,529 Setting DEBUG logging. 2016-09-19 19:32:36,529 attempt 1/10 2016-09-19 19:32:36,529 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/270611a85c6f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-19 19:32:37,135 unpacking tar archive at: fx-team-270611a85c6f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.934129 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 19:32:37.121253) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-19 19:32:37.121564) ========= script_repo_revision: 270611a85c6f0a0bdcd3dcad732f2e98da61206c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-19 19:32:37.121996) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-19 19:32:37.122291) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-19 19:32:37.131631) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-09-19 19:32:37.131948) ========= /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=836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:32:37 INFO - MultiFileLogger online at 20160919 19:32:37 in /builds/slave/test 19:32:37 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 19:32:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:32:37 INFO - {'append_to_log': False, 19:32:37 INFO - 'base_work_dir': '/builds/slave/test', 19:32:37 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:32:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:32:37 INFO - 'branch': 'Fx-Team-Non-PGO', 19:32:37 INFO - 'buildbot_json_path': 'buildprops.json', 19:32:37 INFO - 'config_files': ('talos/linux_config.py',), 19:32:37 INFO - 'default_actions': ('clobber', 19:32:37 INFO - 'read-buildbot-config', 19:32:37 INFO - 'download-and-extract', 19:32:37 INFO - 'populate-webroot', 19:32:37 INFO - 'create-virtualenv', 19:32:37 INFO - 'install', 19:32:37 INFO - 'run-tests'), 19:32:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:32:37 INFO - 'download_minidump_stackwalk': True, 19:32:37 INFO - 'download_symbols': 'ondemand', 19:32:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:32:37 INFO - 'tooltool.py': '/tools/tooltool.py', 19:32:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:32:37 INFO - '/tools/misc-python/virtualenv.py')}, 19:32:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:32:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:32:37 INFO - 'installer_path': 'installer.exe', 19:32:37 INFO - 'log_level': 'info', 19:32:37 INFO - 'log_name': 'talos', 19:32:37 INFO - 'log_to_console': True, 19:32:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:32:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:32:37 INFO - 'opt_config_files': (), 19:32:37 INFO - 'pip_index': False, 19:32:37 INFO - 'sps_profile': False, 19:32:37 INFO - 'sps_profile_interval': 0, 19:32:37 INFO - 'suite': 'dromaeojs', 19:32:37 INFO - 'system_bits': '32', 19:32:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:32:37 INFO - 'title': 'talos-linux64-ix-028', 19:32:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:32:37 INFO - 'use_talos_json': True, 19:32:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:32:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:32:37 INFO - 'work_dir': 'build'} 19:32:37 INFO - [mozharness: 2016-09-20 02:32:37.586387Z] Running clobber step. 19:32:37 INFO - Running pre-action listener: _resource_record_pre_action 19:32:37 INFO - Running main action method: clobber 19:32:37 INFO - rmtree: /builds/slave/test/build 19:32:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:32:38 INFO - Running post-action listener: _resource_record_post_action 19:32:38 INFO - [mozharness: 2016-09-20 02:32:38.045180Z] Finished clobber step (success) 19:32:38 INFO - [mozharness: 2016-09-20 02:32:38.045290Z] Running read-buildbot-config step. 19:32:38 INFO - Running pre-action listener: _resource_record_pre_action 19:32:38 INFO - Running main action method: read_buildbot_config 19:32:38 INFO - Using buildbot properties: 19:32:38 INFO - { 19:32:38 INFO - "project": "", 19:32:38 INFO - "product": "firefox", 19:32:38 INFO - "script_repo_revision": "production", 19:32:38 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:32:38 INFO - "repository": "", 19:32:38 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 19:32:38 INFO - "buildid": "20160919185918", 19:32:38 INFO - "pgo_build": "False", 19:32:38 INFO - "basedir": "/builds/slave/test", 19:32:38 INFO - "buildnumber": 1942, 19:32:38 INFO - "slavename": "talos-linux64-ix-028", 19:32:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:32:38 INFO - "platform": "ubuntu64_hw", 19:32:38 INFO - "scheduler": "tests-fx-team-linux64-talos", 19:32:38 INFO - "branch": "fx-team", 19:32:38 INFO - "repo_path": "integration/fx-team", 19:32:38 INFO - "revision": "270611a85c6f0a0bdcd3dcad732f2e98da61206c", 19:32:38 INFO - "stage_platform": "linux64", 19:32:38 INFO - "builduid": "395402b6c03c4639a221909d35b970a7", 19:32:38 INFO - "slavebuilddir": "test" 19:32:38 INFO - } 19:32:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/Hhk5vb_USH6J_wBbfyO5WA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 19:32:38 INFO - Running post-action listener: _resource_record_post_action 19:32:38 INFO - [mozharness: 2016-09-20 02:32:38.047714Z] Finished read-buildbot-config step (success) 19:32:38 INFO - [mozharness: 2016-09-20 02:32:38.047804Z] Running download-and-extract step. 19:32:38 INFO - Running pre-action listener: _resource_record_pre_action 19:32:38 INFO - Running main action method: download_and_extract 19:32:38 INFO - mkdir: /builds/slave/test/build/tests 19:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:38 INFO - trying https://queue.taskcluster.net/v1/task/Hhk5vb_USH6J_wBbfyO5WA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 19:32:38 INFO - Downloading https://queue.taskcluster.net/v1/task/Hhk5vb_USH6J_wBbfyO5WA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 19:32:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Hhk5vb_USH6J_wBbfyO5WA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:32:38 INFO - Downloaded 1361 bytes. 19:32:38 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 19:32:38 INFO - Using the following test package requirements: 19:32:38 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 19:32:38 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:32:38 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:32:38 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:38 INFO - u'jsshell-linux-x86_64.zip'], 19:32:38 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:32:38 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 19:32:38 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:32:38 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:32:38 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:32:38 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:32:38 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:32:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Hhk5vb_USH6J_wBbfyO5WA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 19:32:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hhk5vb_USH6J_wBbfyO5WA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:32:38 INFO - Fetch https://queue.taskcluster.net/v1/task/Hhk5vb_USH6J_wBbfyO5WA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:32:39 INFO - Expected file size: 20366296 19:32:43 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:32:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Hhk5vb_USH6J_wBbfyO5WA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 19:32:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hhk5vb_USH6J_wBbfyO5WA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:32:43 INFO - Fetch https://queue.taskcluster.net/v1/task/Hhk5vb_USH6J_wBbfyO5WA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:32:43 INFO - Expected file size: 20366296 19:32:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Hhk5vb_USH6J_wBbfyO5WA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 19:32:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hhk5vb_USH6J_wBbfyO5WA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:32:48 INFO - Fetch https://queue.taskcluster.net/v1/task/Hhk5vb_USH6J_wBbfyO5WA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 19:32:49 INFO - Expected file size: 14414059 19:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:49 INFO - trying https://queue.taskcluster.net/v1/task/Hhk5vb_USH6J_wBbfyO5WA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:32:49 INFO - Downloading https://queue.taskcluster.net/v1/task/Hhk5vb_USH6J_wBbfyO5WA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:32:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Hhk5vb_USH6J_wBbfyO5WA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:32:50 INFO - Downloaded 55598870 bytes. 19:32:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Hhk5vb_USH6J_wBbfyO5WA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:32:50 INFO - mkdir: /builds/slave/test/properties 19:32:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:32:50 INFO - Writing to file /builds/slave/test/properties/build_url 19:32:50 INFO - Contents: 19:32:50 INFO - build_url:https://queue.taskcluster.net/v1/task/Hhk5vb_USH6J_wBbfyO5WA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:32:51 INFO - Running post-action listener: _resource_record_post_action 19:32:51 INFO - Running post-action listener: set_extra_try_arguments 19:32:51 INFO - [mozharness: 2016-09-20 02:32:51.342820Z] Finished download-and-extract step (success) 19:32:51 INFO - [mozharness: 2016-09-20 02:32:51.343121Z] Running populate-webroot step. 19:32:51 INFO - Running pre-action listener: _resource_record_pre_action 19:32:51 INFO - Running main action method: populate_webroot 19:32:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:32:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:32:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:32:51 INFO - '--tppagecycles', 19:32:51 INFO - '7'], 19:32:51 INFO - 'tests': ['tsvgm']}}, 19:32:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:32:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:32:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:32:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:32:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:32:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:32:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:51 INFO - 'talos_options': ['--disable-e10s'], 19:32:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:32:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:32:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:51 INFO - 'talos_options': ['--disable-e10s'], 19:32:51 INFO - 'tests': ['damp', 'tps']}, 19:32:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:51 INFO - 'tests': ['damp', 'tps']}, 19:32:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:32:51 INFO - 'tests': ['dromaeo_dom']}, 19:32:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:32:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:32:51 INFO - 'tests': ['basic_compositor_video']}, 19:32:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:32:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:32:51 INFO - 'tests': ['a11yr', 19:32:51 INFO - 'ts_paint', 19:32:51 INFO - 'tpaint', 19:32:51 INFO - 'sessionrestore', 19:32:51 INFO - 'sessionrestore_no_auto_restore', 19:32:51 INFO - 'tabpaint']}, 19:32:51 INFO - 'other-e10s': {'tests': ['a11yr', 19:32:51 INFO - 'ts_paint', 19:32:51 INFO - 'tpaint', 19:32:51 INFO - 'sessionrestore', 19:32:51 INFO - 'sessionrestore_no_auto_restore', 19:32:51 INFO - 'tabpaint']}, 19:32:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:32:51 INFO - 'ts_paint', 19:32:51 INFO - 'tpaint', 19:32:51 INFO - 'sessionrestore', 19:32:51 INFO - 'sessionrestore_no_auto_restore', 19:32:51 INFO - 'tabpaint']}, 19:32:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:32:51 INFO - 'ts_paint', 19:32:51 INFO - 'tpaint', 19:32:51 INFO - 'sessionrestore', 19:32:51 INFO - 'sessionrestore_no_auto_restore', 19:32:51 INFO - 'tabpaint']}, 19:32:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:32:51 INFO - 'tests': ['a11yr', 19:32:51 INFO - 'ts_paint', 19:32:51 INFO - 'tpaint', 19:32:51 INFO - 'sessionrestore', 19:32:51 INFO - 'sessionrestore_no_auto_restore', 19:32:51 INFO - 'tabpaint']}, 19:32:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:32:51 INFO - 'tests': ['a11yr', 19:32:51 INFO - 'ts_paint', 19:32:51 INFO - 'tpaint', 19:32:51 INFO - 'sessionrestore', 19:32:51 INFO - 'sessionrestore_no_auto_restore', 19:32:51 INFO - 'tabpaint']}, 19:32:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:32:51 INFO - 'tests': ['tsvgx', 19:32:51 INFO - 'tsvgr_opacity', 19:32:51 INFO - 'tart', 19:32:51 INFO - 'tscrollx', 19:32:51 INFO - 'cart']}, 19:32:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:32:51 INFO - 'tsvgr_opacity', 19:32:51 INFO - 'tart', 19:32:51 INFO - 'tscrollx', 19:32:51 INFO - 'cart']}, 19:32:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:51 INFO - 'talos_options': ['--disable-e10s'], 19:32:51 INFO - 'tests': ['tp5o']}, 19:32:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:51 INFO - 'tests': ['tp5o']}, 19:32:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:51 INFO - 'talos_options': ['--disable-e10s', 19:32:51 INFO - '--xperf_path', 19:32:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:32:51 INFO - 'tests': ['tp5n']}, 19:32:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:51 INFO - 'talos_options': ['--xperf_path', 19:32:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:32:51 INFO - 'tests': ['tp5n']}}, 19:32:51 INFO - 'talos.zip': {'path': '', 19:32:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:32:51 INFO - Running post-action listener: _resource_record_post_action 19:32:51 INFO - [mozharness: 2016-09-20 02:32:51.362143Z] Finished populate-webroot step (success) 19:32:51 INFO - [mozharness: 2016-09-20 02:32:51.362237Z] Running create-virtualenv step. 19:32:51 INFO - Running pre-action listener: _resource_record_pre_action 19:32:51 INFO - Running main action method: create_virtualenv 19:32:51 INFO - Creating virtualenv /builds/slave/test/build/venv 19:32:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:32:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:32:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:32:51 INFO - Using real prefix '/usr' 19:32:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:32:51 INFO - Installing distribute.............................................................................................................................................................................................done. 19:32:53 INFO - Installing pip.................done. 19:32:53 INFO - Return code: 0 19:32:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a6d8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0f60>, '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 0x16b1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b21d0>, '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': '836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:32:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:32:53 INFO - Using env: {'DISPLAY': ':0', 19:32:53 INFO - 'HOME': '/home/cltbld', 19:32:53 INFO - 'LANG': 'en_US.UTF-8', 19:32:53 INFO - 'LANGUAGE': 'en_US:en', 19:32:53 INFO - 'LOGNAME': 'cltbld', 19:32:53 INFO - 'MAIL': '/var/mail/cltbld', 19:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:53 INFO - 'MOZ_NO_REMOTE': '1', 19:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:53 INFO - 'NO_EM_RESTART': '1', 19:32:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:53 INFO - 'PWD': '/builds/slave/test', 19:32:53 INFO - 'SHELL': '/bin/bash', 19:32:53 INFO - 'SHLVL': '1', 19:32:53 INFO - 'TERM': 'linux', 19:32:53 INFO - 'TMOUT': '86400', 19:32:53 INFO - 'USER': 'cltbld', 19:32:53 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322', 19:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:53 INFO - '_': '/tools/buildbot/bin/python'} 19:32:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:32:54 INFO - Cleaning up... 19:32:54 INFO - Return code: 0 19:32:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:32:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:54 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 0x7f7a6d8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0f60>, '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 0x16b1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b21d0>, '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': '836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:32:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:32:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:32:54 INFO - Using env: {'DISPLAY': ':0', 19:32:54 INFO - 'HOME': '/home/cltbld', 19:32:54 INFO - 'LANG': 'en_US.UTF-8', 19:32:54 INFO - 'LANGUAGE': 'en_US:en', 19:32:54 INFO - 'LOGNAME': 'cltbld', 19:32:54 INFO - 'MAIL': '/var/mail/cltbld', 19:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:54 INFO - 'MOZ_NO_REMOTE': '1', 19:32:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:54 INFO - 'NO_EM_RESTART': '1', 19:32:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:54 INFO - 'PWD': '/builds/slave/test', 19:32:54 INFO - 'SHELL': '/bin/bash', 19:32:54 INFO - 'SHLVL': '1', 19:32:54 INFO - 'TERM': 'linux', 19:32:54 INFO - 'TMOUT': '86400', 19:32:54 INFO - 'USER': 'cltbld', 19:32:54 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322', 19:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:54 INFO - '_': '/tools/buildbot/bin/python'} 19:32:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:54 INFO - Downloading/unpacking psutil>=3.1.1 19:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:32:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:32:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:32:56 INFO - Installing collected packages: psutil 19:32:56 INFO - Running setup.py install for psutil 19:32:56 INFO - building 'psutil._psutil_linux' extension 19:32:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:32:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:32:56 INFO - building 'psutil._psutil_posix' extension 19:32:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:32:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:32:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:32:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:32:56 INFO - Successfully installed psutil 19:32:56 INFO - Cleaning up... 19:32:56 INFO - Return code: 0 19:32:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a6d8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0f60>, '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 0x16b1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b21d0>, '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': '836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:32:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:32:56 INFO - Using env: {'DISPLAY': ':0', 19:32:56 INFO - 'HOME': '/home/cltbld', 19:32:56 INFO - 'LANG': 'en_US.UTF-8', 19:32:56 INFO - 'LANGUAGE': 'en_US:en', 19:32:56 INFO - 'LOGNAME': 'cltbld', 19:32:56 INFO - 'MAIL': '/var/mail/cltbld', 19:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:56 INFO - 'MOZ_NO_REMOTE': '1', 19:32:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:56 INFO - 'NO_EM_RESTART': '1', 19:32:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:56 INFO - 'PWD': '/builds/slave/test', 19:32:56 INFO - 'SHELL': '/bin/bash', 19:32:56 INFO - 'SHLVL': '1', 19:32:56 INFO - 'TERM': 'linux', 19:32:56 INFO - 'TMOUT': '86400', 19:32:56 INFO - 'USER': 'cltbld', 19:32:56 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322', 19:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:56 INFO - '_': '/tools/buildbot/bin/python'} 19:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:32:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:32:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:32:59 INFO - Installing collected packages: mozsystemmonitor 19:32:59 INFO - Running setup.py install for mozsystemmonitor 19:32:59 INFO - Successfully installed mozsystemmonitor 19:32:59 INFO - Cleaning up... 19:32:59 INFO - Return code: 0 19:32:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:59 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 0x7f7a6d8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0f60>, '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 0x16b1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b21d0>, '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': '836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:32:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:32:59 INFO - Using env: {'DISPLAY': ':0', 19:32:59 INFO - 'HOME': '/home/cltbld', 19:32:59 INFO - 'LANG': 'en_US.UTF-8', 19:32:59 INFO - 'LANGUAGE': 'en_US:en', 19:32:59 INFO - 'LOGNAME': 'cltbld', 19:32:59 INFO - 'MAIL': '/var/mail/cltbld', 19:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:59 INFO - 'MOZ_NO_REMOTE': '1', 19:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:59 INFO - 'NO_EM_RESTART': '1', 19:32:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:59 INFO - 'PWD': '/builds/slave/test', 19:32:59 INFO - 'SHELL': '/bin/bash', 19:32:59 INFO - 'SHLVL': '1', 19:32:59 INFO - 'TERM': 'linux', 19:32:59 INFO - 'TMOUT': '86400', 19:32:59 INFO - 'USER': 'cltbld', 19:32:59 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322', 19:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:59 INFO - '_': '/tools/buildbot/bin/python'} 19:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:59 INFO - Downloading/unpacking jsonschema==2.5.1 19:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:33:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:01 INFO - Downloading functools32-3.2.3-2.tar.gz 19:33:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:33:01 INFO - warning: no files found matching '*.txt' 19:33:01 INFO - no previously-included directories found matching 'build' 19:33:01 INFO - no previously-included directories found matching 'dist' 19:33:01 INFO - no previously-included directories found matching '.git*' 19:33:01 INFO - Installing collected packages: jsonschema, functools32 19:33:01 INFO - Running setup.py install for functools32 19:33:01 INFO - warning: no files found matching '*.txt' 19:33:01 INFO - no previously-included directories found matching 'build' 19:33:01 INFO - no previously-included directories found matching 'dist' 19:33:01 INFO - no previously-included directories found matching '.git*' 19:33:01 INFO - Successfully installed jsonschema functools32 19:33:01 INFO - Cleaning up... 19:33:01 INFO - Return code: 0 19:33:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:01 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 0x7f7a6d8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0f60>, '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 0x16b1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b21d0>, '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': '836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:33:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:33:01 INFO - Using env: {'DISPLAY': ':0', 19:33:01 INFO - 'HOME': '/home/cltbld', 19:33:01 INFO - 'LANG': 'en_US.UTF-8', 19:33:01 INFO - 'LANGUAGE': 'en_US:en', 19:33:01 INFO - 'LOGNAME': 'cltbld', 19:33:01 INFO - 'MAIL': '/var/mail/cltbld', 19:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:01 INFO - 'MOZ_NO_REMOTE': '1', 19:33:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:01 INFO - 'NO_EM_RESTART': '1', 19:33:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:01 INFO - 'PWD': '/builds/slave/test', 19:33:01 INFO - 'SHELL': '/bin/bash', 19:33:01 INFO - 'SHLVL': '1', 19:33:01 INFO - 'TERM': 'linux', 19:33:01 INFO - 'TMOUT': '86400', 19:33:01 INFO - 'USER': 'cltbld', 19:33:01 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322', 19:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:01 INFO - '_': '/tools/buildbot/bin/python'} 19:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:33:02 INFO - Cleaning up... 19:33:02 INFO - Return code: 0 19:33:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:02 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 0x7f7a6d8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0f60>, '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 0x16b1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b21d0>, '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': '836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:33:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:33:02 INFO - Using env: {'DISPLAY': ':0', 19:33:02 INFO - 'HOME': '/home/cltbld', 19:33:02 INFO - 'LANG': 'en_US.UTF-8', 19:33:02 INFO - 'LANGUAGE': 'en_US:en', 19:33:02 INFO - 'LOGNAME': 'cltbld', 19:33:02 INFO - 'MAIL': '/var/mail/cltbld', 19:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:02 INFO - 'MOZ_NO_REMOTE': '1', 19:33:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:02 INFO - 'NO_EM_RESTART': '1', 19:33:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:02 INFO - 'PWD': '/builds/slave/test', 19:33:02 INFO - 'SHELL': '/bin/bash', 19:33:02 INFO - 'SHLVL': '1', 19:33:02 INFO - 'TERM': 'linux', 19:33:02 INFO - 'TMOUT': '86400', 19:33:02 INFO - 'USER': 'cltbld', 19:33:02 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322', 19:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:02 INFO - '_': '/tools/buildbot/bin/python'} 19:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:02 INFO - Downloading/unpacking blobuploader==1.2.4 19:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:04 INFO - Downloading blobuploader-1.2.4.tar.gz 19:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:33:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:33:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:04 INFO - Downloading docopt-0.6.1.tar.gz 19:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:33:04 INFO - Installing collected packages: blobuploader, requests, docopt 19:33:04 INFO - Running setup.py install for blobuploader 19:33:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:33:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:33:04 INFO - Running setup.py install for requests 19:33:05 INFO - Running setup.py install for docopt 19:33:05 INFO - Successfully installed blobuploader requests docopt 19:33:05 INFO - Cleaning up... 19:33:05 INFO - Return code: 0 19:33:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:05 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 0x7f7a6d8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0f60>, '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 0x16b1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b21d0>, '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': '836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:33:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:33:05 INFO - Using env: {'DISPLAY': ':0', 19:33:05 INFO - 'HOME': '/home/cltbld', 19:33:05 INFO - 'LANG': 'en_US.UTF-8', 19:33:05 INFO - 'LANGUAGE': 'en_US:en', 19:33:05 INFO - 'LOGNAME': 'cltbld', 19:33:05 INFO - 'MAIL': '/var/mail/cltbld', 19:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:05 INFO - 'MOZ_NO_REMOTE': '1', 19:33:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:05 INFO - 'NO_EM_RESTART': '1', 19:33:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:05 INFO - 'PWD': '/builds/slave/test', 19:33:05 INFO - 'SHELL': '/bin/bash', 19:33:05 INFO - 'SHLVL': '1', 19:33:05 INFO - 'TERM': 'linux', 19:33:05 INFO - 'TMOUT': '86400', 19:33:05 INFO - 'USER': 'cltbld', 19:33:05 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322', 19:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:05 INFO - '_': '/tools/buildbot/bin/python'} 19:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:33:05 INFO - Running setup.py (path:/tmp/pip-GrcLKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:33:05 INFO - Running setup.py (path:/tmp/pip-qKcm1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:33:05 INFO - Running setup.py (path:/tmp/pip-oVaT0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:33:05 INFO - Running setup.py (path:/tmp/pip-JgcFUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:33:05 INFO - Running setup.py (path:/tmp/pip-YdBm0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:33:06 INFO - Running setup.py (path:/tmp/pip-Hat8Ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:33:06 INFO - Running setup.py (path:/tmp/pip-cwIPAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:33:06 INFO - Running setup.py (path:/tmp/pip-SM_srW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:33:06 INFO - Running setup.py (path:/tmp/pip-sgs6Ve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:33:06 INFO - Running setup.py (path:/tmp/pip-2fm7Xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:33:06 INFO - Running setup.py (path:/tmp/pip-4kMNLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:33:06 INFO - Running setup.py (path:/tmp/pip-aUP7mJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:33:06 INFO - Running setup.py (path:/tmp/pip-pzuE7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:33:06 INFO - Running setup.py (path:/tmp/pip-LdcU7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:33:06 INFO - Running setup.py (path:/tmp/pip-JJqgeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:33:06 INFO - Running setup.py (path:/tmp/pip-YuxcIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:33:06 INFO - Running setup.py (path:/tmp/pip-uGVTgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:33:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:33:06 INFO - Running setup.py install for manifestparser 19:33:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:33:07 INFO - Running setup.py install for mozcrash 19:33:07 INFO - Running setup.py install for mozdebug 19:33:07 INFO - Running setup.py install for mozdevice 19:33:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:33:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:33:07 INFO - Running setup.py install for mozfile 19:33:07 INFO - Running setup.py install for mozhttpd 19:33:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:33:07 INFO - Running setup.py install for mozinfo 19:33:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:33:07 INFO - Running setup.py install for mozInstall 19:33:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:33:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:33:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:33:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:33:07 INFO - Running setup.py install for mozleak 19:33:07 INFO - Running setup.py install for mozlog 19:33:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:33:07 INFO - Running setup.py install for moznetwork 19:33:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:33:08 INFO - Running setup.py install for mozprocess 19:33:08 INFO - Running setup.py install for mozprofile 19:33:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:33:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:33:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:33:08 INFO - Running setup.py install for mozrunner 19:33:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:33:08 INFO - Running setup.py install for mozscreenshot 19:33:08 INFO - Running setup.py install for moztest 19:33:08 INFO - Running setup.py install for mozversion 19:33:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:33:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:33:08 INFO - Cleaning up... 19:33:08 INFO - Return code: 0 19:33:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:33:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:08 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 0x7f7a6d8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0f60>, '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 0x16b1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b21d0>, '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': '836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:33:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:33:08 INFO - Using env: {'DISPLAY': ':0', 19:33:08 INFO - 'HOME': '/home/cltbld', 19:33:08 INFO - 'LANG': 'en_US.UTF-8', 19:33:08 INFO - 'LANGUAGE': 'en_US:en', 19:33:08 INFO - 'LOGNAME': 'cltbld', 19:33:08 INFO - 'MAIL': '/var/mail/cltbld', 19:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:08 INFO - 'MOZ_NO_REMOTE': '1', 19:33:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:08 INFO - 'NO_EM_RESTART': '1', 19:33:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:08 INFO - 'PWD': '/builds/slave/test', 19:33:08 INFO - 'SHELL': '/bin/bash', 19:33:08 INFO - 'SHLVL': '1', 19:33:08 INFO - 'TERM': 'linux', 19:33:08 INFO - 'TMOUT': '86400', 19:33:08 INFO - 'USER': 'cltbld', 19:33:08 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322', 19:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:08 INFO - '_': '/tools/buildbot/bin/python'} 19:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:33:08 INFO - Running setup.py (path:/tmp/pip-vCjNkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:33:09 INFO - Running setup.py (path:/tmp/pip-Lpnx4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:33:09 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)) 19:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:33:09 INFO - Running setup.py (path:/tmp/pip-52uqu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:33:09 INFO - Running setup.py (path:/tmp/pip-6JmXDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:33:09 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)) 19:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:33:09 INFO - Running setup.py (path:/tmp/pip-IuczCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:33:09 INFO - Running setup.py (path:/tmp/pip-hlHZwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:33:09 INFO - Running setup.py (path:/tmp/pip-JZLiv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:33:09 INFO - Running setup.py (path:/tmp/pip-yhNVJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:33:09 INFO - Running setup.py (path:/tmp/pip-_Os_SH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:33:09 INFO - Running setup.py (path:/tmp/pip-KjHzvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:33:09 INFO - Running setup.py (path:/tmp/pip-iU6Jio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:33:09 INFO - Running setup.py (path:/tmp/pip-LVfID6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:33:09 INFO - Running setup.py (path:/tmp/pip-hx6wzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:33:09 INFO - Running setup.py (path:/tmp/pip-CaJfaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:33:09 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)) 19:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:33:09 INFO - Running setup.py (path:/tmp/pip-wqfDEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:33:10 INFO - Running setup.py (path:/tmp/pip-ydIy81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:33:10 INFO - Running setup.py (path:/tmp/pip-qjyVZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:33:10 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)) 19:33:10 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)) 19:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:33:10 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)) 19:33:10 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)) 19:33:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:12 INFO - Downloading blessings-1.6.tar.gz 19:33:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:33:12 INFO - Installing collected packages: blessings 19:33:12 INFO - Running setup.py install for blessings 19:33:12 INFO - Successfully installed blessings 19:33:12 INFO - Cleaning up... 19:33:12 INFO - Return code: 0 19:33:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:33:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:33:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:33:12 INFO - Reading from file tmpfile_stdout 19:33:12 INFO - Current package versions: 19:33:12 INFO - argparse == 1.2.1 19:33:12 INFO - blessings == 1.6 19:33:12 INFO - blobuploader == 1.2.4 19:33:12 INFO - docopt == 0.6.1 19:33:12 INFO - functools32 == 3.2.3-2 19:33:12 INFO - jsonschema == 2.5.1 19:33:12 INFO - manifestparser == 1.1 19:33:12 INFO - mozInstall == 1.12 19:33:12 INFO - mozcrash == 0.17 19:33:12 INFO - mozdebug == 0.1 19:33:12 INFO - mozdevice == 0.48 19:33:12 INFO - mozfile == 1.2 19:33:12 INFO - mozhttpd == 0.7 19:33:12 INFO - mozinfo == 0.9 19:33:12 INFO - mozleak == 0.1 19:33:12 INFO - mozlog == 3.4 19:33:12 INFO - moznetwork == 0.27 19:33:12 INFO - mozprocess == 0.23 19:33:12 INFO - mozprofile == 0.28 19:33:12 INFO - mozrunner == 6.12 19:33:12 INFO - mozscreenshot == 0.1 19:33:12 INFO - mozsystemmonitor == 0.3 19:33:12 INFO - moztest == 0.7 19:33:12 INFO - mozversion == 1.4 19:33:12 INFO - psutil == 3.1.1 19:33:12 INFO - requests == 1.2.3 19:33:12 INFO - wsgiref == 0.1.2 19:33:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:33:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:12 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 0x7f7a6d8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0f60>, '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 0x16b1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b21d0>, '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': '836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:33:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:33:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:33:12 INFO - Using env: {'DISPLAY': ':0', 19:33:12 INFO - 'HOME': '/home/cltbld', 19:33:12 INFO - 'LANG': 'en_US.UTF-8', 19:33:12 INFO - 'LANGUAGE': 'en_US:en', 19:33:12 INFO - 'LOGNAME': 'cltbld', 19:33:12 INFO - 'MAIL': '/var/mail/cltbld', 19:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:12 INFO - 'MOZ_NO_REMOTE': '1', 19:33:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:12 INFO - 'NO_EM_RESTART': '1', 19:33:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:12 INFO - 'PWD': '/builds/slave/test', 19:33:12 INFO - 'SHELL': '/bin/bash', 19:33:12 INFO - 'SHLVL': '1', 19:33:12 INFO - 'TERM': 'linux', 19:33:12 INFO - 'TMOUT': '86400', 19:33:12 INFO - 'USER': 'cltbld', 19:33:12 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322', 19:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:12 INFO - '_': '/tools/buildbot/bin/python'} 19:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:33:12 INFO - Cleaning up... 19:33:12 INFO - Return code: 0 19:33:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:33:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:12 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 0x7f7a6d8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0f60>, '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 0x16b1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b21d0>, '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': '836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:33:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:33:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:33:12 INFO - Using env: {'DISPLAY': ':0', 19:33:12 INFO - 'HOME': '/home/cltbld', 19:33:12 INFO - 'LANG': 'en_US.UTF-8', 19:33:12 INFO - 'LANGUAGE': 'en_US:en', 19:33:12 INFO - 'LOGNAME': 'cltbld', 19:33:12 INFO - 'MAIL': '/var/mail/cltbld', 19:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:12 INFO - 'MOZ_NO_REMOTE': '1', 19:33:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:12 INFO - 'NO_EM_RESTART': '1', 19:33:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:12 INFO - 'PWD': '/builds/slave/test', 19:33:12 INFO - 'SHELL': '/bin/bash', 19:33:12 INFO - 'SHLVL': '1', 19:33:12 INFO - 'TERM': 'linux', 19:33:12 INFO - 'TMOUT': '86400', 19:33:12 INFO - 'USER': 'cltbld', 19:33:12 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322', 19:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:12 INFO - '_': '/tools/buildbot/bin/python'} 19:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:33:12 INFO - Cleaning up... 19:33:12 INFO - Return code: 0 19:33:12 INFO - Running post-action listener: _resource_record_post_action 19:33:12 INFO - Running post-action listener: _start_resource_monitoring 19:33:12 INFO - Starting resource monitoring. 19:33:13 INFO - [mozharness: 2016-09-20 02:33:13.000611Z] Finished create-virtualenv step (success) 19:33:13 INFO - [mozharness: 2016-09-20 02:33:13.001064Z] Running install step. 19:33:13 INFO - Running pre-action listener: _resource_record_pre_action 19:33:13 INFO - Running main action method: install 19:33:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:33:13 INFO - Reading from file tmpfile_stdout 19:33:13 INFO - Detecting whether we're running mozinstall >=1.0... 19:33:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:33:13 INFO - Reading from file tmpfile_stdout 19:33:13 INFO - Output received: 19:33:13 INFO - Usage: mozinstall [options] installer 19:33:13 INFO - Options: 19:33:13 INFO - -h, --help show this help message and exit 19:33:13 INFO - -d DEST, --destination=DEST 19:33:13 INFO - Directory to install application into. [default: 19:33:13 INFO - "/builds/slave/test"] 19:33:13 INFO - --app=APP Application being installed. [default: firefox] 19:33:13 INFO - mkdir: /builds/slave/test/build/application 19:33:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:33:29 INFO - Reading from file tmpfile_stdout 19:33:29 INFO - Output received: 19:33:29 INFO - /builds/slave/test/build/application/firefox/firefox 19:33:29 INFO - Running post-action listener: _resource_record_post_action 19:33:29 INFO - [mozharness: 2016-09-20 02:33:29.334544Z] Finished install step (success) 19:33:29 INFO - [mozharness: 2016-09-20 02:33:29.334788Z] Running run-tests step. 19:33:29 INFO - Running pre-action listener: _resource_record_pre_action 19:33:29 INFO - Running main action method: run_tests 19:33:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:33:29 INFO - Python 2.7.3 19:33:29 INFO - Return code: 0 19:33:29 INFO - grabbing minidump binary from tooltool 19:33:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:33:29 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 0x16b0f60>, '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 0x16b1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b21d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:33:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:33:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:33:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:33:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:33:29 INFO - Return code: 0 19:33:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:33:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:33:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:33:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:33:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:33:29 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/Hhk5vb_USH6J_wBbfyO5WA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 19:33:29 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/Hhk5vb_USH6J_wBbfyO5WA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 19:33:29 INFO - Using env: {'DISPLAY': ':0', 19:33:29 INFO - 'HOME': '/home/cltbld', 19:33:29 INFO - 'LANG': 'en_US.UTF-8', 19:33:29 INFO - 'LANGUAGE': 'en_US:en', 19:33:29 INFO - 'LOGNAME': 'cltbld', 19:33:29 INFO - 'MAIL': '/var/mail/cltbld', 19:33:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:33:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:33:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:29 INFO - 'MOZ_NO_REMOTE': '1', 19:33:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:33:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:29 INFO - 'NO_EM_RESTART': '1', 19:33:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:29 INFO - 'PWD': '/builds/slave/test', 19:33:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:33:29 INFO - 'SHELL': '/bin/bash', 19:33:29 INFO - 'SHLVL': '1', 19:33:29 INFO - 'TERM': 'linux', 19:33:29 INFO - 'TMOUT': '86400', 19:33:29 INFO - 'USER': 'cltbld', 19:33:29 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322', 19:33:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:29 INFO - '_': '/tools/buildbot/bin/python'} 19:33:29 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/Hhk5vb_USH6J_wBbfyO5WA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 19:33:29 INFO - mozversion application_buildid: 20160919185918 19:33:29 INFO - mozversion application_changeset: 270611a85c6f0a0bdcd3dcad732f2e98da61206c 19:33:29 INFO - mozversion application_display_name: Nightly 19:33:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:33:29 INFO - mozversion application_name: Firefox 19:33:29 INFO - mozversion application_remotingname: firefox 19:33:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:33:29 INFO - mozversion application_vendor: Mozilla 19:33:29 INFO - mozversion application_version: 52.0a1 19:33:29 INFO - mozversion platform_buildid: 20160919185918 19:33:29 INFO - mozversion platform_changeset: 270611a85c6f0a0bdcd3dcad732f2e98da61206c 19:33:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:33:29 INFO - mozversion platform_version: 52.0a1 19:33:29 INFO - using testdate: 1474338809 19:33:29 INFO - actual date: 1474338809 19:33:29 INFO - starting webserver on 'localhost:50758' 19:33:29 INFO - SUITE-START | Running 2 tests 19:33:29 INFO - TEST-START | dromaeo_css 19:33:29 INFO - operating with platform_type : linux_ 19:33:29 INFO - Initialising browser for dromaeo_css test... 19:33:29 INFO - TEST-INFO | started process 10005 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ9AUfm/profile http://localhost:50758/getInfo.html) 19:33:34 INFO - PROCESS | 10005 | __metrics Screen width/height:1600/1200 19:33:34 INFO - PROCESS | 10005 | colorDepth:24 19:33:34 INFO - PROCESS | 10005 | Browser inner width/height: 1024/697 19:33:34 INFO - PROCESS | 10005 | __metrics 19:33:34 INFO - PROCESS | 10005 | 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" 19:33:34 INFO - PROCESS | 10005 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:33:35 INFO - PROCESS | 10005 | console.error: PushService: 19:33:35 INFO - PROCESS | 10005 | stateChangeProcessEnqueue: Error transitioning state 19:33:35 INFO - PROCESS | 10005 | UnknownError 19:33:36 INFO - TEST-INFO | 10005: exit 0 19:33:36 INFO - Browser initialized. 19:33:36 INFO - Running cycle 1/1 for dromaeo_css test... 19:33:36 INFO - TEST-INFO | started process 10087 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ9AUfm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:33:48 INFO - PROCESS | 10087 | RSS: Main: 174993408 19:33:48 INFO - PROCESS | 10087 | 19:34:06 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:34:26 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.05005 seconds. 19:34:34 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00211 seconds. 19:34:36 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 19:34:40 INFO - PROCESS | 10087 | 1474338880200 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:34:42 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 19:34:44 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.05008 seconds. 19:34:48 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 19:34:54 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 19:34:59 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01667 seconds. 19:35:14 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 19:35:18 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.03342 seconds. 19:35:20 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01674 seconds. 19:35:24 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.16673 seconds. 19:35:29 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.05001 seconds. 19:35:37 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 19:35:39 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:35:41 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:35:56 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01675 seconds. 19:36:03 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.58346 seconds. 19:36:06 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.03339 seconds. 19:36:23 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.05006 seconds. 19:36:26 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 19:36:31 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:36:32 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:36:34 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 19:36:44 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 19:36:50 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 19:36:52 INFO - PROCESS | 10087 | Cycle 1(1): loaded http://localhost:50758/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50758/tests/dromaeo/cssquery-ext.html) 19:36:53 INFO - PROCESS | 10087 | RSS: Main: 270778368 19:36:53 INFO - PROCESS | 10087 | 19:36:57 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 19:36:58 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.03341 seconds. 19:37:04 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 19:37:14 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:37:16 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00008 seconds. 19:37:28 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 19:37:30 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 19:37:32 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 19:37:44 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:37:49 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 19:37:53 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 19:38:11 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 19:38:23 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:38:27 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 19:38:33 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 19:38:51 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01664 seconds. 19:38:53 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 19:39:01 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 19:39:07 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 19:39:09 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 19:39:11 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 19:39:22 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:39:23 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 19:39:32 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:39:38 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 19:39:42 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01675 seconds. 19:39:44 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 19:39:46 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 19:39:48 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 19:39:50 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 19:39:53 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 19:39:56 INFO - PROCESS | 10087 | Cycle 1(1): loaded http://localhost:50758/tests/dromaeo/cssquery-ext.html (next: http://localhost:50758/tests/dromaeo/cssquery-jquery.html) 19:39:56 INFO - PROCESS | 10087 | RSS: Main: 273309696 19:39:56 INFO - PROCESS | 10087 | 19:40:00 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.03339 seconds. 19:40:06 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 19:40:13 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:40:22 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 19:40:27 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 19:40:35 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 19:40:41 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:40:43 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 19:40:45 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 19:41:10 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:41:14 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 19:41:32 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 19:41:39 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 19:41:40 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01667 seconds. 19:41:42 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.0001 seconds. 19:41:46 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01676 seconds. 19:41:48 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 19:41:58 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:42:00 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 19:42:02 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01659 seconds. 19:42:04 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 19:42:06 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 19:42:25 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:42:38 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 19:42:40 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00008 seconds. 19:42:43 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:42:49 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 19:42:51 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 19:42:59 INFO - PROCESS | 10087 | Cycle 1(1): loaded http://localhost:50758/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50758/tests/dromaeo/cssquery-mootools.html) 19:42:59 INFO - PROCESS | 10087 | RSS: Main: 214786048 19:42:59 INFO - PROCESS | 10087 | 19:43:03 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01674 seconds. 19:43:04 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 19:43:16 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 19:43:18 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 19:43:46 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 19:43:48 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01676 seconds. 19:43:50 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 19:44:06 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:44:09 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 19:44:11 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 19:44:17 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:44:19 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 19:44:21 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 19:44:33 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 19:44:35 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 19:44:41 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01677 seconds. 19:44:59 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 19:45:09 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 19:45:11 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 19:45:14 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00008 seconds. 19:45:44 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:45:49 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:46:01 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 19:46:02 INFO - PROCESS | 10087 | Cycle 1(1): loaded http://localhost:50758/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50758/tests/dromaeo/cssquery-prototype.html) 19:46:02 INFO - PROCESS | 10087 | RSS: Main: 215957504 19:46:02 INFO - PROCESS | 10087 | 19:46:19 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 19:46:25 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:46:32 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 19:46:40 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 19:46:56 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 19:47:06 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 19:47:07 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 2.00008 seconds. 19:47:08 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.0001 seconds. 19:47:13 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:47:32 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 19:47:49 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 19:47:51 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 19:47:56 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 19:48:00 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 19:48:03 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 2.00003 seconds. 19:48:03 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 2.00003 seconds. 19:48:05 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 19:48:14 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 19:48:15 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 19:48:17 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 19:48:19 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 19:48:21 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 19:48:23 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01676 seconds. 19:48:25 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 19:48:45 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:49:00 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 19:49:04 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01679 seconds. 19:49:05 INFO - PROCESS | 10087 | Cycle 1(1): loaded http://localhost:50758/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50758/tests/dromaeo/cssquery-yui.html) 19:49:06 INFO - PROCESS | 10087 | RSS: Main: 215629824 19:49:06 INFO - PROCESS | 10087 | 19:49:10 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 19:49:11 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 2.0334 seconds. 19:49:20 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:49:27 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 19:49:43 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 19:49:49 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 19:49:55 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 19:49:57 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 19:50:01 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 19:50:36 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 19:50:38 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 19:50:40 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 19:50:46 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 19:50:48 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 19:50:54 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 19:50:56 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 19:51:00 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:51:08 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 19:51:11 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:51:16 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 19:51:17 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 2.01668 seconds. 19:51:20 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 19:51:26 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 19:51:30 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:51:34 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:51:36 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 19:51:55 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 19:51:57 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:52:03 INFO - PROCESS | 10087 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 19:52:09 INFO - PROCESS | 10087 | Cycle 1(1): loaded http://localhost:50758/tests/dromaeo/cssquery-yui.html (next: http://localhost:50758/tests/dromaeo/cssquery-dojo.html) 19:52:09 INFO - PROCESS | 10087 | RSS: Main: 288092160 19:52:09 INFO - PROCESS | 10087 | 19:52:09 INFO - PROCESS | 10087 | __start_tp_report 19:52:09 INFO - PROCESS | 10087 | _x_x_mozilla_page_load 19:52:09 INFO - PROCESS | 10087 | _x_x_mozilla_page_load_details 19:52:09 INFO - PROCESS | 10087 | |i|pagename|runs| 19:52:09 INFO - PROCESS | 10087 | |0;dojo.html;2539.5174916765814;2601.6357709920603;2620.554505734025;2631.1711810779616;2647.5896236083413;4589.954100458995;4653.581177694007;4668.206404911165;4669.392978912741;4677.345171675964;4696.671233013691;4715.740634265114;4720.480747117823;4727.645426593011;4768.809247630099;4290.6352959998285;4333.068390296085;4348.564973558718;4362.25841606926;4457.264551349023;4436.600705936465;4446.666500012496;4456.131054444385;4458.910821783578;4471.4187155669715;4240.067185219247;4284.464441944757;4307.547707490699;4360.607545320936;4366.650667946573;4265.7440553566885;4283.550227226158;4310.504292006428;4314.201872653538;4377.102693947733;4270.295401258789;4271.850485233033;4275.657947364203;4294.312909934427;4326;4681.719096854165;4703.2239680452685;4719.575238228542;4719.976400118012;4732.881677958044;4894.021195760862;4931.432885218174;4990.5508504234795;5019.4227663818765;5025.246213068032;5070.923936140961;5074.112030394666;5077.695338279715;5078.5937125029905;5133.435322114565;4718.355736571675;4719.174144524694;4722.669413141047;4727.881802954885;4772.164871147535;5071.985602879365;5110.821121260812;5130.179171332569;5203.349581302337;5227.26818245446;4924.975375123101;4936.185529387682;4947.233178857283;4959.876003099951;4976.303317535476;5016.899662006739;5041.294218809297;5064.620153488503;5140.691558506502;5147.948520514822;5011.5489605935645;5049.065922804293;5104.795808167632;5119.1553393690365;5134.255532947702;5017.57350625201;5023.397192336943;5027.396712394463;5030.2957585938;5036.420811606712;4169.145325208325;4203.6637069034405;4209.368594710757;4270.508891477458;4282.186384586918;3634.582023067328;3713.1459764254373;3729.216864458494;3766.246750649881;3774.7168962327937;4342.392065110887;4343.739375637472;4345.760983145958;4346.7609281489185;4399.758013309235;5002.299678045077;5004.474530174352;5018.548330650259;5059.165237735732;5110.540051395392;4311.956880431156;4329.523752387235;4336.978315108404;4349.456317960255;4371.038371558252;4592.523196826715;4594.770261486912;4596.3105534170145;4606.193916064675;4637.420322459692;4720.787564559603;4735.408073990751;4736.976315118402;4737.45519265282;4789.95210047909;4935.333729946411;4980.825671101494;5049.621278404061;5081.44104148536;5110.207917772751;4789.736564488987;4793.089313030513;4793.472718001087;4816.373871396836;4851.490593487633;5039.067772462106;5043;5045.419776725576;5046.268291097696;5096;4922.581580565692;4961.982793527246;5069.797208111634;5098.1588037973315;5169.457206993212;4959.082569724613;5003.599712022957;5004.049230646166;5070.721110338966;5071.644984851025;4988.45127036033;4996.375453068366;4996.975015124901;4998.87502812418;5061.848144555669;4758.857234282977;4767.73777442244;4919.606431485401;4938.8765280868265;4987.60099192071;4960.950390496048;4989.25161225819;4996.100701873697;5008.874778130576;5069.721165335942;4855.902881942271;4880.829170979141;4895.143349913822;4908.092002979461;4955.231939049453 19:52:09 INFO - PROCESS | 10087 | |1;ext.html;526.2606038515884;563.6702529020522;567.526115693396;582.2518064287392;583.0350769476515;27681.723182768168;30428.239294017632;30478.542821857664;30518.3896322074;30522;30176.094717158467;39112.413313800316;39752.80123599385;39868.60131398685;43302.56697433025;7578.469507134503;7709.229077092302;7715.074191097076;7715.228477152268;7723.65243564041;5616.382197958222;5684.658920464785;5686.545076393879;5688.862227554485;7185.461090418214;7233.529820561673;9921.454320012397;10152.949235253813;10153.695389138338;10473.371597704125;10001.299909006373;10057.295989280754;10069.54687039085;10074.34516756412;10079.848802267972;9666.516674166334;9914.950425247827;9927.156191723712;9935.80128397428;9936;37329.62670373289;37694.623053769385;37739.24521509554;37744;37789.24421511554;2960.6595241547066;3057.2051266670605;3095;3204.070819462353;3320.352531256406;27602.5859612106;27639.447211055667;28273;28382.574261386097;30974.380512389627;2944.4847151748572;2944.6024786653743;3004.564338170953;3044.558539011853;3103.053568661557;258174;260127;260704;261132;262654;28364.85817570899;51791.48208517942;51941.48058519442;52074;52150.73924630353;30202.54696179559;31755.364892702015;31863.68136318607;31925.840370797996;31944.520832187536;13666.385012674453;13866.722665546633;13869.09850859691;13876.861231387758;13877.653058673412;11579.13156513265;11645;11647.41762911851;11649.1263155262;11653;7197.316254955771;7349.889751653729;7701.1902202982255;7760;7862.960685196652;2924.3712601790294;2995.6255468066493;3031.1512776422637;3076.507758758588;3087.1047396254835;783.5886159766169;836.2682652678906;862.2110768646618;899.8740176375313;960.5437417226761;25973;27475.190744527164;27476;27730.5840412394;27933.16200513947;890.1899271662885;929.7536152919482;951.785848184153;957.3824882950458;988.0703713489538;14013.929930350283;14134.15195088298;14147.434102635985;14157.221352825694;14485.348159332856;361277;364959;365005;365469.5897807622;366785;47407.52592474031;47901.520984790404;48060.27909581359;48106.75946620244;48158.759206203744;1122.3378206857992;1136.2046567402851;1145.135422755814;1210.915235933494;1212.0485418946262;25223.747762522875;26481.867590661925;27058.32354191161;27364.863175683993;27541.31146721348;41398.1720365597;41708.374374385014;41714.58285417107;41734;41769.16461670689;301323;302010;303245;303722;304887;24798.628020580065;25069.623955640316;25139.622905656062;25146.49707005813;25151;40136.39795403013;40554.59445405626;40655.59344406636;41619.167616648105;41792.16415671731;34703;34896.127596810285;35013.47479787856;35179;35639.465408019416;34786.30427391489;35233.82383088068;35239.647603523634;35567.64432355644;35585.28829423449;34916;35552.64447355493;35899.64100358963;36697.81651091728;38190;30517.694823051486;32944.1763955903;33144.83427582846;33149.17127071746;33188.50217246695;24683.753162468864;25020;25279.752550574824;25396.238112856645;25513.23460296194 19:52:09 INFO - PROCESS | 10087 | |2;jquery.html;342.84400597728035;368.8745826419017;369.4753450100857;372.58456820644983;391.5888317266871;12198.329091899943;12263.816042759354;13188.208707477557;13210;16961.830381696178;15653.921730391361;15951.760723589156;16912.154392280398;17012.319507219727;17227.82772172278;4738.47876733559;4752.691075080117;4951.876203094916;4959.355283813117;4996.875078123039;3660.396034654279;4903.509649035103;4980.402351717799;4982.327385802924;4983.127952608297;3813.6949044076546;5464.207689884965;5745.885082298351;5801.47786699197;5851.210086638292;5685.4883060524335;5820.272465941757;5835.941640583582;5839.416058394169;5849.151872978395;5167.0957582422925;5169.896602067975;5173.534381905609;5174.586033117379;5176.275321454999;17991.73012404815;18633.254669813192;18705.251789928385;19083.809161908343;20516.589668206554;1700.9659806803918;1822.2073398071882;1964.5972575621963;1978.485593745622;2236.899339529709;8496.915030849736;8798.51608161551;9250.907490925072;9622.326437149402;9759.853602195974;1634.3544300001433;1668.7580300856307;1694.9830501694948;1712.152484520158;1779.9288028478975;53617;63918.360816392174;65706.70026549096;69097.65451172763;74041.25958740451;9971.501424928725;9990.150837178775;10314.948425257826;10339.844902326471;10514.421706806199;14019.859801401855;14035.78946315806;14045.297735113203;14047.648808779657;14065.85934140666;7215.96392018047;7367.557946523226;7540.886886696704;7547.962260188664;7720.15078341382;6909.309069093151;6930.688119034656;6962.825929351706;7165.749198778018;7182;4004.1791432756213;4069.2471892699946;4287.713685894281;4372.475302963665;4388.824447022147;1771.2649250560873;1800.1629242402346;1855.7587513623412;1862.3761040051463;1869.9439016829517;756.8798178695451;776.413807575277;799.936005119589;841.3857883744901;860.5181098584687;16735.163241837858;17036.48890533286;17225.22486488111;17559.648807023787;17684.823151768574;752.7290175536803;763.9312461878458;771.3828936850609;791.3392317415023;794.3367288314322;9004.279657627374;9502.239820814319;9535.189508891823;9556.23550115989;9565.952170239105;355834;384820;385937;386241;387033;58243.70878145582;73880;74459;79888;83143;888.1518150166576;912.3978174404994;924.8705181274627;937.5124935033745;939.9483028433502;15534.145621990447;16167.67664646724;16521.091339976418;16621.66756664884;16635.737803053173;37492.81253593715;37996.81001594974;38406.23187536289;38907.61092389153;38964.220715586096;53582.73208633932;53954.73022634862;54687.45312546824;54946;55750.72124639351;6303.49572034227;6550.279469258282;6834.965825170842;6932.653367331714;6971.686274117778;9156;11644.35956022427;11654;11771.646850594496;11818.290902545874;9959.601615935282;10285.485725713834;10334.948325258325;10709;10833.241673082808;9811.313208075366;9880.35777674449;9892.752681183028;9975.800483990424;10121.848172277569;10234.897651023395;10266.486675666038;10394.532246048795;10395.844062339222;10442.164626829683;6844;6880.415164710856;6978.79063628092;7096.53872498286;7197.532160409557;8923.464592124494;10162.136218421518;10219.386836789816;10325.63860264887;10804.459777011276 19:52:09 INFO - PROCESS | 10087 | |3;mootools.html;1292.7802273613486;1366.6651670340766;1372.6019454358236;1646.6459711162097;1681.890677105988;6787.9321206788045;7023.543469674468;7511.323980841723;8082.313003394711;8102.513849169054;7410.740624078158;7699.230076992298;7714.228577142297;7866.292033716964;7883.054033515972;2142.710734050903;2160.0387827416807;2171.3703026122407;2171.522265101675;2172.1745736620064;1791.8656100792427;1847.7413162157309;2075.6056349293663;2104.5685634444903;2125.4048866317457;2076.294060019593;2146.248812915475;2146.903389347483;2148.4628842789302;2148.473623962124;2079.105984426696;2081.7918208179212;2113.154738104755;2128.12746773822;2132.1791110422446;2060.093558834123;2077.345636124616;2081.6149012432747;2083.562451885106;2084.249670118756;7840.803979900491;7903.209679032051;7933.206679332078;7937.72217972374;7942.880856787153;4410.448693913261;4480.955190448087;4555.04344087742;4557.726536407826;4563.178627847019;2669.853158076305;2811.704770999036;2851.0306495791324;2857.6142220800134;2871.3539453622975;862.4221771413105;881.8368601808686;885.8022538635521;888.342626456424;890.4746199742118;10350.275480716278;10408.427536485491;10427.217958653131;10431.68704938853;10458.581656733722;3805.4101614249835;3949.644531992077;4058.7158898876796;4070.1249231415386;4183.142455796555;8729.869051964226;8733.737987860375;8762.561871906379;8822.911770882338;8949.821003579891;4453.866384008485;4461.397711308997;4474.038081812426;4476.41806565151;4479.037007043501;4059.89850253746;4089.5297040840087;4092.2224777292217;4103.630673239423;4104.507459104867;3561.465780133001;3641.4537819326783;3647.598764135943;3654.7989860557923;3700.9259814803554;1060.1412855587;1108.6729414822646;1203.3802591665299;1216.5498765456837;1226.270369130366;639.8784230996096;693.982650433733;729.7810656802938;742.406075139886;752.2966026764992;4937.210046392632;5087.796488140433;5187.144121220032;5267.78928842842;5525.060739674184;772.3550835052681;785.7564155111934;861.5089399042486;864.3085531574715;885.4465958775766;3107.53386991953;3187.6015498062743;3202.6637203093806;3218.9195270117966;3304.6530114337647;9375.953120234355;9710.320277580642;9817.901820981842;9831.655892043744;9849.55676994537;9374.109459601326;9691.418514889128;9737.367071140354;9779.755506112404;9794.608215671436;6989.161300643854;7196.712131514681;7201.495895287279;7217.711291548279;7218.927810721931;4814.759262036954;5093.8726531837;5196.558292545176;5277.20841873722;5481.3422389311945;8971.730848074569;9133.45199288045;9138.31462640318;9144.58849351794;9254.814903702023;8786.253168480494;9026.503542305236;9101.044390339184;9149.817003660022;9234.9538252311;6525.249596296487;6611.570247933869;6624.072629831731;6663.866722665616;6714.194296684429;7306.342429181399;7365.189829118685;7369.263073692588;7385.926140738524;7388.630568471663;6686.3313668632745;6688.565243259172;6704.865902682017;6830.009648600826;7061.858762824818;6509.251436084911;6557.180352455943;6573.57271777333;6591.5056370773345;6835.384815366641;5807.0998995155815;5888.146218798336;5889.146073819186;5911.113332999912;5916.881662366814;4182.895427614212;4194.140201258796;4210.894727631834;4295.806688698954;4406.911861762811;4345.283028300295;4414.911701765883;4447.666425018072;4519.254323036794;4552.726836389827 19:52:09 INFO - PROCESS | 10087 | |4;prototype.html;293.7077607780259;296.1854899027674;304.32288158846563;305.8363775380172;305.9204606802231;4871;4890.532840147955;4900.093482705702;4900.166971614825;4923.5814955728765;4821.325014497965;4824.975875120628;4826.20080353395;4830.830920917769;4833.299171620113;3612.9458058129085;3710.8515659373593;3713.517242758451;3763.2285381496863;3834.9424758628643;3814.294355544233;3818.16000479894;3824.9426258606145;3833.386658134699;3848.076461649198;3797.3544497435364;3801.8479260829536;3812.809359532026;3817.351050321452;3819.6562309392148;3617.963820361789;3725.6833169180786;3726.7763934164036;3795.734298599099;3817.2174704185854;3367.5285460035616;3370.8651653934057;3392.4402473591826;3394.575678040245;3395.9660403395897;4739.95260047402;4748.145333839908;4759.547842954914;4766.261229509431;4799.568038876518;4231.492220933507;4362.541933097011;4387.94689274575;4390.385346051556;4393.033532622818;5050.39395272566;5054.444011158769;5056.797728090872;5063.139266324733;5063.265826455144;3707.9073023174365;3715.04959896054;3718.1184581949205;3723.441483777428;3725.8137093145506;5189.325387699612;5317;5324.600654950856;5356.4107948125675;5387.0841956867425;3787.0910981364273;3811.6950643948417;3813.3707938189887;3819.713521485844;3821.331267028259;3871.4192871069004;3874.1864208515963;3874.651281384689;3880.320943834874;3880.438910319232;4362.625772881533;4375.5341960442975;4387.254166791653;4389.103191893335;4396.824127034883;4997.425296090923;5077.715028237308;5092.872678183001;5115.667481613683;5120.257562653394;1328.8936885049172;1341.3226320708175;1341.9463221471226;1343.7043850352907;1345.098783814827;826.2522417212432;861.9396642235109;869.8825658536143;880.5861245214867;888.1340692824574;4365.236083685342;4391.538888416734;4487.506374298824;4493.932591011137;4500.527444618333;5231.738413079331;5233.5551478124025;5241.31862857826;5243.632945693841;5250.422453530108;4505.729656220572;4508.526604706524;4509.616682581952;4518.71216703238;4524.88687782808;2630.5396555602692;2753.2979090331837;2755.8897644094413;2770.224337185591;2798.2164993801766;4910.582600478928;4923.704577725348;4925.13810083234;4956.90086198274;4965.428975667773;5241.0828105081455;5321.760520776575;5386.892262154735;5391.086164411656;5404.648697834628;4873.390826146731;4890.266460030953;4904.6212586896045;4906.90186196274;4912.214045752734;5175.430702622633;5188.481151884781;5189.6107791915;5220.112580861339;5265.815696450606;4910.337104490991;5150.098732721834;5154;5178.8964220716125;5180.559652429435;4945.862451636216;4952.628552858478;4955.752212389294;4961.677490963076;4973.9253911190635;3720.1771132144513;3732.1602639407;3752.681022113151;3767.566729826105;3772.698184145207;5102.846914592568;5259.237410575369;5334.653247538898;5335.199720042025;5348.983693098299;5094.312267843794;5113.593761715558;5117.43708192106;5125.692458452356;5142.1258386073705;5086.694798312114;5087.949120508748;5128.79484820603;5147.9227811583605;5169.844904652867;4882.584980276574;4998.825041123689;5008.248762685626;5032.572231360376;5059.241113832807;4893.853184404474;5027.949720502895;5037.974810125926;5158.432572416956;5166.2508936203285;4958.206686930074;4979.203327467588;5031.773570189277;5040.521150490697;5054.21659642756 19:52:09 INFO - PROCESS | 10087 | |5;yui.html;552.7816512477569;611.0620197996077;629.792168584367;655.4821690864218;680.8966793879868;12526.373681315932;13198.340082995835;13520.93239533801;13668.248246346448;13725.725485490284;12857.614271571867;13212.933935330333;13275;13275.933620331909;13296.601101966933;737.376916505552;756.3042001358735;759.3242014607005;759.8062494064006;760.3612965109335;605.9091136329564;622.741562251665;731.0532859946383;755.056179775281;765.4335791514295;794.3367288314264;794.9364050875945;795.2167115391335;795.6061749434039;795.7533164718926;788.8304014636881;789.7907054630471;789.8143936175023;789.9091604465502;790.7983464216617;464.73510099243447;473.11763560958565;476.08829092288227;476.69491525423757;552.5551930695789;12536.749265014649;12644.620661380173;12911.935440322739;12917.160384574972;12940.417681204275;12224.266544007389;12277.570285039981;12681.682957926034;12763.234205947672;12887.484500620058;11353.659390218307;11751.236169648946;11828.526858925632;11848.585299514476;12579.119461637689;3981.581933896928;4022.658074063708;4063.756174629532;4071.491063617048;4088.3867419886956;64939.67530162366;65641.343586564;65988.67005664941;66926.99219023388;69527.3047269531;10286.588536458608;10351.534180961724;10671.786564268672;10699.62551310716;10725.356478611307;18233.36183233607;18375.816241837678;18399.632007359778;18406.815931840778;18419.26322947094;6321.494280457552;6341.619502829845;6384.616922984543;6445.709943052574;6855.931440685629;3468.271662950758;3469.7397695172963;3509.1402606361603;3589.569251689814;3590.605033446319;3023.1988523041414;3225.1614580209316;3256.1371236622313;3280.097973057428;3282.359939811714;529.4837533404899;533.1443033930564;533.7331334332833;538.7252501224403;546.3907742866754;482.2655543070797;493.64704236471096;525.4220357606679;526.3946461569226;534.7326336831584;7318.536292741473;7452.664630091659;7507.249275072449;7584;7789.844203116019;457.8557754307449;474.28146358267253;510.85951363374625;512.1089304609952;513.3480479790645;3506.526618906415;3518.9120271992892;3531.5408996830247;3741.644543768338;3904.9609503905167;92794;103010;106193;109353;109924.45037774919;86584;88680.55659721661;90607;91645.54177229072;93032;50723.49276507262;59221.40778592245;75009.6249518749;77265;78017;7079.575225486487;7201.6399180041835;7295.270472952662;7573.772786816405;7591.620418978919;44840;45305.320420193064;45701.54298457106;46282.53717462917;47091.529084710084;39254.214915700955;39914.00859913985;39991.80004099961;59246.70376648089;66561.33438665746;10101.848472273068;10118.19054475655;10205.336653117523;10248;10653.254272200871;10586.100181484351;10586.576536938745;10974.890251097388;11119.72200694989;11432.542698292307;9529.809403812023;9619.711408657471;9914.652987145415;10023.74940626461;10308.278420510493;9549.618015279311;9579.089986451276;9791.216702663913;9913.405195688281;10025.197984161105;8669.913300867163;8702.216800487986;8719.564021799011;8938.41900276506;9885.308028437941;7822.374210063295;7864.6854125834325;7887;8197.590120493833;8565.528895910784;7796.961015194887;8442.704505342284;8477.533735644598;8512;8575.571221438779 19:52:09 INFO - PROCESS | 10087 | __end_tp_report 19:52:09 INFO - PROCESS | 10087 | __start_cc_report 19:52:09 INFO - PROCESS | 10087 | _x_x_mozilla_cycle_collect,880 19:52:09 INFO - PROCESS | 10087 | __end_cc_report 19:52:09 INFO - PROCESS | 10087 | __startTimestamp1474339929515__endTimestamp 19:52:09 INFO - PROCESS | 10087 | 19:52:09 INFO - PROCESS | 10087 | ------- Summary: start ------- 19:52:09 INFO - PROCESS | 10087 | Number of tests: 6 19:52:09 INFO - PROCESS | 10087 | 19:52:09 INFO - PROCESS | 10087 | [#0] dojo.html Cycles:165 Average:4675.25 Median:4789.95 stddev:501.03 (10.5%) stddev-sans-first:473.72 19:52:09 INFO - PROCESS | 10087 | Values: 2539.5 2601.6 2620.6 2631.2 2647.6 4590.0 4653.6 4668.2 4669.4 4677.3 4696.7 4715.7 4720.5 4727.6 4768.8 4290.6 4333.1 4348.6 4362.3 4457.3 4436.6 4446.7 4456.1 4458.9 4471.4 4240.1 4284.5 4307.5 4360.6 4366.7 4265.7 4283.6 4310.5 4314.2 4377.1 4270.3 4271.9 4275.7 4294.3 4326.0 4681.7 4703.2 4719.6 4720.0 4732.9 4894.0 4931.4 4990.6 5019.4 5025.2 5070.9 5074.1 5077.7 5078.6 5133.4 4718.4 4719.2 4722.7 4727.9 4772.2 5072.0 5110.8 5130.2 5203.3 5227.3 4925.0 4936.2 4947.2 4959.9 4976.3 5016.9 5041.3 5064.6 5140.7 5147.9 5011.5 5049.1 5104.8 5119.2 5134.3 5017.6 5023.4 5027.4 5030.3 5036.4 4169.1 4203.7 4209.4 4270.5 4282.2 3634.6 3713.1 3729.2 3766.2 3774.7 4342.4 4343.7 4345.8 4346.8 4399.8 5002.3 5004.5 5018.5 5059.2 5110.5 4312.0 4329.5 4337.0 4349.5 4371.0 4592.5 4594.8 4596.3 4606.2 4637.4 4720.8 4735.4 4737.0 4737.5 4790.0 4935.3 4980.8 5049.6 5081.4 5110.2 4789.7 4793.1 4793.5 4816.4 4851.5 5039.1 5043.0 5045.4 5046.3 5096.0 4922.6 4962.0 5069.8 5098.2 5169.5 4959.1 5003.6 5004.0 5070.7 5071.6 4988.5 4996.4 4997.0 4998.9 5061.8 4758.9 4767.7 4919.6 4938.9 4987.6 4961.0 4989.3 4996.1 5008.9 5069.7 4855.9 4880.8 4895.1 4908.1 4955.2 19:52:09 INFO - PROCESS | 10087 | 19:52:09 INFO - PROCESS | 10087 | [#1] ext.html Cycles:180 Average:44968.11 Median:33044.51 stddev:82248.41 (248.9%) stddev-sans-first:82411.45 19:52:09 INFO - PROCESS | 10087 | Values: 526.3 563.7 567.5 582.3 583.0 27681.7 30428.2 30478.5 30518.4 30522.0 30176.1 39112.4 39752.8 39868.6 43302.6 7578.5 7709.2 7715.1 7715.2 7723.7 5616.4 5684.7 5686.5 5688.9 7185.5 7233.5 9921.5 10152.9 10153.7 10473.4 10001.3 10057.3 10069.5 10074.3 10079.8 9666.5 9915.0 9927.2 9935.8 9936.0 37329.6 37694.6 37739.2 37744.0 37789.2 2960.7 3057.2 3095.0 3204.1 3320.4 27602.6 27639.4 28273.0 28382.6 30974.4 2944.5 2944.6 3004.6 3044.6 3103.1 258174.0 260127.0 260704.0 261132.0 262654.0 28364.9 51791.5 51941.5 52074.0 52150.7 30202.5 31755.4 31863.7 31925.8 31944.5 13666.4 13866.7 13869.1 13876.9 13877.7 11579.1 11645.0 11647.4 11649.1 11653.0 7197.3 7349.9 7701.2 7760.0 7863.0 2924.4 2995.6 3031.2 3076.5 3087.1 783.6 836.3 862.2 899.9 960.5 25973.0 27475.2 27476.0 27730.6 27933.2 890.2 929.8 951.8 957.4 988.1 14013.9 14134.2 14147.4 14157.2 14485.3 361277.0 364959.0 365005.0 365469.6 366785.0 47407.5 47901.5 48060.3 48106.8 48158.8 1122.3 1136.2 1145.1 1210.9 1212.0 25223.7 26481.9 27058.3 27364.9 27541.3 41398.2 41708.4 41714.6 41734.0 41769.2 301323.0 302010.0 303245.0 303722.0 304887.0 24798.6 25069.6 25139.6 25146.5 25151.0 40136.4 40554.6 40655.6 41619.2 41792.2 34703.0 34896.1 35013.5 35179.0 35639.5 34786.3 35233.8 35239.6 35567.6 35585.3 34916.0 35552.6 35899.6 36697.8 38190.0 30517.7 32944.2 33144.8 33149.2 33188.5 24683.8 25020.0 25279.8 25396.2 25513.2 19:52:09 INFO - PROCESS | 10087 | 19:52:09 INFO - PROCESS | 10087 | [#2] jquery.html Cycles:180 Average:23787.11 Median:4927.69 stddev:62807.30 (1274.6%) stddev-sans-first:62958.83 19:52:09 INFO - PROCESS | 10087 | Values: 342.8 368.9 369.5 372.6 391.6 12198.3 12263.8 13188.2 13210.0 16961.8 15653.9 15951.8 16912.2 17012.3 17227.8 4738.5 4752.7 4951.9 4959.4 4996.9 3660.4 4903.5 4980.4 4982.3 4983.1 3813.7 5464.2 5745.9 5801.5 5851.2 5685.5 5820.3 5835.9 5839.4 5849.2 5167.1 5169.9 5173.5 5174.6 5176.3 17991.7 18633.3 18705.3 19083.8 20516.6 1701.0 1822.2 1964.6 1978.5 2236.9 8496.9 8798.5 9250.9 9622.3 9759.9 1634.4 1668.8 1695.0 1712.2 1779.9 53617.0 63918.4 65706.7 69097.7 74041.3 9971.5 9990.2 10314.9 10339.8 10514.4 14019.9 14035.8 14045.3 14047.6 14065.9 7216.0 7367.6 7540.9 7548.0 7720.2 6909.3 6930.7 6962.8 7165.7 7182.0 4004.2 4069.2 4287.7 4372.5 4388.8 1771.3 1800.2 1855.8 1862.4 1869.9 756.9 776.4 799.9 841.4 860.5 16735.2 17036.5 17225.2 17559.6 17684.8 752.7 763.9 771.4 791.3 794.3 9004.3 9502.2 9535.2 9556.2 9566.0 355834.0 384820.0 385937.0 386241.0 387033.0 58243.7 73880.0 74459.0 79888.0 83143.0 888.2 912.4 924.9 937.5 939.9 15534.1 16167.7 16521.1 16621.7 16635.7 37492.8 37996.8 38406.2 38907.6 38964.2 53582.7 53954.7 54687.5 54946.0 55750.7 6303.5 6550.3 6835.0 6932.7 6971.7 9156.0 11644.4 11654.0 11771.6 11818.3 9959.6 10285.5 10334.9 10709.0 10833.2 9811.3 9880.4 9892.8 9975.8 10121.8 10234.9 10266.5 10394.5 10395.8 10442.2 6844.0 6880.4 6978.8 7096.5 7197.5 8923.5 10162.1 10219.4 10325.6 10804.5 19:52:09 INFO - PROCESS | 10087 | 19:52:09 INFO - PROCESS | 10087 | [#3] mootools.html Cycles:180 Average:5048.15 Median:5232.17 stddev:2889.00 (55.2%) stddev-sans-first:2883.32 19:52:09 INFO - PROCESS | 10087 | Values: 1292.8 1366.7 1372.6 1646.6 1681.9 6787.9 7023.5 7511.3 8082.3 8102.5 7410.7 7699.2 7714.2 7866.3 7883.1 2142.7 2160.0 2171.4 2171.5 2172.2 1791.9 1847.7 2075.6 2104.6 2125.4 2076.3 2146.2 2146.9 2148.5 2148.5 2079.1 2081.8 2113.2 2128.1 2132.2 2060.1 2077.3 2081.6 2083.6 2084.2 7840.8 7903.2 7933.2 7937.7 7942.9 4410.4 4481.0 4555.0 4557.7 4563.2 2669.9 2811.7 2851.0 2857.6 2871.4 862.4 881.8 885.8 888.3 890.5 10350.3 10408.4 10427.2 10431.7 10458.6 3805.4 3949.6 4058.7 4070.1 4183.1 8729.9 8733.7 8762.6 8822.9 8949.8 4453.9 4461.4 4474.0 4476.4 4479.0 4059.9 4089.5 4092.2 4103.6 4104.5 3561.5 3641.5 3647.6 3654.8 3700.9 1060.1 1108.7 1203.4 1216.5 1226.3 639.9 694.0 729.8 742.4 752.3 4937.2 5087.8 5187.1 5267.8 5525.1 772.4 785.8 861.5 864.3 885.4 3107.5 3187.6 3202.7 3218.9 3304.7 9376.0 9710.3 9817.9 9831.7 9849.6 9374.1 9691.4 9737.4 9779.8 9794.6 6989.2 7196.7 7201.5 7217.7 7218.9 4814.8 5093.9 5196.6 5277.2 5481.3 8971.7 9133.5 9138.3 9144.6 9254.8 8786.3 9026.5 9101.0 9149.8 9235.0 6525.2 6611.6 6624.1 6663.9 6714.2 7306.3 7365.2 7369.3 7385.9 7388.6 6686.3 6688.6 6704.9 6830.0 7061.9 6509.3 6557.2 6573.6 6591.5 6835.4 5807.1 5888.1 5889.1 5911.1 5916.9 4182.9 4194.1 4210.9 4295.8 4406.9 4345.3 4414.9 4447.7 4519.3 4552.7 19:52:09 INFO - PROCESS | 10087 | 19:52:09 INFO - PROCESS | 10087 | [#4] prototype.html Cycles:180 Average:4244.82 Median:4872.20 stddev:1223.84 (25.1%) stddev-sans-first:1190.80 19:52:09 INFO - PROCESS | 10087 | Values: 293.7 296.2 304.3 305.8 305.9 4871.0 4890.5 4900.1 4900.2 4923.6 4821.3 4825.0 4826.2 4830.8 4833.3 3612.9 3710.9 3713.5 3763.2 3834.9 3814.3 3818.2 3824.9 3833.4 3848.1 3797.4 3801.8 3812.8 3817.4 3819.7 3618.0 3725.7 3726.8 3795.7 3817.2 3367.5 3370.9 3392.4 3394.6 3396.0 4740.0 4748.1 4759.5 4766.3 4799.6 4231.5 4362.5 4387.9 4390.4 4393.0 5050.4 5054.4 5056.8 5063.1 5063.3 3707.9 3715.0 3718.1 3723.4 3725.8 5189.3 5317.0 5324.6 5356.4 5387.1 3787.1 3811.7 3813.4 3819.7 3821.3 3871.4 3874.2 3874.7 3880.3 3880.4 4362.6 4375.5 4387.3 4389.1 4396.8 4997.4 5077.7 5092.9 5115.7 5120.3 1328.9 1341.3 1341.9 1343.7 1345.1 826.3 861.9 869.9 880.6 888.1 4365.2 4391.5 4487.5 4493.9 4500.5 5231.7 5233.6 5241.3 5243.6 5250.4 4505.7 4508.5 4509.6 4518.7 4524.9 2630.5 2753.3 2755.9 2770.2 2798.2 4910.6 4923.7 4925.1 4956.9 4965.4 5241.1 5321.8 5386.9 5391.1 5404.6 4873.4 4890.3 4904.6 4906.9 4912.2 5175.4 5188.5 5189.6 5220.1 5265.8 4910.3 5150.1 5154.0 5178.9 5180.6 4945.9 4952.6 4955.8 4961.7 4973.9 3720.2 3732.2 3752.7 3767.6 3772.7 5102.8 5259.2 5334.7 5335.2 5349.0 5094.3 5113.6 5117.4 5125.7 5142.1 5086.7 5087.9 5128.8 5147.9 5169.8 4882.6 4998.8 5008.2 5032.6 5059.2 4893.9 5027.9 5038.0 5158.4 5166.3 4958.2 4979.2 5031.8 5040.5 5054.2 19:52:09 INFO - PROCESS | 10087 | 19:52:09 INFO - PROCESS | 10087 | [#5] yui.html Cycles:180 Average:17340.10 Median:512.73 stddev:25969.06 (5064.9%) stddev-sans-first:26011.32 19:52:09 INFO - PROCESS | 10087 | Values: 552.8 611.1 629.8 655.5 680.9 12526.4 13198.3 13520.9 13668.2 13725.7 12857.6 13212.9 13275.0 13275.9 13296.6 737.4 756.3 759.3 759.8 760.4 605.9 622.7 731.1 755.1 765.4 794.3 794.9 795.2 795.6 795.8 788.8 789.8 789.8 789.9 790.8 464.7 473.1 476.1 476.7 552.6 12536.7 12644.6 12911.9 12917.2 12940.4 12224.3 12277.6 12681.7 12763.2 12887.5 11353.7 11751.2 11828.5 11848.6 12579.1 3981.6 4022.7 4063.8 4071.5 4088.4 64939.7 65641.3 65988.7 66927.0 69527.3 10286.6 10351.5 10671.8 10699.6 10725.4 18233.4 18375.8 18399.6 18406.8 18419.3 6321.5 6341.6 6384.6 6445.7 6855.9 3468.3 3469.7 3509.1 3589.6 3590.6 3023.2 3225.2 3256.1 3280.1 3282.4 529.5 533.1 533.7 538.7 546.4 482.3 493.6 525.4 526.4 534.7 7318.5 7452.7 7507.2 7584.0 7789.8 457.9 474.3 510.9 512.1 513.3 3506.5 3518.9 3531.5 3741.6 3905.0 92794.0 103010.0 106193.0 109353.0 109924.5 86584.0 88680.6 90607.0 91645.5 93032.0 50723.5 59221.4 75009.6 77265.0 78017.0 7079.6 7201.6 7295.3 7573.8 7591.6 44840.0 45305.3 45701.5 46282.5 47091.5 39254.2 39914.0 39991.8 59246.7 66561.3 10101.8 10118.2 10205.3 10248.0 10653.3 10586.1 10586.6 10974.9 11119.7 11432.5 9529.8 9619.7 9914.7 10023.7 10308.3 9549.6 9579.1 9791.2 9913.4 10025.2 8669.9 8702.2 8719.6 8938.4 9885.3 7822.4 7864.7 7887.0 8197.6 8565.5 7797.0 8442.7 8477.5 8512.0 8575.6 19:52:09 INFO - PROCESS | 10087 | -------- Summary: end -------- 19:52:09 INFO - PROCESS | 10087 | 19:52:10 INFO - TEST-INFO | 10087: exit 0 19:52:10 INFO - TEST-OK | dromaeo_css | took 1120738ms 19:52:10 INFO - TEST-START | kraken 19:52:10 INFO - operating with platform_type : linux_ 19:52:10 INFO - Initialising browser for kraken test... 19:52:10 INFO - TEST-INFO | started process 10392 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprrffs5/profile http://localhost:50758/getInfo.html) 19:52:15 INFO - PROCESS | 10392 | __metrics Screen width/height:1600/1200 19:52:15 INFO - PROCESS | 10392 | colorDepth:24 19:52:15 INFO - PROCESS | 10392 | Browser inner width/height: 1024/697 19:52:15 INFO - PROCESS | 10392 | __metrics 19:52:15 INFO - PROCESS | 10392 | 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" 19:52:15 INFO - PROCESS | 10392 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:52:16 INFO - PROCESS | 10392 | console.error: PushService: 19:52:16 INFO - PROCESS | 10392 | stateChangeProcessEnqueue: Error transitioning state 19:52:16 INFO - PROCESS | 10392 | UnknownError 19:52:16 INFO - TEST-INFO | 10392: exit 0 19:52:16 INFO - Browser initialized. 19:52:16 INFO - Running cycle 1/1 for kraken test... 19:52:16 INFO - TEST-INFO | started process 10476 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprrffs5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:52:29 INFO - PROCESS | 10476 | RSS: Main: 175288320 19:52:29 INFO - PROCESS | 10476 | 19:52:32 INFO - PROCESS | 10476 | Cycle 1(1): loaded http://localhost:50758/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50758/tests/kraken/driver.html?testName=audio-beat-detection) 19:52:32 INFO - PROCESS | 10476 | RSS: Main: 242266112 19:52:32 INFO - PROCESS | 10476 | 19:52:35 INFO - PROCESS | 10476 | Cycle 1(1): loaded http://localhost:50758/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50758/tests/kraken/driver.html?testName=audio-dft) 19:52:36 INFO - PROCESS | 10476 | RSS: Main: 218554368 19:52:36 INFO - PROCESS | 10476 | 19:52:39 INFO - PROCESS | 10476 | Cycle 1(1): loaded http://localhost:50758/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50758/tests/kraken/driver.html?testName=audio-fft) 19:52:40 INFO - PROCESS | 10476 | RSS: Main: 300208128 19:52:40 INFO - PROCESS | 10476 | 19:52:42 INFO - PROCESS | 10476 | Cycle 1(1): loaded http://localhost:50758/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50758/tests/kraken/driver.html?testName=audio-oscillator) 19:52:42 INFO - PROCESS | 10476 | RSS: Main: 209162240 19:52:42 INFO - PROCESS | 10476 | 19:52:45 INFO - PROCESS | 10476 | Cycle 1(1): loaded http://localhost:50758/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50758/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:52:45 INFO - PROCESS | 10476 | RSS: Main: 213815296 19:52:45 INFO - PROCESS | 10476 | 19:52:48 INFO - PROCESS | 10476 | Cycle 1(1): loaded http://localhost:50758/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50758/tests/kraken/driver.html?testName=imaging-darkroom) 19:52:49 INFO - PROCESS | 10476 | RSS: Main: 250322944 19:52:49 INFO - PROCESS | 10476 | 19:52:52 INFO - PROCESS | 10476 | Cycle 1(1): loaded http://localhost:50758/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50758/tests/kraken/driver.html?testName=imaging-desaturate) 19:52:53 INFO - PROCESS | 10476 | RSS: Main: 244658176 19:52:53 INFO - PROCESS | 10476 | 19:52:56 INFO - PROCESS | 10476 | Cycle 1(1): loaded http://localhost:50758/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50758/tests/kraken/driver.html?testName=json-parse-financial) 19:52:57 INFO - PROCESS | 10476 | RSS: Main: 246943744 19:52:57 INFO - PROCESS | 10476 | 19:52:58 INFO - PROCESS | 10476 | Cycle 1(1): loaded http://localhost:50758/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50758/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:52:59 INFO - PROCESS | 10476 | RSS: Main: 211169280 19:52:59 INFO - PROCESS | 10476 | 19:53:01 INFO - PROCESS | 10476 | Cycle 1(1): loaded http://localhost:50758/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50758/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:53:02 INFO - PROCESS | 10476 | RSS: Main: 218460160 19:53:02 INFO - PROCESS | 10476 | 19:53:04 INFO - PROCESS | 10476 | Cycle 1(1): loaded http://localhost:50758/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50758/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:53:05 INFO - PROCESS | 10476 | RSS: Main: 222564352 19:53:05 INFO - PROCESS | 10476 | 19:53:07 INFO - PROCESS | 10476 | Cycle 1(1): loaded http://localhost:50758/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50758/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:53:08 INFO - PROCESS | 10476 | RSS: Main: 223916032 19:53:08 INFO - PROCESS | 10476 | 19:53:11 INFO - PROCESS | 10476 | Cycle 1(1): loaded http://localhost:50758/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50758/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:53:12 INFO - PROCESS | 10476 | RSS: Main: 222261248 19:53:12 INFO - PROCESS | 10476 | 19:53:13 INFO - PROCESS | 10476 | Cycle 1(1): loaded http://localhost:50758/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50758/tests/kraken/driver.html?testName=ai-astar) 19:53:14 INFO - PROCESS | 10476 | RSS: Main: 273670144 19:53:14 INFO - PROCESS | 10476 | 19:53:14 INFO - PROCESS | 10476 | __start_tp_report 19:53:14 INFO - PROCESS | 10476 | _x_x_mozilla_page_load 19:53:14 INFO - PROCESS | 10476 | _x_x_mozilla_page_load_details 19:53:14 INFO - PROCESS | 10476 | |i|pagename|runs| 19:53:14 INFO - PROCESS | 10476 | |0;ai-astar;112;114;114;115;114;114;115;115;118;115 19:53:14 INFO - PROCESS | 10476 | |1;audio-beat-detection;147;132;129;166;123;131;130;130;163;132 19:53:14 INFO - PROCESS | 10476 | |2;audio-dft;161;160;162;162;162;161;161;162;163;163 19:53:14 INFO - PROCESS | 10476 | |3;audio-fft;76;76;76;109;75;77;79;77;98;77 19:53:14 INFO - PROCESS | 10476 | |4;audio-oscillator;85;84;115;84;84;84;106;84;84;109 19:53:14 INFO - PROCESS | 10476 | |5;imaging-gaussian-blur;117;117;117;116;118;117;117;116;117;117 19:53:14 INFO - PROCESS | 10476 | |6;imaging-darkroom;147;147;147;146;146;146;146;146;146;146 19:53:14 INFO - PROCESS | 10476 | |7;imaging-desaturate;95;95;95;95;95;95;94;96;95;95 19:53:14 INFO - PROCESS | 10476 | |8;json-parse-financial;65;76;65;64;66;66;66;66;65;64 19:53:14 INFO - PROCESS | 10476 | |9;json-stringify-tinderbox;66;66;66;66;66;66;67;69;67;66 19:53:14 INFO - PROCESS | 10476 | |10;stanford-crypto-aes;82;83;83;82;85;88;82;91;82;82 19:53:14 INFO - PROCESS | 10476 | |11;stanford-crypto-ccm;140;134;133;132;131;141;144;147;179;142 19:53:14 INFO - PROCESS | 10476 | |12;stanford-crypto-pbkdf2;178;173;176;176;172;172;174;171;177;178 19:53:14 INFO - PROCESS | 10476 | |13;stanford-crypto-sha256-iterative;69;70;78;68;70;70;70;69;68;68 19:53:14 INFO - PROCESS | 10476 | __end_tp_report 19:53:14 INFO - PROCESS | 10476 | __start_cc_report 19:53:14 INFO - PROCESS | 10476 | _x_x_mozilla_cycle_collect,1998 19:53:14 INFO - PROCESS | 10476 | __end_cc_report 19:53:14 INFO - PROCESS | 10476 | __startTimestamp1474339994024__endTimestamp 19:53:14 INFO - PROCESS | 10476 | 19:53:14 INFO - PROCESS | 10476 | ------- Summary: start ------- 19:53:14 INFO - PROCESS | 10476 | Number of tests: 14 19:53:14 INFO - PROCESS | 10476 | 19:53:14 INFO - PROCESS | 10476 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:1.51 (1.3%) stddev-sans-first:1.27 19:53:14 INFO - PROCESS | 10476 | Values: 112.0 114.0 114.0 115.0 114.0 114.0 115.0 115.0 118.0 115.0 19:53:14 INFO - PROCESS | 10476 | 19:53:14 INFO - PROCESS | 10476 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:132.00 stddev:15.07 (11.4%) stddev-sans-first:15.65 19:53:14 INFO - PROCESS | 10476 | Values: 147.0 132.0 129.0 166.0 123.0 131.0 130.0 130.0 163.0 132.0 19:53:14 INFO - PROCESS | 10476 | 19:53:14 INFO - PROCESS | 10476 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 19:53:14 INFO - PROCESS | 10476 | Values: 161.0 160.0 162.0 162.0 162.0 161.0 161.0 162.0 163.0 163.0 19:53:14 INFO - PROCESS | 10476 | 19:53:14 INFO - PROCESS | 10476 | [#3] audio-fft Cycles:10 Average:82.00 Median:77.00 stddev:11.67 (15.2%) stddev-sans-first:12.18 19:53:14 INFO - PROCESS | 10476 | Values: 76.0 76.0 76.0 109.0 75.0 77.0 79.0 77.0 98.0 77.0 19:53:14 INFO - PROCESS | 10476 | 19:53:14 INFO - PROCESS | 10476 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:84.00 stddev:12.68 (15.1%) stddev-sans-first:13.20 19:53:14 INFO - PROCESS | 10476 | Values: 85.0 84.0 115.0 84.0 84.0 84.0 106.0 84.0 84.0 109.0 19:53:14 INFO - PROCESS | 10476 | 19:53:14 INFO - PROCESS | 10476 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 19:53:14 INFO - PROCESS | 10476 | Values: 117.0 117.0 117.0 116.0 118.0 117.0 117.0 116.0 117.0 117.0 19:53:14 INFO - PROCESS | 10476 | 19:53:14 INFO - PROCESS | 10476 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 19:53:14 INFO - PROCESS | 10476 | Values: 147.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 19:53:14 INFO - PROCESS | 10476 | 19:53:14 INFO - PROCESS | 10476 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 19:53:14 INFO - PROCESS | 10476 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 96.0 95.0 95.0 19:53:14 INFO - PROCESS | 10476 | 19:53:14 INFO - PROCESS | 10476 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:66.00 stddev:3.50 (5.3%) stddev-sans-first:3.68 19:53:14 INFO - PROCESS | 10476 | Values: 65.0 76.0 65.0 64.0 66.0 66.0 66.0 66.0 65.0 64.0 19:53:14 INFO - PROCESS | 10476 | 19:53:14 INFO - PROCESS | 10476 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 19:53:14 INFO - PROCESS | 10476 | Values: 66.0 66.0 66.0 66.0 66.0 66.0 67.0 69.0 67.0 66.0 19:53:14 INFO - PROCESS | 10476 | 19:53:14 INFO - PROCESS | 10476 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:83.00 stddev:3.13 (3.8%) stddev-sans-first:3.23 19:53:14 INFO - PROCESS | 10476 | Values: 82.0 83.0 83.0 82.0 85.0 88.0 82.0 91.0 82.0 82.0 19:53:14 INFO - PROCESS | 10476 | 19:53:14 INFO - PROCESS | 10476 | [#11] stanford-crypto-ccm Cycles:10 Average:142.30 Median:141.50 stddev:14.02 (9.9%) stddev-sans-first:14.84 19:53:14 INFO - PROCESS | 10476 | Values: 140.0 134.0 133.0 132.0 131.0 141.0 144.0 147.0 179.0 142.0 19:53:14 INFO - PROCESS | 10476 | 19:53:14 INFO - PROCESS | 10476 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.70 Median:176.00 stddev:2.63 (1.5%) stddev-sans-first:2.50 19:53:14 INFO - PROCESS | 10476 | Values: 178.0 173.0 176.0 176.0 172.0 172.0 174.0 171.0 177.0 178.0 19:53:14 INFO - PROCESS | 10476 | 19:53:14 INFO - PROCESS | 10476 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:2.94 (4.2%) stddev-sans-first:3.10 19:53:14 INFO - PROCESS | 10476 | Values: 69.0 70.0 78.0 68.0 70.0 70.0 70.0 69.0 68.0 68.0 19:53:14 INFO - PROCESS | 10476 | -------- Summary: end -------- 19:53:14 INFO - PROCESS | 10476 | 19:53:15 INFO - TEST-INFO | 10476: exit 0 19:53:15 INFO - TEST-OK | kraken | took 64921ms 19:53:15 INFO - SUITE-END | took 1185s 19:53:15 INFO - Completed test suite (00:19:46) 19:53:15 INFO - javascript benchmark 19:53:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2539.5174916765814, 2601.6357709920603, 2620.554505734025, 2631.1711810779616, 2647.5896236083413, 4589.954100458995, 4653.581177694007, 4668.206404911165, 4669.392978912741, 4677.345171675964, 4696.671233013691, 4715.740634265114, 4720.480747117823, 4727.645426593011, 4768.809247630099, 4290.6352959998285, 4333.068390296085, 4348.564973558718, 4362.25841606926, 4457.264551349023, 4436.600705936465, 4446.666500012496, 4456.131054444385, 4458.910821783578, 4471.4187155669715, 4240.067185219247, 4284.464441944757, 4307.547707490699, 4360.607545320936, 4366.650667946573, 4265.7440553566885, 4283.550227226158, 4310.504292006428, 4314.201872653538, 4377.102693947733, 4270.295401258789, 4271.850485233033, 4275.657947364203, 4294.312909934427, 4326.0, 4681.719096854165, 4703.2239680452685, 4719.575238228542, 4719.976400118012, 4732.881677958044, 4894.021195760862, 4931.432885218174, 4990.5508504234795, 5019.4227663818765, 5025.246213068032, 5070.923936140961, 5074.112030394666, 5077.695338279715, 5078.5937125029905, 5133.435322114565, 4718.355736571675, 4719.174144524694, 4722.669413141047, 4727.881802954885, 4772.164871147535, 5071.985602879365, 5110.821121260812, 5130.179171332569, 5203.349581302337, 5227.26818245446, 4924.975375123101, 4936.185529387682, 4947.233178857283, 4959.876003099951, 4976.303317535476, 5016.899662006739, 5041.294218809297, 5064.620153488503, 5140.691558506502, 5147.948520514822, 5011.5489605935645, 5049.065922804293, 5104.795808167632, 5119.1553393690365, 5134.255532947702, 5017.57350625201, 5023.397192336943, 5027.396712394463, 5030.2957585938, 5036.420811606712, 4169.145325208325, 4203.6637069034405, 4209.368594710757, 4270.508891477458, 4282.186384586918, 3634.582023067328, 3713.1459764254373, 3729.216864458494, 3766.246750649881, 3774.7168962327937, 4342.392065110887, 4343.739375637472, 4345.760983145958, 4346.7609281489185, 4399.758013309235, 5002.299678045077, 5004.474530174352, 5018.548330650259, 5059.165237735732, 5110.540051395392, 4311.956880431156, 4329.523752387235, 4336.978315108404, 4349.456317960255, 4371.038371558252, 4592.523196826715, 4594.770261486912, 4596.3105534170145, 4606.193916064675, 4637.420322459692, 4720.787564559603, 4735.408073990751, 4736.976315118402, 4737.45519265282, 4789.95210047909, 4935.333729946411, 4980.825671101494, 5049.621278404061, 5081.44104148536, 5110.207917772751, 4789.736564488987, 4793.089313030513, 4793.472718001087, 4816.373871396836, 4851.490593487633, 5039.067772462106, 5043.0, 5045.419776725576, 5046.268291097696, 5096.0, 4922.581580565692, 4961.982793527246, 5069.797208111634, 5098.1588037973315, 5169.457206993212, 4959.082569724613, 5003.599712022957, 5004.049230646166, 5070.721110338966, 5071.644984851025, 4988.45127036033, 4996.375453068366, 4996.975015124901, 4998.87502812418, 5061.848144555669, 4758.857234282977, 4767.73777442244, 4919.606431485401, 4938.8765280868265, 4987.60099192071, 4960.950390496048, 4989.25161225819, 4996.100701873697, 5008.874778130576, 5069.721165335942, 4855.902881942271, 4880.829170979141, 4895.143349913822, 4908.092002979461, 4955.231939049453], "value": 4642.34803072019, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [526.2606038515884, 563.6702529020522, 567.526115693396, 582.2518064287392, 583.0350769476515, 27681.723182768168, 30428.239294017632, 30478.542821857664, 30518.3896322074, 30522.0, 30176.094717158467, 39112.413313800316, 39752.80123599385, 39868.60131398685, 43302.56697433025, 7578.469507134503, 7709.229077092302, 7715.074191097076, 7715.228477152268, 7723.65243564041, 5616.382197958222, 5684.658920464785, 5686.545076393879, 5688.862227554485, 7185.461090418214, 7233.529820561673, 9921.454320012397, 10152.949235253813, 10153.695389138338, 10473.371597704125, 10001.299909006373, 10057.295989280754, 10069.54687039085, 10074.34516756412, 10079.848802267972, 9666.516674166334, 9914.950425247827, 9927.156191723712, 9935.80128397428, 9936.0, 37329.62670373289, 37694.623053769385, 37739.24521509554, 37744.0, 37789.24421511554, 2960.6595241547066, 3057.2051266670605, 3095.0, 3204.070819462353, 3320.352531256406, 27602.5859612106, 27639.447211055667, 28273.0, 28382.574261386097, 30974.380512389627, 2944.4847151748572, 2944.6024786653743, 3004.564338170953, 3044.558539011853, 3103.053568661557, 258174.0, 260127.0, 260704.0, 261132.0, 262654.0, 28364.85817570899, 51791.48208517942, 51941.48058519442, 52074.0, 52150.73924630353, 30202.54696179559, 31755.364892702015, 31863.68136318607, 31925.840370797996, 31944.520832187536, 13666.385012674453, 13866.722665546633, 13869.09850859691, 13876.861231387758, 13877.653058673412, 11579.13156513265, 11645.0, 11647.41762911851, 11649.1263155262, 11653.0, 7197.316254955771, 7349.889751653729, 7701.1902202982255, 7760.0, 7862.960685196652, 2924.3712601790294, 2995.6255468066493, 3031.1512776422637, 3076.507758758588, 3087.1047396254835, 783.5886159766169, 836.2682652678906, 862.2110768646618, 899.8740176375313, 960.5437417226761, 25973.0, 27475.190744527164, 27476.0, 27730.5840412394, 27933.16200513947, 890.1899271662885, 929.7536152919482, 951.785848184153, 957.3824882950458, 988.0703713489538, 14013.929930350283, 14134.15195088298, 14147.434102635985, 14157.221352825694, 14485.348159332856, 361277.0, 364959.0, 365005.0, 365469.5897807622, 366785.0, 47407.52592474031, 47901.520984790404, 48060.27909581359, 48106.75946620244, 48158.759206203744, 1122.3378206857992, 1136.2046567402851, 1145.135422755814, 1210.915235933494, 1212.0485418946262, 25223.747762522875, 26481.867590661925, 27058.32354191161, 27364.863175683993, 27541.31146721348, 41398.1720365597, 41708.374374385014, 41714.58285417107, 41734.0, 41769.16461670689, 301323.0, 302010.0, 303245.0, 303722.0, 304887.0, 24798.628020580065, 25069.623955640316, 25139.622905656062, 25146.49707005813, 25151.0, 40136.39795403013, 40554.59445405626, 40655.59344406636, 41619.167616648105, 41792.16415671731, 34703.0, 34896.127596810285, 35013.47479787856, 35179.0, 35639.465408019416, 34786.30427391489, 35233.82383088068, 35239.647603523634, 35567.64432355644, 35585.28829423449, 34916.0, 35552.64447355493, 35899.64100358963, 36697.81651091728, 38190.0, 30517.694823051486, 32944.1763955903, 33144.83427582846, 33149.17127071746, 33188.50217246695, 24683.753162468864, 25020.0, 25279.752550574824, 25396.238112856645, 25513.23460296194], "value": 16190.120400612306, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.84400597728035, 368.8745826419017, 369.4753450100857, 372.58456820644983, 391.5888317266871, 12198.329091899943, 12263.816042759354, 13188.208707477557, 13210.0, 16961.830381696178, 15653.921730391361, 15951.760723589156, 16912.154392280398, 17012.319507219727, 17227.82772172278, 4738.47876733559, 4752.691075080117, 4951.876203094916, 4959.355283813117, 4996.875078123039, 3660.396034654279, 4903.509649035103, 4980.402351717799, 4982.327385802924, 4983.127952608297, 3813.6949044076546, 5464.207689884965, 5745.885082298351, 5801.47786699197, 5851.210086638292, 5685.4883060524335, 5820.272465941757, 5835.941640583582, 5839.416058394169, 5849.151872978395, 5167.0957582422925, 5169.896602067975, 5173.534381905609, 5174.586033117379, 5176.275321454999, 17991.73012404815, 18633.254669813192, 18705.251789928385, 19083.809161908343, 20516.589668206554, 1700.9659806803918, 1822.2073398071882, 1964.5972575621963, 1978.485593745622, 2236.899339529709, 8496.915030849736, 8798.51608161551, 9250.907490925072, 9622.326437149402, 9759.853602195974, 1634.3544300001433, 1668.7580300856307, 1694.9830501694948, 1712.152484520158, 1779.9288028478975, 53617.0, 63918.360816392174, 65706.70026549096, 69097.65451172763, 74041.25958740451, 9971.501424928725, 9990.150837178775, 10314.948425257826, 10339.844902326471, 10514.421706806199, 14019.859801401855, 14035.78946315806, 14045.297735113203, 14047.648808779657, 14065.85934140666, 7215.96392018047, 7367.557946523226, 7540.886886696704, 7547.962260188664, 7720.15078341382, 6909.309069093151, 6930.688119034656, 6962.825929351706, 7165.749198778018, 7182.0, 4004.1791432756213, 4069.2471892699946, 4287.713685894281, 4372.475302963665, 4388.824447022147, 1771.2649250560873, 1800.1629242402346, 1855.7587513623412, 1862.3761040051463, 1869.9439016829517, 756.8798178695451, 776.413807575277, 799.936005119589, 841.3857883744901, 860.5181098584687, 16735.163241837858, 17036.48890533286, 17225.22486488111, 17559.648807023787, 17684.823151768574, 752.7290175536803, 763.9312461878458, 771.3828936850609, 791.3392317415023, 794.3367288314322, 9004.279657627374, 9502.239820814319, 9535.189508891823, 9556.23550115989, 9565.952170239105, 355834.0, 384820.0, 385937.0, 386241.0, 387033.0, 58243.70878145582, 73880.0, 74459.0, 79888.0, 83143.0, 888.1518150166576, 912.3978174404994, 924.8705181274627, 937.5124935033745, 939.9483028433502, 15534.145621990447, 16167.67664646724, 16521.091339976418, 16621.66756664884, 16635.737803053173, 37492.81253593715, 37996.81001594974, 38406.23187536289, 38907.61092389153, 38964.220715586096, 53582.73208633932, 53954.73022634862, 54687.45312546824, 54946.0, 55750.72124639351, 6303.49572034227, 6550.279469258282, 6834.965825170842, 6932.653367331714, 6971.686274117778, 9156.0, 11644.35956022427, 11654.0, 11771.646850594496, 11818.290902545874, 9959.601615935282, 10285.485725713834, 10334.948325258325, 10709.0, 10833.241673082808, 9811.313208075366, 9880.35777674449, 9892.752681183028, 9975.800483990424, 10121.848172277569, 10234.897651023395, 10266.486675666038, 10394.532246048795, 10395.844062339222, 10442.164626829683, 6844.0, 6880.415164710856, 6978.79063628092, 7096.53872498286, 7197.532160409557, 8923.464592124494, 10162.136218421518, 10219.386836789816, 10325.63860264887, 10804.459777011276], "value": 8012.7485718575745, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1292.7802273613486, 1366.6651670340766, 1372.6019454358236, 1646.6459711162097, 1681.890677105988, 6787.9321206788045, 7023.543469674468, 7511.323980841723, 8082.313003394711, 8102.513849169054, 7410.740624078158, 7699.230076992298, 7714.228577142297, 7866.292033716964, 7883.054033515972, 2142.710734050903, 2160.0387827416807, 2171.3703026122407, 2171.522265101675, 2172.1745736620064, 1791.8656100792427, 1847.7413162157309, 2075.6056349293663, 2104.5685634444903, 2125.4048866317457, 2076.294060019593, 2146.248812915475, 2146.903389347483, 2148.4628842789302, 2148.473623962124, 2079.105984426696, 2081.7918208179212, 2113.154738104755, 2128.12746773822, 2132.1791110422446, 2060.093558834123, 2077.345636124616, 2081.6149012432747, 2083.562451885106, 2084.249670118756, 7840.803979900491, 7903.209679032051, 7933.206679332078, 7937.72217972374, 7942.880856787153, 4410.448693913261, 4480.955190448087, 4555.04344087742, 4557.726536407826, 4563.178627847019, 2669.853158076305, 2811.704770999036, 2851.0306495791324, 2857.6142220800134, 2871.3539453622975, 862.4221771413105, 881.8368601808686, 885.8022538635521, 888.342626456424, 890.4746199742118, 10350.275480716278, 10408.427536485491, 10427.217958653131, 10431.68704938853, 10458.581656733722, 3805.4101614249835, 3949.644531992077, 4058.7158898876796, 4070.1249231415386, 4183.142455796555, 8729.869051964226, 8733.737987860375, 8762.561871906379, 8822.911770882338, 8949.821003579891, 4453.866384008485, 4461.397711308997, 4474.038081812426, 4476.41806565151, 4479.037007043501, 4059.89850253746, 4089.5297040840087, 4092.2224777292217, 4103.630673239423, 4104.507459104867, 3561.465780133001, 3641.4537819326783, 3647.598764135943, 3654.7989860557923, 3700.9259814803554, 1060.1412855587, 1108.6729414822646, 1203.3802591665299, 1216.5498765456837, 1226.270369130366, 639.8784230996096, 693.982650433733, 729.7810656802938, 742.406075139886, 752.2966026764992, 4937.210046392632, 5087.796488140433, 5187.144121220032, 5267.78928842842, 5525.060739674184, 772.3550835052681, 785.7564155111934, 861.5089399042486, 864.3085531574715, 885.4465958775766, 3107.53386991953, 3187.6015498062743, 3202.6637203093806, 3218.9195270117966, 3304.6530114337647, 9375.953120234355, 9710.320277580642, 9817.901820981842, 9831.655892043744, 9849.55676994537, 9374.109459601326, 9691.418514889128, 9737.367071140354, 9779.755506112404, 9794.608215671436, 6989.161300643854, 7196.712131514681, 7201.495895287279, 7217.711291548279, 7218.927810721931, 4814.759262036954, 5093.8726531837, 5196.558292545176, 5277.20841873722, 5481.3422389311945, 8971.730848074569, 9133.45199288045, 9138.31462640318, 9144.58849351794, 9254.814903702023, 8786.253168480494, 9026.503542305236, 9101.044390339184, 9149.817003660022, 9234.9538252311, 6525.249596296487, 6611.570247933869, 6624.072629831731, 6663.866722665616, 6714.194296684429, 7306.342429181399, 7365.189829118685, 7369.263073692588, 7385.926140738524, 7388.630568471663, 6686.3313668632745, 6688.565243259172, 6704.865902682017, 6830.009648600826, 7061.858762824818, 6509.251436084911, 6557.180352455943, 6573.57271777333, 6591.5056370773345, 6835.384815366641, 5807.0998995155815, 5888.146218798336, 5889.146073819186, 5911.113332999912, 5916.881662366814, 4182.895427614212, 4194.140201258796, 4210.894727631834, 4295.806688698954, 4406.911861762811, 4345.283028300295, 4414.911701765883, 4447.666425018072, 4519.254323036794, 4552.726836389827], "value": 4027.4426294461296, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.7077607780259, 296.1854899027674, 304.32288158846563, 305.8363775380172, 305.9204606802231, 4871.0, 4890.532840147955, 4900.093482705702, 4900.166971614825, 4923.5814955728765, 4821.325014497965, 4824.975875120628, 4826.20080353395, 4830.830920917769, 4833.299171620113, 3612.9458058129085, 3710.8515659373593, 3713.517242758451, 3763.2285381496863, 3834.9424758628643, 3814.294355544233, 3818.16000479894, 3824.9426258606145, 3833.386658134699, 3848.076461649198, 3797.3544497435364, 3801.8479260829536, 3812.809359532026, 3817.351050321452, 3819.6562309392148, 3617.963820361789, 3725.6833169180786, 3726.7763934164036, 3795.734298599099, 3817.2174704185854, 3367.5285460035616, 3370.8651653934057, 3392.4402473591826, 3394.575678040245, 3395.9660403395897, 4739.95260047402, 4748.145333839908, 4759.547842954914, 4766.261229509431, 4799.568038876518, 4231.492220933507, 4362.541933097011, 4387.94689274575, 4390.385346051556, 4393.033532622818, 5050.39395272566, 5054.444011158769, 5056.797728090872, 5063.139266324733, 5063.265826455144, 3707.9073023174365, 3715.04959896054, 3718.1184581949205, 3723.441483777428, 3725.8137093145506, 5189.325387699612, 5317.0, 5324.600654950856, 5356.4107948125675, 5387.0841956867425, 3787.0910981364273, 3811.6950643948417, 3813.3707938189887, 3819.713521485844, 3821.331267028259, 3871.4192871069004, 3874.1864208515963, 3874.651281384689, 3880.320943834874, 3880.438910319232, 4362.625772881533, 4375.5341960442975, 4387.254166791653, 4389.103191893335, 4396.824127034883, 4997.425296090923, 5077.715028237308, 5092.872678183001, 5115.667481613683, 5120.257562653394, 1328.8936885049172, 1341.3226320708175, 1341.9463221471226, 1343.7043850352907, 1345.098783814827, 826.2522417212432, 861.9396642235109, 869.8825658536143, 880.5861245214867, 888.1340692824574, 4365.236083685342, 4391.538888416734, 4487.506374298824, 4493.932591011137, 4500.527444618333, 5231.738413079331, 5233.5551478124025, 5241.31862857826, 5243.632945693841, 5250.422453530108, 4505.729656220572, 4508.526604706524, 4509.616682581952, 4518.71216703238, 4524.88687782808, 2630.5396555602692, 2753.2979090331837, 2755.8897644094413, 2770.224337185591, 2798.2164993801766, 4910.582600478928, 4923.704577725348, 4925.13810083234, 4956.90086198274, 4965.428975667773, 5241.0828105081455, 5321.760520776575, 5386.892262154735, 5391.086164411656, 5404.648697834628, 4873.390826146731, 4890.266460030953, 4904.6212586896045, 4906.90186196274, 4912.214045752734, 5175.430702622633, 5188.481151884781, 5189.6107791915, 5220.112580861339, 5265.815696450606, 4910.337104490991, 5150.098732721834, 5154.0, 5178.8964220716125, 5180.559652429435, 4945.862451636216, 4952.628552858478, 4955.752212389294, 4961.677490963076, 4973.9253911190635, 3720.1771132144513, 3732.1602639407, 3752.681022113151, 3767.566729826105, 3772.698184145207, 5102.846914592568, 5259.237410575369, 5334.653247538898, 5335.199720042025, 5348.983693098299, 5094.312267843794, 5113.593761715558, 5117.43708192106, 5125.692458452356, 5142.1258386073705, 5086.694798312114, 5087.949120508748, 5128.79484820603, 5147.9227811583605, 5169.844904652867, 4882.584980276574, 4998.825041123689, 5008.248762685626, 5032.572231360376, 5059.241113832807, 4893.853184404474, 5027.949720502895, 5037.974810125926, 5158.432572416956, 5166.2508936203285, 4958.206686930074, 4979.203327467588, 5031.773570189277, 5040.521150490697, 5054.21659642756], "value": 3855.52240375292, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.7816512477569, 611.0620197996077, 629.792168584367, 655.4821690864218, 680.8966793879868, 12526.373681315932, 13198.340082995835, 13520.93239533801, 13668.248246346448, 13725.725485490284, 12857.614271571867, 13212.933935330333, 13275.0, 13275.933620331909, 13296.601101966933, 737.376916505552, 756.3042001358735, 759.3242014607005, 759.8062494064006, 760.3612965109335, 605.9091136329564, 622.741562251665, 731.0532859946383, 755.056179775281, 765.4335791514295, 794.3367288314264, 794.9364050875945, 795.2167115391335, 795.6061749434039, 795.7533164718926, 788.8304014636881, 789.7907054630471, 789.8143936175023, 789.9091604465502, 790.7983464216617, 464.73510099243447, 473.11763560958565, 476.08829092288227, 476.69491525423757, 552.5551930695789, 12536.749265014649, 12644.620661380173, 12911.935440322739, 12917.160384574972, 12940.417681204275, 12224.266544007389, 12277.570285039981, 12681.682957926034, 12763.234205947672, 12887.484500620058, 11353.659390218307, 11751.236169648946, 11828.526858925632, 11848.585299514476, 12579.119461637689, 3981.581933896928, 4022.658074063708, 4063.756174629532, 4071.491063617048, 4088.3867419886956, 64939.67530162366, 65641.343586564, 65988.67005664941, 66926.99219023388, 69527.3047269531, 10286.588536458608, 10351.534180961724, 10671.786564268672, 10699.62551310716, 10725.356478611307, 18233.36183233607, 18375.816241837678, 18399.632007359778, 18406.815931840778, 18419.26322947094, 6321.494280457552, 6341.619502829845, 6384.616922984543, 6445.709943052574, 6855.931440685629, 3468.271662950758, 3469.7397695172963, 3509.1402606361603, 3589.569251689814, 3590.605033446319, 3023.1988523041414, 3225.1614580209316, 3256.1371236622313, 3280.097973057428, 3282.359939811714, 529.4837533404899, 533.1443033930564, 533.7331334332833, 538.7252501224403, 546.3907742866754, 482.2655543070797, 493.64704236471096, 525.4220357606679, 526.3946461569226, 534.7326336831584, 7318.536292741473, 7452.664630091659, 7507.249275072449, 7584.0, 7789.844203116019, 457.8557754307449, 474.28146358267253, 510.85951363374625, 512.1089304609952, 513.3480479790645, 3506.526618906415, 3518.9120271992892, 3531.5408996830247, 3741.644543768338, 3904.9609503905167, 92794.0, 103010.0, 106193.0, 109353.0, 109924.45037774919, 86584.0, 88680.55659721661, 90607.0, 91645.54177229072, 93032.0, 50723.49276507262, 59221.40778592245, 75009.6249518749, 77265.0, 78017.0, 7079.575225486487, 7201.6399180041835, 7295.270472952662, 7573.772786816405, 7591.620418978919, 44840.0, 45305.320420193064, 45701.54298457106, 46282.53717462917, 47091.529084710084, 39254.214915700955, 39914.00859913985, 39991.80004099961, 59246.70376648089, 66561.33438665746, 10101.848472273068, 10118.19054475655, 10205.336653117523, 10248.0, 10653.254272200871, 10586.100181484351, 10586.576536938745, 10974.890251097388, 11119.72200694989, 11432.542698292307, 9529.809403812023, 9619.711408657471, 9914.652987145415, 10023.74940626461, 10308.278420510493, 9549.618015279311, 9579.089986451276, 9791.216702663913, 9913.405195688281, 10025.197984161105, 8669.913300867163, 8702.216800487986, 8719.564021799011, 8938.41900276506, 9885.308028437941, 7822.374210063295, 7864.6854125834325, 7887.0, 8197.590120493833, 8565.528895910784, 7796.961015194887, 8442.704505342284, 8477.533735644598, 8512.0, 8575.571221438779], "value": 6200.98813996334, "unit": "score"}], "name": "dromaeo_css", "value": 6221.543921205921, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 114.0, 115.0, 114.0, 114.0, 115.0, 115.0, 118.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 132.0, 129.0, 166.0, 123.0, 131.0, 130.0, 130.0, 163.0, 132.0], "value": 138.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 162.0, 162.0, 161.0, 161.0, 162.0, 163.0, 163.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 109.0, 75.0, 77.0, 79.0, 77.0, 98.0, 77.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 115.0, 84.0, 84.0, 84.0, 106.0, 84.0, 84.0, 109.0], "value": 91.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 76.0, 65.0, 64.0, 66.0, 66.0, 66.0, 66.0, 65.0, 64.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 69.0, 67.0, 66.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 83.0, 82.0, 85.0, 88.0, 82.0, 91.0, 82.0, 82.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 134.0, 133.0, 132.0, 131.0, 141.0, 144.0, 147.0, 179.0, 142.0], "value": 142.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 173.0, 176.0, 176.0, 172.0, 172.0, 174.0, 171.0, 177.0, 178.0], "value": 174.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 78.0, 68.0, 70.0, 70.0, 70.0, 69.0, 68.0, 68.0], "value": 70.0, "unit": "score"}], "name": "kraken", "value": 1550.5, "alertThreshold": 2.0}]} 19:53:15 INFO - Return code: 0 19:53:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:53:15 INFO - # TBPL SUCCESS # 19:53:15 INFO - Running post-action listener: _resource_record_post_action 19:53:15 INFO - [mozharness: 2016-09-20 02:53:15.839082Z] Finished run-tests step (success) 19:53:15 INFO - Running post-run listener: _resource_record_post_run 19:53:15 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 403824640; Read time: 172; Write time: 249756 19:53:15 INFO - TinderboxPrint: CPU usage
13.1% 19:53:15 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 172 19:53:15 INFO - TinderboxPrint: I/O write bytes / time
403,824,640 / 249,756 19:53:15 INFO - TinderboxPrint: CPU idle
8,336.1 (86.9%) 19:53:15 INFO - TinderboxPrint: CPU user
1,201.1 (12.5%) 19:53:15 INFO - TinderboxPrint: Swap in / out
0 / 0 19:53:15 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110366720; Read time: 0; Write time: 55568 19:53:15 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293457920; Read time: 160; Write time: 194188 19:53:16 INFO - Running post-run listener: _upload_blobber_files 19:53:16 INFO - Blob upload gear active. 19:53:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:53:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:53:16 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'] 19:53:16 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 19:53:16 INFO - (blobuploader) - INFO - Open directory for files ... 19:53:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:53:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:53:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:53:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:53:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:53:18 INFO - (blobuploader) - INFO - Done attempting. 19:53:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:53:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:53:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:53:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:53:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:53:21 INFO - (blobuploader) - INFO - Done attempting. 19:53:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:53:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:53:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:53:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:53:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:53:22 INFO - (blobuploader) - INFO - Done attempting. 19:53:22 INFO - (blobuploader) - INFO - Iteration through files over. 19:53:22 INFO - Return code: 0 19:53:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:53:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:53:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/08fafb0fdca400fa5424745bdae43cb654496116a168293f72b4e938974f9e77e833691783967640250731e97259ae885295e464794eed579fa33117303fac05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e1217850df1501b3bb1559d0ce764da944bb8251033b1e034032d6e160701dd4f74e7935e764167b37188a5283b83f990e53557ff89738a269543d29cd78ba3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5174f2c5d8bea3493b79dda88bc38a8d517ec200262cbc1f918a3c28f6481496de3eb4cf4aefa0fc13596761b680c80cc889b040e1bff8e83d3eb668dcd76155"} 19:53:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:53:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:53:22 INFO - Contents: 19:53:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/08fafb0fdca400fa5424745bdae43cb654496116a168293f72b4e938974f9e77e833691783967640250731e97259ae885295e464794eed579fa33117303fac05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e1217850df1501b3bb1559d0ce764da944bb8251033b1e034032d6e160701dd4f74e7935e764167b37188a5283b83f990e53557ff89738a269543d29cd78ba3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5174f2c5d8bea3493b79dda88bc38a8d517ec200262cbc1f918a3c28f6481496de3eb4cf4aefa0fc13596761b680c80cc889b040e1bff8e83d3eb668dcd76155"} 19:53:22 INFO - Running post-run listener: copy_logs_to_upload_dir 19:53:22 INFO - Copying logs to upload dir... 19:53:22 INFO - mkdir: /builds/slave/test/build/upload/logs 19:53:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.984177 ========= master_lag: 0.78 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-09-19 19:53:22.896459) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-19 19:53:22.902154) ========= 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=836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322 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/08fafb0fdca400fa5424745bdae43cb654496116a168293f72b4e938974f9e77e833691783967640250731e97259ae885295e464794eed579fa33117303fac05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e1217850df1501b3bb1559d0ce764da944bb8251033b1e034032d6e160701dd4f74e7935e764167b37188a5283b83f990e53557ff89738a269543d29cd78ba3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5174f2c5d8bea3493b79dda88bc38a8d517ec200262cbc1f918a3c28f6481496de3eb4cf4aefa0fc13596761b680c80cc889b040e1bff8e83d3eb668dcd76155"} build_url:https://queue.taskcluster.net/v1/task/Hhk5vb_USH6J_wBbfyO5WA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011336 build_url: 'https://queue.taskcluster.net/v1/task/Hhk5vb_USH6J_wBbfyO5WA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/08fafb0fdca400fa5424745bdae43cb654496116a168293f72b4e938974f9e77e833691783967640250731e97259ae885295e464794eed579fa33117303fac05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e1217850df1501b3bb1559d0ce764da944bb8251033b1e034032d6e160701dd4f74e7935e764167b37188a5283b83f990e53557ff89738a269543d29cd78ba3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5174f2c5d8bea3493b79dda88bc38a8d517ec200262cbc1f918a3c28f6481496de3eb4cf4aefa0fc13596761b680c80cc889b040e1bff8e83d3eb668dcd76155"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-19 19:53:22.931233) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 19:53:22.931561) ========= 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=836cfdc75598d54cb747368e000001a9-1474338511.213056-861224322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 19:53:22.984396) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-19 19:53:22.987755) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-19 19:53:22.988053) ========= ========= Total master_lag: 0.91 =========