builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-058 starttime: 1474976197.73 results: success (0) buildid: 20160927035852 builduid: 49547c1fcc474257a48ac2001e699ca4 revision: 7c1929f35c5d11b0b921ebd03c197bdb5afbeaca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:37.729731) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:37.730406) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:37.731029) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:37.754399) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:37.754844) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-27 04:36:38-- 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-27 04:36:38 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.071472 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:37.843449) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:37.843729) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017750 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:37.893571) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:37.893889) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7c1929f35c5d11b0b921ebd03c197bdb5afbeaca --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 7c1929f35c5d11b0b921ebd03c197bdb5afbeaca --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-27 04:36:38,865 truncating revision to first 12 chars 2016-09-27 04:36:38,865 Setting DEBUG logging. 2016-09-27 04:36:38,865 attempt 1/10 2016-09-27 04:36:38,865 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7c1929f35c5d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 04:36:39,290 unpacking tar archive at: fx-team-7c1929f35c5d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.871859 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:38.778543) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:38.778838) ========= script_repo_revision: 7c1929f35c5d11b0b921ebd03c197bdb5afbeaca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:38.779276) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:38.779633) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:38.789783) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-09-27 04:36:38.790183) ========= /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=0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:36:39 INFO - MultiFileLogger online at 20160927 04:36:39 in /builds/slave/test 04:36:39 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 04:36:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:36:39 INFO - {'append_to_log': False, 04:36:39 INFO - 'base_work_dir': '/builds/slave/test', 04:36:39 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:36:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:36:39 INFO - 'branch': 'Fx-Team-Non-PGO', 04:36:39 INFO - 'buildbot_json_path': 'buildprops.json', 04:36:39 INFO - 'config_files': ('talos/linux_config.py',), 04:36:39 INFO - 'default_actions': ('clobber', 04:36:39 INFO - 'read-buildbot-config', 04:36:39 INFO - 'download-and-extract', 04:36:39 INFO - 'populate-webroot', 04:36:39 INFO - 'create-virtualenv', 04:36:39 INFO - 'install', 04:36:39 INFO - 'run-tests'), 04:36:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:36:39 INFO - 'download_minidump_stackwalk': True, 04:36:39 INFO - 'download_symbols': 'ondemand', 04:36:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:36:39 INFO - 'tooltool.py': '/tools/tooltool.py', 04:36:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:36:39 INFO - '/tools/misc-python/virtualenv.py')}, 04:36:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:36:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:36:39 INFO - 'installer_path': 'installer.exe', 04:36:39 INFO - 'log_level': 'info', 04:36:39 INFO - 'log_name': 'talos', 04:36:39 INFO - 'log_to_console': True, 04:36:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:36:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:36:39 INFO - 'opt_config_files': (), 04:36:39 INFO - 'pip_index': False, 04:36:39 INFO - 'sps_profile': False, 04:36:39 INFO - 'sps_profile_interval': 0, 04:36:39 INFO - 'suite': 'dromaeojs', 04:36:39 INFO - 'system_bits': '32', 04:36:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:36:39 INFO - 'title': 'talos-linux64-ix-058', 04:36:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:36:39 INFO - 'use_talos_json': True, 04:36:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:36:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:36:39 INFO - 'work_dir': 'build'} 04:36:39 INFO - [mozharness: 2016-09-27 11:36:39.863873Z] Running clobber step. 04:36:39 INFO - Running pre-action listener: _resource_record_pre_action 04:36:39 INFO - Running main action method: clobber 04:36:39 INFO - rmtree: /builds/slave/test/build 04:36:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:36:40 INFO - Running post-action listener: _resource_record_post_action 04:36:40 INFO - [mozharness: 2016-09-27 11:36:40.327416Z] Finished clobber step (success) 04:36:40 INFO - [mozharness: 2016-09-27 11:36:40.327517Z] Running read-buildbot-config step. 04:36:40 INFO - Running pre-action listener: _resource_record_pre_action 04:36:40 INFO - Running main action method: read_buildbot_config 04:36:40 INFO - Using buildbot properties: 04:36:40 INFO - { 04:36:40 INFO - "project": "", 04:36:40 INFO - "product": "firefox", 04:36:40 INFO - "script_repo_revision": "production", 04:36:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:36:40 INFO - "repository": "", 04:36:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:36:40 INFO - "buildid": "20160927035852", 04:36:40 INFO - "pgo_build": "False", 04:36:40 INFO - "basedir": "/builds/slave/test", 04:36:40 INFO - "buildnumber": 2175, 04:36:40 INFO - "slavename": "talos-linux64-ix-058", 04:36:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:36:40 INFO - "platform": "ubuntu64_hw", 04:36:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:36:40 INFO - "branch": "fx-team", 04:36:40 INFO - "repo_path": "integration/fx-team", 04:36:40 INFO - "revision": "7c1929f35c5d11b0b921ebd03c197bdb5afbeaca", 04:36:40 INFO - "stage_platform": "linux64", 04:36:40 INFO - "builduid": "49547c1fcc474257a48ac2001e699ca4", 04:36:40 INFO - "slavebuilddir": "test" 04:36:40 INFO - } 04:36:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/d8kijwZsSyyyeucAXl1ERg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 04:36:40 INFO - Running post-action listener: _resource_record_post_action 04:36:40 INFO - [mozharness: 2016-09-27 11:36:40.329978Z] Finished read-buildbot-config step (success) 04:36:40 INFO - [mozharness: 2016-09-27 11:36:40.330067Z] Running download-and-extract step. 04:36:40 INFO - Running pre-action listener: _resource_record_pre_action 04:36:40 INFO - Running main action method: download_and_extract 04:36:40 INFO - mkdir: /builds/slave/test/build/tests 04:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:40 INFO - trying https://queue.taskcluster.net/v1/task/d8kijwZsSyyyeucAXl1ERg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:36:40 INFO - Downloading https://queue.taskcluster.net/v1/task/d8kijwZsSyyyeucAXl1ERg/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 04:36:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d8kijwZsSyyyeucAXl1ERg/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 04:36:40 INFO - Downloaded 1361 bytes. 04:36:40 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:36:40 INFO - Using the following test package requirements: 04:36:40 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:36:40 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:36:40 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:36:40 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:40 INFO - u'jsshell-linux-x86_64.zip'], 04:36:40 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:36:40 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:36:40 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:36:40 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:36:40 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:36:40 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:36:40 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:36:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d8kijwZsSyyyeucAXl1ERg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:36:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d8kijwZsSyyyeucAXl1ERg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:36:40 INFO - Fetch https://queue.taskcluster.net/v1/task/d8kijwZsSyyyeucAXl1ERg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:36:41 INFO - Expected file size: 20413434 04:36:46 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 04:36:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d8kijwZsSyyyeucAXl1ERg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:36:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d8kijwZsSyyyeucAXl1ERg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:36:46 INFO - Fetch https://queue.taskcluster.net/v1/task/d8kijwZsSyyyeucAXl1ERg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:36:47 INFO - Expected file size: 20413434 04:36:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d8kijwZsSyyyeucAXl1ERg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 04:36:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d8kijwZsSyyyeucAXl1ERg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:36:51 INFO - Fetch https://queue.taskcluster.net/v1/task/d8kijwZsSyyyeucAXl1ERg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:36:52 INFO - Expected file size: 14414062 04:36: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')]} 04:36:53 INFO - trying https://queue.taskcluster.net/v1/task/d8kijwZsSyyyeucAXl1ERg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:36:53 INFO - Downloading https://queue.taskcluster.net/v1/task/d8kijwZsSyyyeucAXl1ERg/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 04:36:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d8kijwZsSyyyeucAXl1ERg/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 04:36:55 INFO - Downloaded 55742678 bytes. 04:36:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d8kijwZsSyyyeucAXl1ERg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:36:55 INFO - mkdir: /builds/slave/test/properties 04:36:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:36:55 INFO - Writing to file /builds/slave/test/properties/build_url 04:36:55 INFO - Contents: 04:36:55 INFO - build_url:https://queue.taskcluster.net/v1/task/d8kijwZsSyyyeucAXl1ERg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:36:56 INFO - Running post-action listener: _resource_record_post_action 04:36:56 INFO - Running post-action listener: set_extra_try_arguments 04:36:56 INFO - [mozharness: 2016-09-27 11:36:56.116293Z] Finished download-and-extract step (success) 04:36:56 INFO - [mozharness: 2016-09-27 11:36:56.116541Z] Running populate-webroot step. 04:36:56 INFO - Running pre-action listener: _resource_record_pre_action 04:36:56 INFO - Running main action method: populate_webroot 04:36:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:36:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:36:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:36:56 INFO - '--tppagecycles', 04:36:56 INFO - '7'], 04:36:56 INFO - 'tests': ['tsvgm']}}, 04:36:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:36:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:36:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:36:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:36:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:36:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:36:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:56 INFO - 'talos_options': ['--disable-e10s'], 04:36:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:56 INFO - 'talos_options': ['--disable-e10s'], 04:36:56 INFO - 'tests': ['damp', 'tps']}, 04:36:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:56 INFO - 'tests': ['damp', 'tps']}, 04:36:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:36:56 INFO - 'tests': ['dromaeo_dom']}, 04:36:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:36:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:36:56 INFO - 'tests': ['basic_compositor_video']}, 04:36:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:36:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:36:56 INFO - 'tests': ['a11yr', 04:36:56 INFO - 'ts_paint', 04:36:56 INFO - 'tpaint', 04:36:56 INFO - 'sessionrestore', 04:36:56 INFO - 'sessionrestore_no_auto_restore', 04:36:56 INFO - 'tabpaint']}, 04:36:56 INFO - 'other-e10s': {'tests': ['a11yr', 04:36:56 INFO - 'ts_paint', 04:36:56 INFO - 'tpaint', 04:36:56 INFO - 'sessionrestore', 04:36:56 INFO - 'sessionrestore_no_auto_restore', 04:36:56 INFO - 'tabpaint']}, 04:36:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:36:56 INFO - 'ts_paint', 04:36:56 INFO - 'tpaint', 04:36:56 INFO - 'sessionrestore', 04:36:56 INFO - 'sessionrestore_no_auto_restore', 04:36:56 INFO - 'tabpaint']}, 04:36:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:36:56 INFO - 'ts_paint', 04:36:56 INFO - 'tpaint', 04:36:56 INFO - 'sessionrestore', 04:36:56 INFO - 'sessionrestore_no_auto_restore', 04:36:56 INFO - 'tabpaint']}, 04:36:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:36:56 INFO - 'tests': ['a11yr', 04:36:56 INFO - 'ts_paint', 04:36:56 INFO - 'tpaint', 04:36:56 INFO - 'sessionrestore', 04:36:56 INFO - 'sessionrestore_no_auto_restore', 04:36:56 INFO - 'tabpaint']}, 04:36:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:36:56 INFO - 'tests': ['a11yr', 04:36:56 INFO - 'ts_paint', 04:36:56 INFO - 'tpaint', 04:36:56 INFO - 'sessionrestore', 04:36:56 INFO - 'sessionrestore_no_auto_restore', 04:36:56 INFO - 'tabpaint']}, 04:36:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:36:56 INFO - 'tests': ['tsvgx', 04:36:56 INFO - 'tsvgr_opacity', 04:36:56 INFO - 'tart', 04:36:56 INFO - 'tscrollx', 04:36:56 INFO - 'cart']}, 04:36:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:36:56 INFO - 'tsvgr_opacity', 04:36:56 INFO - 'tart', 04:36:56 INFO - 'tscrollx', 04:36:56 INFO - 'cart']}, 04:36:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:56 INFO - 'talos_options': ['--disable-e10s'], 04:36:56 INFO - 'tests': ['tp5o']}, 04:36:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:56 INFO - 'tests': ['tp5o']}, 04:36:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:56 INFO - 'talos_options': ['--disable-e10s', 04:36:56 INFO - '--xperf_path', 04:36:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:56 INFO - 'tests': ['tp5n']}, 04:36:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:56 INFO - 'talos_options': ['--xperf_path', 04:36:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:56 INFO - 'tests': ['tp5n']}}, 04:36:56 INFO - 'talos.zip': {'path': '', 04:36:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:36:56 INFO - Running post-action listener: _resource_record_post_action 04:36:56 INFO - [mozharness: 2016-09-27 11:36:56.139858Z] Finished populate-webroot step (success) 04:36:56 INFO - [mozharness: 2016-09-27 11:36:56.139947Z] Running create-virtualenv step. 04:36:56 INFO - Running pre-action listener: _resource_record_pre_action 04:36:56 INFO - Running main action method: create_virtualenv 04:36:56 INFO - Creating virtualenv /builds/slave/test/build/venv 04:36:56 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 04:36:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:36:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:36:56 INFO - Using real prefix '/usr' 04:36:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:36:56 INFO - Installing distribute.............................................................................................................................................................................................done. 04:36:58 INFO - Installing pip.................done. 04:36:58 INFO - Return code: 0 04:36:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:36:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:36:58 INFO - Reading from file tmpfile_stdout 04:36:58 INFO - Output received: 04:36:58 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:36:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:36:58 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')]} 04:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:58 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')]} 04:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:58 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 0x7fcf7fac0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1713ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1710f60>, '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 0x1711d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17121d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442', '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 04:36:58 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 04:36:58 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 04:36:58 INFO - Using env: {'DISPLAY': ':0', 04:36:58 INFO - 'HOME': '/home/cltbld', 04:36:58 INFO - 'LANG': 'en_US.UTF-8', 04:36:58 INFO - 'LANGUAGE': 'en_US:en', 04:36:58 INFO - 'LOGNAME': 'cltbld', 04:36:58 INFO - 'MAIL': '/var/mail/cltbld', 04:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:58 INFO - 'MOZ_NO_REMOTE': '1', 04:36:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:58 INFO - 'NO_EM_RESTART': '1', 04:36:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:58 INFO - 'PWD': '/builds/slave/test', 04:36:58 INFO - 'SHELL': '/bin/bash', 04:36:58 INFO - 'SHLVL': '1', 04:36:58 INFO - 'TERM': 'linux', 04:36:58 INFO - 'TMOUT': '86400', 04:36:58 INFO - 'USER': 'cltbld', 04:36:58 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442', 04:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:58 INFO - '_': '/tools/buildbot/bin/python'} 04:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:59 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 04:36:59 INFO - Cleaning up... 04:36:59 INFO - Return code: 0 04:36:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:36: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')]} 04:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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')]} 04:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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', '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 0x7fcf7fac0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1713ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1710f60>, '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 0x1711d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17121d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442', '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 04:36: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:36: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 psutil>=3.1.1 04:36:59 INFO - Using env: {'DISPLAY': ':0', 04:36:59 INFO - 'HOME': '/home/cltbld', 04:36:59 INFO - 'LANG': 'en_US.UTF-8', 04:36:59 INFO - 'LANGUAGE': 'en_US:en', 04:36:59 INFO - 'LOGNAME': 'cltbld', 04:36:59 INFO - 'MAIL': '/var/mail/cltbld', 04:36:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:59 INFO - 'MOZ_NO_REMOTE': '1', 04:36:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:59 INFO - 'NO_EM_RESTART': '1', 04:36:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:59 INFO - 'PWD': '/builds/slave/test', 04:36:59 INFO - 'SHELL': '/bin/bash', 04:36:59 INFO - 'SHLVL': '1', 04:36:59 INFO - 'TERM': 'linux', 04:36:59 INFO - 'TMOUT': '86400', 04:36:59 INFO - 'USER': 'cltbld', 04:36:59 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442', 04:36:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:59 INFO - '_': '/tools/buildbot/bin/python'} 04:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:59 INFO - Downloading/unpacking psutil>=3.1.1 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:37:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:37:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:01 INFO - Installing collected packages: psutil 04:37:01 INFO - Running setup.py install for psutil 04:37:01 INFO - building 'psutil._psutil_linux' extension 04:37:01 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 04:37:01 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 04:37:01 INFO - building 'psutil._psutil_posix' extension 04:37:01 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 04:37:01 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 04:37:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:01 INFO - Successfully installed psutil 04:37:01 INFO - Cleaning up... 04:37:01 INFO - Return code: 0 04:37:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:37: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')]} 04:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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')]} 04:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf7fac0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1713ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1710f60>, '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 0x1711d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17121d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442', '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 04:37: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:37: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 mozsystemmonitor==0.3 04:37:01 INFO - Using env: {'DISPLAY': ':0', 04:37:01 INFO - 'HOME': '/home/cltbld', 04:37:01 INFO - 'LANG': 'en_US.UTF-8', 04:37:01 INFO - 'LANGUAGE': 'en_US:en', 04:37:01 INFO - 'LOGNAME': 'cltbld', 04:37:01 INFO - 'MAIL': '/var/mail/cltbld', 04:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:01 INFO - 'MOZ_NO_REMOTE': '1', 04:37:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:01 INFO - 'NO_EM_RESTART': '1', 04:37:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:01 INFO - 'PWD': '/builds/slave/test', 04:37:01 INFO - 'SHELL': '/bin/bash', 04:37:01 INFO - 'SHLVL': '1', 04:37:01 INFO - 'TERM': 'linux', 04:37:01 INFO - 'TMOUT': '86400', 04:37:01 INFO - 'USER': 'cltbld', 04:37:01 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442', 04:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:01 INFO - '_': '/tools/buildbot/bin/python'} 04:37:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:37:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:37:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:37:04 INFO - Installing collected packages: mozsystemmonitor 04:37:04 INFO - Running setup.py install for mozsystemmonitor 04:37:04 INFO - Successfully installed mozsystemmonitor 04:37:04 INFO - Cleaning up... 04:37:04 INFO - Return code: 0 04:37:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:37:04 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')]} 04:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:04 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')]} 04:37:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:04 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 0x7fcf7fac0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1713ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1710f60>, '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 0x1711d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17121d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442', '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 04:37:04 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 04:37:04 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 04:37:04 INFO - Using env: {'DISPLAY': ':0', 04:37:04 INFO - 'HOME': '/home/cltbld', 04:37:04 INFO - 'LANG': 'en_US.UTF-8', 04:37:04 INFO - 'LANGUAGE': 'en_US:en', 04:37:04 INFO - 'LOGNAME': 'cltbld', 04:37:04 INFO - 'MAIL': '/var/mail/cltbld', 04:37:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:04 INFO - 'MOZ_NO_REMOTE': '1', 04:37:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:04 INFO - 'NO_EM_RESTART': '1', 04:37:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:04 INFO - 'PWD': '/builds/slave/test', 04:37:04 INFO - 'SHELL': '/bin/bash', 04:37:04 INFO - 'SHLVL': '1', 04:37:04 INFO - 'TERM': 'linux', 04:37:04 INFO - 'TMOUT': '86400', 04:37:04 INFO - 'USER': 'cltbld', 04:37:04 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442', 04:37:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:04 INFO - '_': '/tools/buildbot/bin/python'} 04:37:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:04 INFO - Downloading/unpacking jsonschema==2.5.1 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:37:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:37:06 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 04:37:06 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 04:37:06 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 04:37:06 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 04:37:06 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 04:37:06 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 04:37:06 INFO - Downloading functools32-3.2.3-2.tar.gz 04:37:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:37:06 INFO - warning: no files found matching '*.txt' 04:37:06 INFO - no previously-included directories found matching 'build' 04:37:06 INFO - no previously-included directories found matching 'dist' 04:37:06 INFO - no previously-included directories found matching '.git*' 04:37:06 INFO - Installing collected packages: jsonschema, functools32 04:37:06 INFO - Running setup.py install for functools32 04:37:06 INFO - warning: no files found matching '*.txt' 04:37:06 INFO - no previously-included directories found matching 'build' 04:37:06 INFO - no previously-included directories found matching 'dist' 04:37:06 INFO - no previously-included directories found matching '.git*' 04:37:06 INFO - Successfully installed jsonschema functools32 04:37:06 INFO - Cleaning up... 04:37:06 INFO - Return code: 0 04:37:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:06 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 0x7fcf7fac0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1713ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1710f60>, '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 0x1711d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17121d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442', '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 04:37:06 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 04:37:06 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 04:37:06 INFO - Using env: {'DISPLAY': ':0', 04:37:06 INFO - 'HOME': '/home/cltbld', 04:37:06 INFO - 'LANG': 'en_US.UTF-8', 04:37:06 INFO - 'LANGUAGE': 'en_US:en', 04:37:06 INFO - 'LOGNAME': 'cltbld', 04:37:06 INFO - 'MAIL': '/var/mail/cltbld', 04:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:06 INFO - 'MOZ_NO_REMOTE': '1', 04:37:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:06 INFO - 'NO_EM_RESTART': '1', 04:37:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:06 INFO - 'PWD': '/builds/slave/test', 04:37:06 INFO - 'SHELL': '/bin/bash', 04:37:06 INFO - 'SHLVL': '1', 04:37:06 INFO - 'TERM': 'linux', 04:37:06 INFO - 'TMOUT': '86400', 04:37:06 INFO - 'USER': 'cltbld', 04:37:06 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442', 04:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:06 INFO - '_': '/tools/buildbot/bin/python'} 04:37:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:37:07 INFO - Cleaning up... 04:37:07 INFO - Return code: 0 04:37:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:37:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcf7fac0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1713ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1710f60>, '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 0x1711d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17121d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442', '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 04:37:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:37:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:37:07 INFO - Using env: {'DISPLAY': ':0', 04:37:07 INFO - 'HOME': '/home/cltbld', 04:37:07 INFO - 'LANG': 'en_US.UTF-8', 04:37:07 INFO - 'LANGUAGE': 'en_US:en', 04:37:07 INFO - 'LOGNAME': 'cltbld', 04:37:07 INFO - 'MAIL': '/var/mail/cltbld', 04:37:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:07 INFO - 'MOZ_NO_REMOTE': '1', 04:37:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:07 INFO - 'NO_EM_RESTART': '1', 04:37:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:07 INFO - 'PWD': '/builds/slave/test', 04:37:07 INFO - 'SHELL': '/bin/bash', 04:37:07 INFO - 'SHLVL': '1', 04:37:07 INFO - 'TERM': 'linux', 04:37:07 INFO - 'TMOUT': '86400', 04:37:07 INFO - 'USER': 'cltbld', 04:37:07 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442', 04:37:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:07 INFO - '_': '/tools/buildbot/bin/python'} 04:37:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:07 INFO - Downloading/unpacking blobuploader==1.2.4 04:37:07 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 04:37:07 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 04:37:07 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 04:37:07 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 04:37:07 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 04:37:07 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 04:37:09 INFO - Downloading blobuploader-1.2.4.tar.gz 04:37:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:37:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:37:09 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 04:37:09 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 04:37:09 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 04:37:09 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 04:37:09 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 04:37:09 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 04:37:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:37:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:37:09 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 04:37:09 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 04:37:09 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 04:37:09 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 04:37:09 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 04:37:09 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 04:37:09 INFO - Downloading docopt-0.6.1.tar.gz 04:37:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:37:09 INFO - Installing collected packages: blobuploader, requests, docopt 04:37:09 INFO - Running setup.py install for blobuploader 04:37:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:37:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:37:10 INFO - Running setup.py install for requests 04:37:10 INFO - Running setup.py install for docopt 04:37:10 INFO - Successfully installed blobuploader requests docopt 04:37:10 INFO - Cleaning up... 04:37:10 INFO - Return code: 0 04:37:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37:10 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')]} 04:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:10 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')]} 04:37:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:10 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 0x7fcf7fac0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1713ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1710f60>, '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 0x1711d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17121d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442', '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 04:37:10 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 04:37:10 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 04:37:10 INFO - Using env: {'DISPLAY': ':0', 04:37:10 INFO - 'HOME': '/home/cltbld', 04:37:10 INFO - 'LANG': 'en_US.UTF-8', 04:37:10 INFO - 'LANGUAGE': 'en_US:en', 04:37:10 INFO - 'LOGNAME': 'cltbld', 04:37:10 INFO - 'MAIL': '/var/mail/cltbld', 04:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:10 INFO - 'MOZ_NO_REMOTE': '1', 04:37:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:10 INFO - 'NO_EM_RESTART': '1', 04:37:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:10 INFO - 'PWD': '/builds/slave/test', 04:37:10 INFO - 'SHELL': '/bin/bash', 04:37:10 INFO - 'SHLVL': '1', 04:37:10 INFO - 'TERM': 'linux', 04:37:10 INFO - 'TMOUT': '86400', 04:37:10 INFO - 'USER': 'cltbld', 04:37:10 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442', 04:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:10 INFO - '_': '/tools/buildbot/bin/python'} 04:37:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:37:10 INFO - Running setup.py (path:/tmp/pip-UxbrrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:37:10 INFO - Running setup.py (path:/tmp/pip-O_GSY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:37:10 INFO - Running setup.py (path:/tmp/pip-WaTH4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:37:11 INFO - Running setup.py (path:/tmp/pip-CY0lJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:37:11 INFO - Running setup.py (path:/tmp/pip-WvTW8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:37:11 INFO - Running setup.py (path:/tmp/pip-kgoRGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:37:11 INFO - Running setup.py (path:/tmp/pip-95Tywf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:37:11 INFO - Running setup.py (path:/tmp/pip-bfA3nV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:37:11 INFO - Running setup.py (path:/tmp/pip-SR2wvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:37:11 INFO - Running setup.py (path:/tmp/pip-LaxmlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:37:11 INFO - Running setup.py (path:/tmp/pip-edcKhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:37:11 INFO - Running setup.py (path:/tmp/pip-xAGoZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:37:11 INFO - Running setup.py (path:/tmp/pip-tBCO0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:37:11 INFO - Running setup.py (path:/tmp/pip-OiZUaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:11 INFO - Running setup.py (path:/tmp/pip-aGUC9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:37:11 INFO - Running setup.py (path:/tmp/pip-qVSuSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:37:11 INFO - Running setup.py (path:/tmp/pip-ZbyHZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:37:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:37:12 INFO - Running setup.py install for manifestparser 04:37:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:37:12 INFO - Running setup.py install for mozcrash 04:37:12 INFO - Running setup.py install for mozdebug 04:37:12 INFO - Running setup.py install for mozdevice 04:37:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:37:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:37:12 INFO - Running setup.py install for mozfile 04:37:12 INFO - Running setup.py install for mozhttpd 04:37:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:37:12 INFO - Running setup.py install for mozinfo 04:37:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:37:12 INFO - Running setup.py install for mozInstall 04:37:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:37:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:37:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:37:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:37:12 INFO - Running setup.py install for mozleak 04:37:12 INFO - Running setup.py install for mozlog 04:37:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:37:13 INFO - Running setup.py install for moznetwork 04:37:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:37:13 INFO - Running setup.py install for mozprocess 04:37:13 INFO - Running setup.py install for mozprofile 04:37:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:37:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:37:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:37:13 INFO - Running setup.py install for mozrunner 04:37:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:37:13 INFO - Running setup.py install for mozscreenshot 04:37:13 INFO - Running setup.py install for moztest 04:37:13 INFO - Running setup.py install for mozversion 04:37:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:37:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:37:13 INFO - Cleaning up... 04:37:13 INFO - Return code: 0 04:37:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37:13 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')]} 04:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:13 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')]} 04:37:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:13 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 0x7fcf7fac0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1713ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1710f60>, '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 0x1711d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17121d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442', '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 04:37:13 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 04:37:13 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 04:37:13 INFO - Using env: {'DISPLAY': ':0', 04:37:13 INFO - 'HOME': '/home/cltbld', 04:37:13 INFO - 'LANG': 'en_US.UTF-8', 04:37:13 INFO - 'LANGUAGE': 'en_US:en', 04:37:13 INFO - 'LOGNAME': 'cltbld', 04:37:13 INFO - 'MAIL': '/var/mail/cltbld', 04:37:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:13 INFO - 'MOZ_NO_REMOTE': '1', 04:37:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:13 INFO - 'NO_EM_RESTART': '1', 04:37:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:13 INFO - 'PWD': '/builds/slave/test', 04:37:13 INFO - 'SHELL': '/bin/bash', 04:37:13 INFO - 'SHLVL': '1', 04:37:13 INFO - 'TERM': 'linux', 04:37:13 INFO - 'TMOUT': '86400', 04:37:13 INFO - 'USER': 'cltbld', 04:37:13 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442', 04:37:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:13 INFO - '_': '/tools/buildbot/bin/python'} 04:37:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:37:14 INFO - Running setup.py (path:/tmp/pip-mW6kuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:37:14 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)) 04:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:37:14 INFO - Running setup.py (path:/tmp/pip-GkzNFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:37:14 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)) 04:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:37:14 INFO - Running setup.py (path:/tmp/pip-iJTVQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:37:14 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)) 04:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:37:14 INFO - Running setup.py (path:/tmp/pip-_BXJCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:37:14 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)) 04:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:37:14 INFO - Running setup.py (path:/tmp/pip-rpfnlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:37:14 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)) 04:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:37:14 INFO - Running setup.py (path:/tmp/pip-G2g4p_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:37:14 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)) 04:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:37:14 INFO - Running setup.py (path:/tmp/pip-huw4xF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:37:14 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)) 04:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:37:14 INFO - Running setup.py (path:/tmp/pip-yGW8W4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:37:14 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)) 04:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:37:14 INFO - Running setup.py (path:/tmp/pip-v5q6FI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:37:14 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)) 04:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:37:14 INFO - Running setup.py (path:/tmp/pip-JLBUcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:37:14 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)) 04:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:37:14 INFO - Running setup.py (path:/tmp/pip-xMJ3bA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:37:14 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)) 04:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:37:14 INFO - Running setup.py (path:/tmp/pip-e871V3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:37:14 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)) 04:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:37:14 INFO - Running setup.py (path:/tmp/pip-SPvi77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:37:14 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)) 04:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:37:15 INFO - Running setup.py (path:/tmp/pip-HQgxb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:37:15 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)) 04:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:15 INFO - Running setup.py (path:/tmp/pip-1Z7Q3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:15 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)) 04:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:37:15 INFO - Running setup.py (path:/tmp/pip-IbZy4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:37:15 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)) 04:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:37:15 INFO - Running setup.py (path:/tmp/pip-eSfbs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:37:15 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)) 04:37:15 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)) 04:37:15 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)) 04:37:15 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)) 04:37:15 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)) 04:37:15 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)) 04:37:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:37:15 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 04:37:15 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 04:37:15 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 04:37:15 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 04:37:15 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 04:37:15 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 04:37:17 INFO - Downloading blessings-1.6.tar.gz 04:37:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:37:17 INFO - Installing collected packages: blessings 04:37:17 INFO - Running setup.py install for blessings 04:37:17 INFO - Successfully installed blessings 04:37:17 INFO - Cleaning up... 04:37:17 INFO - Return code: 0 04:37:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:37:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:37:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:37:17 INFO - Reading from file tmpfile_stdout 04:37:17 INFO - Current package versions: 04:37:17 INFO - argparse == 1.2.1 04:37:17 INFO - blessings == 1.6 04:37:17 INFO - blobuploader == 1.2.4 04:37:17 INFO - docopt == 0.6.1 04:37:17 INFO - functools32 == 3.2.3-2 04:37:17 INFO - jsonschema == 2.5.1 04:37:17 INFO - manifestparser == 1.1 04:37:17 INFO - mozInstall == 1.12 04:37:17 INFO - mozcrash == 0.17 04:37:17 INFO - mozdebug == 0.1 04:37:17 INFO - mozdevice == 0.48 04:37:17 INFO - mozfile == 1.2 04:37:17 INFO - mozhttpd == 0.7 04:37:17 INFO - mozinfo == 0.9 04:37:17 INFO - mozleak == 0.1 04:37:17 INFO - mozlog == 3.4 04:37:17 INFO - moznetwork == 0.27 04:37:17 INFO - mozprocess == 0.23 04:37:17 INFO - mozprofile == 0.28 04:37:17 INFO - mozrunner == 6.12 04:37:17 INFO - mozscreenshot == 0.1 04:37:17 INFO - mozsystemmonitor == 0.3 04:37:17 INFO - moztest == 0.7 04:37:17 INFO - mozversion == 1.4 04:37:17 INFO - psutil == 3.1.1 04:37:17 INFO - requests == 1.2.3 04:37:17 INFO - wsgiref == 0.1.2 04:37:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37:17 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')]} 04:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:17 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')]} 04:37:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:17 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 0x7fcf7fac0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1713ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1710f60>, '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 0x1711d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17121d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442', '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 04:37:17 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 04:37:17 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 04:37:17 INFO - Using env: {'DISPLAY': ':0', 04:37:17 INFO - 'HOME': '/home/cltbld', 04:37:17 INFO - 'LANG': 'en_US.UTF-8', 04:37:17 INFO - 'LANGUAGE': 'en_US:en', 04:37:17 INFO - 'LOGNAME': 'cltbld', 04:37:17 INFO - 'MAIL': '/var/mail/cltbld', 04:37:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:17 INFO - 'MOZ_NO_REMOTE': '1', 04:37:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:17 INFO - 'NO_EM_RESTART': '1', 04:37:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:17 INFO - 'PWD': '/builds/slave/test', 04:37:17 INFO - 'SHELL': '/bin/bash', 04:37:17 INFO - 'SHLVL': '1', 04:37:17 INFO - 'TERM': 'linux', 04:37:17 INFO - 'TMOUT': '86400', 04:37:17 INFO - 'USER': 'cltbld', 04:37:17 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442', 04:37:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:17 INFO - '_': '/tools/buildbot/bin/python'} 04:37:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:17 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)) 04:37:17 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)) 04:37:17 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)) 04:37:17 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)) 04:37:17 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)) 04:37:17 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)) 04:37:17 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)) 04:37:17 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)) 04:37:17 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)) 04:37:17 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)) 04:37:17 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)) 04:37:17 INFO - Cleaning up... 04:37:17 INFO - Return code: 0 04:37:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:37:17 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')]} 04:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:17 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')]} 04:37:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:17 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 0x7fcf7fac0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1713ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1710f60>, '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 0x1711d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17121d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442', '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 04:37:17 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 04:37:17 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 04:37:17 INFO - Using env: {'DISPLAY': ':0', 04:37:17 INFO - 'HOME': '/home/cltbld', 04:37:17 INFO - 'LANG': 'en_US.UTF-8', 04:37:17 INFO - 'LANGUAGE': 'en_US:en', 04:37:17 INFO - 'LOGNAME': 'cltbld', 04:37:17 INFO - 'MAIL': '/var/mail/cltbld', 04:37:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:17 INFO - 'MOZ_NO_REMOTE': '1', 04:37:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:17 INFO - 'NO_EM_RESTART': '1', 04:37:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:17 INFO - 'PWD': '/builds/slave/test', 04:37:17 INFO - 'SHELL': '/bin/bash', 04:37:17 INFO - 'SHLVL': '1', 04:37:17 INFO - 'TERM': 'linux', 04:37:17 INFO - 'TMOUT': '86400', 04:37:17 INFO - 'USER': 'cltbld', 04:37:17 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442', 04:37:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:17 INFO - '_': '/tools/buildbot/bin/python'} 04:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:37:18 INFO - Cleaning up... 04:37:18 INFO - Return code: 0 04:37:18 INFO - Running post-action listener: _resource_record_post_action 04:37:18 INFO - Running post-action listener: _start_resource_monitoring 04:37:18 INFO - Starting resource monitoring. 04:37:18 INFO - [mozharness: 2016-09-27 11:37:18.125616Z] Finished create-virtualenv step (success) 04:37:18 INFO - [mozharness: 2016-09-27 11:37:18.126068Z] Running install step. 04:37:18 INFO - Running pre-action listener: _resource_record_pre_action 04:37:18 INFO - Running main action method: install 04:37:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:37:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:37:18 INFO - Reading from file tmpfile_stdout 04:37:18 INFO - Detecting whether we're running mozinstall >=1.0... 04:37:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:37:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:37:18 INFO - Reading from file tmpfile_stdout 04:37:18 INFO - Output received: 04:37:18 INFO - Usage: mozinstall [options] installer 04:37:18 INFO - Options: 04:37:18 INFO - -h, --help show this help message and exit 04:37:18 INFO - -d DEST, --destination=DEST 04:37:18 INFO - Directory to install application into. [default: 04:37:18 INFO - "/builds/slave/test"] 04:37:18 INFO - --app=APP Application being installed. [default: firefox] 04:37:18 INFO - mkdir: /builds/slave/test/build/application 04:37:18 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'] 04:37:18 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 04:37:34 INFO - Reading from file tmpfile_stdout 04:37:34 INFO - Output received: 04:37:34 INFO - /builds/slave/test/build/application/firefox/firefox 04:37:34 INFO - Running post-action listener: _resource_record_post_action 04:37:34 INFO - [mozharness: 2016-09-27 11:37:34.540788Z] Finished install step (success) 04:37:34 INFO - [mozharness: 2016-09-27 11:37:34.541032Z] Running run-tests step. 04:37:34 INFO - Running pre-action listener: _resource_record_pre_action 04:37:34 INFO - Running main action method: run_tests 04:37:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:37:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:37:34 INFO - Python 2.7.3 04:37:34 INFO - Return code: 0 04:37:34 INFO - grabbing minidump binary from tooltool 04:37:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:34 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 0x1710f60>, '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 0x1711d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17121d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:37:34 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 04:37:34 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 04:37:34 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 04:37:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:37:34 INFO - Return code: 0 04:37:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:37:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:37:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:37:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:37:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:37:34 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/d8kijwZsSyyyeucAXl1ERg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:37:34 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/d8kijwZsSyyyeucAXl1ERg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:37:34 INFO - Using env: {'DISPLAY': ':0', 04:37:34 INFO - 'HOME': '/home/cltbld', 04:37:34 INFO - 'LANG': 'en_US.UTF-8', 04:37:34 INFO - 'LANGUAGE': 'en_US:en', 04:37:34 INFO - 'LOGNAME': 'cltbld', 04:37:34 INFO - 'MAIL': '/var/mail/cltbld', 04:37:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:37:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:37:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:34 INFO - 'MOZ_NO_REMOTE': '1', 04:37:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:37:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:34 INFO - 'NO_EM_RESTART': '1', 04:37:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:34 INFO - 'PWD': '/builds/slave/test', 04:37:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:37:34 INFO - 'SHELL': '/bin/bash', 04:37:34 INFO - 'SHLVL': '1', 04:37:34 INFO - 'TERM': 'linux', 04:37:34 INFO - 'TMOUT': '86400', 04:37:34 INFO - 'USER': 'cltbld', 04:37:34 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442', 04:37:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:34 INFO - '_': '/tools/buildbot/bin/python'} 04:37:34 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/d8kijwZsSyyyeucAXl1ERg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:37:34 INFO - mozversion application_buildid: 20160927035852 04:37:34 INFO - mozversion application_changeset: 7c1929f35c5d11b0b921ebd03c197bdb5afbeaca 04:37:34 INFO - mozversion application_display_name: Nightly 04:37:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:37:34 INFO - mozversion application_name: Firefox 04:37:34 INFO - mozversion application_remotingname: firefox 04:37:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:37:34 INFO - mozversion application_vendor: Mozilla 04:37:34 INFO - mozversion application_version: 52.0a1 04:37:34 INFO - mozversion platform_buildid: 20160927035852 04:37:34 INFO - mozversion platform_changeset: 7c1929f35c5d11b0b921ebd03c197bdb5afbeaca 04:37:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:37:34 INFO - mozversion platform_version: 52.0a1 04:37:34 INFO - using testdate: 1474976254 04:37:34 INFO - actual date: 1474976254 04:37:34 INFO - starting webserver on 'localhost:50291' 04:37:34 INFO - SUITE-START | Running 2 tests 04:37:34 INFO - TEST-START | dromaeo_css 04:37:34 INFO - operating with platform_type : linux_ 04:37:34 INFO - Initialising browser for dromaeo_css test... 04:37:34 INFO - TEST-INFO | started process 31027 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx2dhso/profile http://localhost:50291/getInfo.html) 04:37:39 INFO - PROCESS | 31027 | __metrics Screen width/height:1600/1200 04:37:39 INFO - PROCESS | 31027 | colorDepth:24 04:37:39 INFO - PROCESS | 31027 | Browser inner width/height: 1024/697 04:37:39 INFO - PROCESS | 31027 | __metrics 04:37:40 INFO - PROCESS | 31027 | 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" 04:37:40 INFO - PROCESS | 31027 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:37:40 INFO - PROCESS | 31027 | console.error: PushService: 04:37:40 INFO - PROCESS | 31027 | stateChangeProcessEnqueue: Error transitioning state 04:37:40 INFO - PROCESS | 31027 | UnknownError 04:37:41 INFO - TEST-INFO | 31027: exit 0 04:37:41 INFO - Browser initialized. 04:37:41 INFO - Running cycle 1/1 for dromaeo_css test... 04:37:41 INFO - TEST-INFO | started process 31110 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx2dhso/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:37:53 INFO - PROCESS | 31110 | RSS: Main: 175919104 04:37:53 INFO - PROCESS | 31110 | 04:38:45 INFO - PROCESS | 31110 | 1474976325356 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] 04:40:57 INFO - PROCESS | 31110 | Cycle 1(1): loaded http://localhost:50291/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50291/tests/dromaeo/cssquery-ext.html) 04:40:59 INFO - PROCESS | 31110 | RSS: Main: 320823296 04:40:59 INFO - PROCESS | 31110 | 04:44:02 INFO - PROCESS | 31110 | Cycle 1(1): loaded http://localhost:50291/tests/dromaeo/cssquery-ext.html (next: http://localhost:50291/tests/dromaeo/cssquery-jquery.html) 04:44:02 INFO - PROCESS | 31110 | RSS: Main: 272277504 04:44:02 INFO - PROCESS | 31110 | 04:47:05 INFO - PROCESS | 31110 | Cycle 1(1): loaded http://localhost:50291/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50291/tests/dromaeo/cssquery-mootools.html) 04:47:05 INFO - PROCESS | 31110 | RSS: Main: 253677568 04:47:05 INFO - PROCESS | 31110 | 04:50:07 INFO - PROCESS | 31110 | Cycle 1(1): loaded http://localhost:50291/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50291/tests/dromaeo/cssquery-prototype.html) 04:50:08 INFO - PROCESS | 31110 | RSS: Main: 217194496 04:50:08 INFO - PROCESS | 31110 | 04:53:11 INFO - PROCESS | 31110 | Cycle 1(1): loaded http://localhost:50291/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50291/tests/dromaeo/cssquery-yui.html) 04:53:12 INFO - PROCESS | 31110 | RSS: Main: 217964544 04:53:12 INFO - PROCESS | 31110 | 04:56:15 INFO - PROCESS | 31110 | Cycle 1(1): loaded http://localhost:50291/tests/dromaeo/cssquery-yui.html (next: http://localhost:50291/tests/dromaeo/cssquery-dojo.html) 04:56:15 INFO - PROCESS | 31110 | RSS: Main: 294707200 04:56:15 INFO - PROCESS | 31110 | 04:56:15 INFO - PROCESS | 31110 | __start_tp_report 04:56:15 INFO - PROCESS | 31110 | _x_x_mozilla_page_load 04:56:15 INFO - PROCESS | 31110 | _x_x_mozilla_page_load_details 04:56:15 INFO - PROCESS | 31110 | |i|pagename|runs| 04:56:15 INFO - PROCESS | 31110 | |0;dojo.html;2590.676165479315;2613.333599932017;2645.973540264597;2655.070725246164;2670.8531030793297;4641.25739881619;4712.175369310366;4733.934864655451;4760.500147484512;4853.2720091986175;4740.241561350184;4741.336212930192;4776.785044672989;4808.855734327967;4844.66087373884;4325.870223893288;4336;4381.671374646899;4401.141777353418;4404.515503294635;4451.5993560579545;4499.707519011254;4500.356656507369;4506.8422605208825;4522.932156017662;4303.483581970152;4390.121975604892;4403.889902752425;4419.756913369763;4490.461144662645;4329.783510824478;4352.825886964518;4360.345948107777;4378.408914796493;4421.668374871898;4324.891877703051;4325.070109926381;4334.068175342285;4380.846670366522;4398.3622374755805;4727.929081063787;4737.336772851803;4758.405199350082;4778.259369797652;4786.64100192487;4934.876628084291;4988.077205716918;5006.299118123466;5048.419431765357;5102.311187989611;5079.542841144278;5081.136206844808;5092.719900405476;5140.845774626767;5156.097682905514;4728.739919304402;4743.359646447754;4744.881377965578;4747.264174053027;4816.638752093607;5041.773120209599;5081.415637201695;5179.533841954242;5265.736713164327;5270.420253772082;4920.434150072788;5011.4487406386;5060.063888180698;5063.670861394071;5143.71709555978;5160.380754309432;5168.2764412982215;5170.069387510284;5172.19830926207;5173.1722924331925;5070.112730272188;5070.61970352225;5113.948860511347;5118.232265160255;5164.406093299243;4856.975715121402;4921.409430868319;4927.704337739747;4997.175466048134;5143.254228136899;4287.249731297011;4298.333758267411;4338.392625032498;4344.196323680129;4401.053773438726;3766.0961369271176;3773.867914622975;3778.6221377861993;3820.1595648957186;3828.885133446001;4372.060007098426;4379.4525684289465;4381.18947994622;4385.188740083031;4434.933475997863;4976.825811096666;5024.472430394829;5033.245013247969;5057.974710126426;5076.543111120017;4348.130373925228;4350.2387082260475;4402.361657559636;4410.16206920684;4411.228035093845;4558.0655965526985;4584.083183363341;4593.448786145684;4638.884027899329;4643.558861908114;4621.768911554476;4698.859034228979;4745.857624271277;4756.952430475721;4817.759112044314;4995.225740010304;5032.370953630796;5063.898722025465;5086.135356989246;5086.160783470686;4685.718856868599;4687.835925742719;4696.4599071105895;4763.428388593391;4764.30917516965;4950.801967921387;4953.975230123826;4954.77703503336;4955.603551715926;5015.899682006412;4874.561289483963;4941.456439791692;4955.430125535466;5046.747662616781;5087.033463641897;4841.491643377535;4854.73298968546;4880.048390563948;4954.232094025432;4960.627952903475;4873.390826146731;4900.313956046085;4911.435184953776;4914.311996320446;4964.131277026434;4708.199606067045;4806.49531799156;4849.151398505177;4877.975610121926;4921.434035085867;4883.560479556857;4918.754062296943;4950.603951683928;4952.108620448354;5010.198368261061;4804.663673542818;4838.322634831056;4839.540243676845;4845.830395936126;4908.779104940215 04:56:15 INFO - PROCESS | 31110 | |1;ext.html;554.282204545114;569.0951387294202;573.5096492498916;577.3677822784052;580.3355158343696;28561.714382856164;38877.80561097194;40194.39708404369;40372;44393;41305.79347103268;41883.58116418835;41932.790336048274;41934.37098443518;41960.370594441105;7329.596872172028;7524.661390237453;7655.578943158124;7677.270659287359;7688.231176882323;7307.415406767446;9710.805783884318;9933.900660993406;9978.052085051908;10305.381677099398;9930.404175749441;9934.950325248363;9956.103950644441;9959.153471954856;10053.296269261155;9881.95059024704;9955.05426984439;10006.799864002753;10019.246631839473;10020.599176033023;9792;9892.703218903373;9894.10953014225;9896.564998075239;9898.80202395948;37772.81113594415;38162;38258.23483530342;38286.23427531434;38298;2952.7342539171577;3127.3276245607076;3303.306305675787;3323.96676033239;3579.6599323064265;25996.480070398677;27934.720652793414;28481.287967800763;28546.429071418665;28582.857085714437;3515.3145136698354;3544.3974524330924;3558.6085530591613;3727.9813600932093;3743.681787048104;254579;255642;255833;256446;256646;31025.68974310228;53890.73054634702;54213.72893135588;54296.185557216675;54327.03603905311;31674.524882126785;33828.661713383044;33831.66168338335;33852.32295354079;33853.32293354119;12870.806937895939;12940.417681204368;12984.545540906023;12999.09006369564;13036.41336139857;9373;9582.952085239669;10744.14046876248;10819.080378167786;10820.458977051116;7352.742654007191;7418.480706350611;7426.777196684108;7518.812029699301;7780.8832867507035;2975.523916173402;3022.9395412092076;3026.9243268918012;3047.588575542318;3107.502799552061;838.6058552480324;867.2108381372921;877.4998250996871;897.9146981036791;971.3297824501071;26632.866835665696;27229;27814;27844.16467505978;27855.442891142062;920.2040235196507;976.8876579193342;995;1035.2028937717914;1035.30634474902;14206.560173155822;14856.108633482027;14863.851361486462;14896.553103406915;14945.317160469234;116849.41575292069;410745;417260;418135;623778;49045.50954490481;49149;49188.7540562302;49221.261681074815;49317.26024109641;1073.1575713065051;1094.9124070074533;1165.4056431220138;1178.8644305904932;1184.265755231762;25560.616590751524;29483.85258073696;31067.689323107385;31542;31817.522737159423;46800.7659961698;47550.28674569954;47681.28478072762;47706;47736.28395574;342211;344432;345334;345505;346059;21811.454713632287;22350.888245558668;22498.66252006254;25545.61681574815;25883;35023.29953400969;35184.472232916014;39525.40711889266;41727.16545669009;41997.79001105097;35688.286234275685;35749.46375804313;35824.28351433009;35998;36024.099397515274;35300.29399411946;35430.46854297136;35764.284714306086;35953.101172470895;36021.45967810538;35167.824160879034;35249.1187720309;35945.460818087224;36114.63885361218;36404.27191456209;30221.69778302189;32430;32493.025209243762;32966;33066.504002440466;24558;25003.87498062498;25559;25856.48287034211;26050.609240861024 04:56:15 INFO - PROCESS | 31110 | |2;jquery.html;344.9758516903818;362.6192497877228;364.14971042615485;372.9757565758226;389.58509187715083;12509.562165324203;12656.367876848433;13994.650133746649;14500.564983050499;17341.653166936652;16674.33302667895;16728.247228874698;17275.654486910254;17396.913015434904;17432.56418589536;4855.732934688591;5072.137736584771;5141.974290128563;5150.1759718445055;5151.4333423323405;3677.8712745053926;5080.41575218849;5158.303629010074;5164.896702065957;5174.508421699951;3846.8076596170217;3913.7651740895494;3950.2494526040105;6009.549283803733;6111.969440152793;5902.557308201859;6103.298120716108;6105.81682549522;6107.4808641265545;6116.418940200674;5343.064963631349;5367.946320536823;5375;5375.731213439312;5377.354717433933;20558.69161962572;20663.27678531259;20674.793252067437;20859.37421877346;21022.474438139016;1743.4943866278763;1810.185416562552;1891.0828248299563;1907.437305994735;1979.1094007696595;8760.21158095768;8949.284057275403;9111.681091161843;9445.386049906734;9589.376690515164;1617.5632579203666;1660.767492551044;1683.8400351966543;1691.2727527163315;1716.3048965169125;64554;64712.55805582371;65824.67087664531;67171.32828671699;68157.65921170362;9536.28477864163;9785.510724463747;9795.363301385387;9951.476930303606;10181.949090254502;13175.60473185806;13194.142380745221;13260.53588124411;13278.601641950758;13358.933205333911;6970.302969702989;7293.854122917618;7322.560646361236;7431.29402706742;7459.365953893871;6518.804435866931;6763.628000459924;6858.947768243084;7130.643467826588;7151.749688760972;4088.5707000765087;4227.830886764495;4284.592963668447;4350.325699516517;4352.651787856964;1736.8957862528036;1795.317779243879;1823.589692319244;1839.6412699523464;1866.9719954200698;820.6471217376585;827.7392621324263;842.3513894301353;888.7422647432302;933.332667142996;15985.680286394207;16670.249838757285;17083.40208092711;17291;17625.647487050188;831.6839600951721;838.5723281126669;844.27814218842;857.511218605389;859.1923591823665;9117.77205569866;9905.653302134391;10025.498725063717;10367.740806479898;10464.854704785654;354281;360522;373785;375988;377201;51523;58465;80266;80784.59607701923;81960.18039819645;907.6414816147585;925.134998776133;944.1219665710955;946.1815529566875;949.4872768704822;15220.162891041098;15591.76612350793;16208.918955405148;16463.259153337887;16484.752728708838;33785;36447;39555.163775629764;39739;40711.389329159494;46442.53557464382;46947.765261173474;48824;52806.2079068822;55899.441005589426;6223;6450.612963222222;6669.1330127083165;6866;7064.894026589708;8820.382573219813;10778.461076946278;11119.221654484109;11260.94369528147;11518.769624607628;9819.9018009819;10206.234532410248;10246.23153263523;10388.11701005423;10705;10039.297249192487;10155.238357123097;10341;10386.688399348031;10400.531976061247;9507.477088759908;9945.950270248602;10139.695809125738;10321.793564128826;10796;6904.482163837632;7033.683484243119;7060.258672839484;7127.714891404493;7134.750283740044;9332.440053596805;10129.058660305276;10248.948755256177;10320.535575899252;10350.844737328796 04:56:15 INFO - PROCESS | 31110 | |3;mootools.html;1352.966175845604;1399.174487052639;1462.195792314227;1597.5287290249375;1683.6464342488084;7021.508494405393;7276;7543.773686789398;8183;8192.795180120493;7643.350315223212;7808.92191078089;7879.133295337509;8159.510429374227;8163.510189388641;2118.184498967893;2133.5412886229456;2144.15305954148;2146.2702681088426;2152.0638522242875;1760.489458057162;1859.0333026826042;1965.547923977486;2126.7447906251195;2167.1223154622403;1989.870658407206;2029.9797002029939;2032.9186832526755;2032.928847490338;2038.918443262275;2091.5816836632657;2096.517800905785;2099.1078791513696;2102.873827570351;2134.967975480369;2117.7035215069905;2123.6283650361124;2124.2989813361555;2126.8830214338204;2127.2767259131815;7963.721269755531;8031.518108913484;8033.1565185655245;8039.477433966774;8064;4484.596386325246;4490.640748740093;4555.726656400627;4559.156556037144;4563.840265590688;2809.90165344212;2947.336849208932;2984.8955286565083;2999.7150270724246;3007.548867669845;866.9393142480029;880.300161371711;881.180502133016;886.609891647673;900.3472482450237;11001.889981100167;11062.22564420491;11071.99999999992;11086.889131108746;11197.27217730853;3900.356441187229;4101.85643502476;4167.666586673059;4227.175700738388;4228.88555722139;9308.581113849894;9330.393524420891;9336.95331523338;9342.205912497513;9346.57940392684;4547.363369128325;4550.249208880564;4552.795124219418;4553.772311384484;4555.339475775994;4038.8788336349958;4156.667466602665;4162.167566486654;4163.791810409467;4172.290710579209;3646.538586454186;3679.5400574928135;3750.4936833527127;3812.866549670748;3814.6948244140403;1041.6406339812752;1089.54239219528;1129.9830502542468;1172.5309876049648;1197.4312201704122;643.9517036222302;778.4434129597252;821.5399376349263;841.389992255622;845.5772113943028;5158.535731784157;5250.343707036621;5265.578753699695;5377.247185394048;5402.783888644489;815.233680340478;855.1192271959891;871.1549796697194;880.6609455359604;895.7178488776015;3543.7519373644113;3548.929021419557;3612.3678356287546;3631.963680363215;3875.612438756158;9901.405915645084;10062.496875156214;10076.3954162749;10086.243531735003;10165.745856353651;9911.355761875455;10022.74943126413;10034.899651003543;10043.899561004442;10049.497525123714;7404.703811847466;7591.8861217081785;7618.352440042548;7620.314171724572;7623.69505219785;5317.308749862493;5353.250544923636;5449;5450.754716037709;5561.63849349791;8703.695370661997;8997.55012249398;9012.729618111467;9163.266938645025;9310.627574896927;9191.264698823945;9295.907040929775;9315.441073535609;9326.580303886478;9407.623695052122;6694.966525167343;6847.589144651337;6850.588964662136;6867.283179205198;7059.505834591735;7397.112346518452;7534.698612055457;7536.849263014599;7538.773836784905;7541.472096953161;6805.89791153143;6855.280195579592;6884.4148247399535;7129;7132.607706576188;6486.383793539606;6516.967415162894;6618.371254730793;6632.767853125118;6647.6676166192465;6058.787942421994;6176.166217560752;6181.165542651865;6184.536159788124;6194.442500175006;4288.678349123766;4415.646748260196;4437.911241775211;4514;4521.751303678329;4417.889552761207;4442.911141777082;4471.128130014616;4499.932501012422;4516.232240519054 04:56:15 INFO - PROCESS | 31110 | |4;prototype.html;295.55666500249623;300.81800510691033;306.29246440721926;306.3016322784052;307.0404984423676;4810.39870016248;4830.058138662957;4834.685745426545;4842.75786210689;4859.951400485994;4735.5974742146955;4754.573627911622;4755.952440475594;4768.141734487791;4777.235642297233;3578.9821050894775;3675.44868269759;3695.870644527429;3730.7501986834445;3735.533058367704;3614.34941710492;3684.5578530576236;3717.9814100929593;3754.361758501048;3785.129420233348;3703.9814800925956;3718.2563487302646;3726.6646001859826;3729.1982223821874;3732.3095227382887;3657.231981283907;3707.1473561080966;3737.4020156774923;3741.4761933329355;3744.0826997385543;3316.2372654289406;3322.302316513535;3326.550915626384;3332.100332910125;3342.331533693271;4654.534546545352;4661.417322834645;4670.486246512881;4676.298555216711;4681.0871879983415;4292.991147080434;4305.526392096866;4307.267764480046;4308.590683885026;4311.353297005474;4841.419029716421;4884.438289596706;4894.804207831682;4954.653174277802;4985;3590.694790942773;3592.586852511942;3592.892213233607;3596.62235465275;3604.567451905788;5219.347581552306;5226.608004399647;5255.159174532057;5262.842114736564;5266.894662106774;3599.136207310279;3687.1703866629796;3696.5194524711615;3702.407614781676;3717.4572552390996;3747.4191500317493;3775.2826962876966;3790.639889210521;3791.109089363997;3794.4118661607495;4258.701890867609;4268.615824575803;4278.144371125787;4288.120935208275;4303.354496825501;4813.879653008703;4980;4981.427135879348;4995.150824359867;5059.822906198266;1302.160106731153;1310.960671179866;1317.367663521515;1326.1777697827215;1327.7809161488246;824.8286070427004;848.5078654380444;859.1537335724306;864.3690106222493;865.9696910608099;3955.169414422946;4207;4296.720713153698;4351.456067991501;4430.291153415438;5047.899042019139;5111.488851114858;5150.690958542499;5152.6650767699975;5158.710322419395;4360.9127817444105;4365.628921541641;4431.446069241345;4449.555044495589;4463.218936686132;2648.8940442382473;2682.4366882954796;2714.67894949819;2726.740959608834;2739.1919383781833;4745.95254047462;4759.928601070987;4775.6657034007285;4778.259369797687;4787.760611969387;5230.08473517133;5233.816816411483;5243.501867322599;5249.921251181236;5250.684958902478;4685.976570117127;4795.424549054136;4795.928061079087;4808.9519104808505;4830.492798256273;5117.5650069743;5149.69101853875;5157.716325602128;5159.380874294959;5180.533751962342;5048.621353398436;5057.74711264428;5064.772085256246;5066.746662666926;5070.41690205631;4602.585767280961;4775.71055814935;4783.95216047835;4803;4807.519248075165;3754.2491501700315;3764.9834544672235;3773.8490460382377;3779.281936432069;3795.8102094894593;5083.517065878736;5114.616403769658;5156.2671783954565;5173.741312934413;5186.948130518646;4719.976400118115;4970.652054356305;5019.84940451787;5041.269015992734;5055.848324550269;5030.446650868328;5037.395512538519;5039.949600504095;5042.14283571801;5047.318611987482;4971.458847757207;4977.676451030671;4979.651424400257;4984.775685094107;4989.750512474289;4782.904341913212;4920.163572192664;4939.629527785359;4989.575886049726;5035.29505869186;4796.880077998078;4915.95084049155;4948.975255123702;4953.380827396575;4960.578350840219 04:56:15 INFO - PROCESS | 31110 | |5;yui.html;550.9531689806365;560.4815545620302;574.6264927796929;600.5735927491481;624.5596854217777;12062.879371206285;12464.314462704548;12490.937545312283;13083.803742943863;13093.54172603959;12216.083793715485;12457.626271211879;12493.625191244255;12497.06272029597;12506.749865002694;629.7638385605399;647.795944277551;757.046121886423;777.1567848883967;779.3842864137325;758.5297115788219;776.8329809091044;783.8667426537502;785.1677222144546;786.3866184376195;827.9586020698971;830.3979614779267;830.730012745857;830.7424698343502;831.0152469323871;655.8229278094888;816.6814942172557;819.9098099209082;820.5979070255592;821.0721884270796;492.49519242776086;578.5949835115393;591.3288417646003;594.9524038076944;596.84780381003;12187.39063046844;12188.20776649515;12189;12202.694932626666;12222.511099556006;11792.351420671945;12055.457504412234;12093.939530302292;12960.611181664472;13544.864551354558;11540.422978851024;11922.642320730392;12045.879541204564;12104.576339828152;12110.091743119301;4149.543550209474;4241.49102107746;4284.3145096784365;4301.5913488218885;4432.800523976396;56515;68271.65864170647;68563.31436685669;68782.31217687808;68815;9934.850977235346;9984.15134713543;9997.750056248651;10069.798604028025;10121.595136194617;17672.823271767375;18719.344822931133;18930.716039259423;18973.241070357308;18978.905105474383;6794.184697836291;6893.586384816927;6952.617606031616;6962.721491140399;7028.226895041541;3536.575610926654;3584.444411116281;3670.15586415126;3714.312852122366;3755.230177813596;2920.6495220573665;3027.061610900628;3067.585875906724;3069.754419646423;3071.8156910585435;515.6081378152631;516.4267662894184;522.6263221796434;525.1282870435059;526.194921769693;546.1698218707543;552.8313864271355;553.3691591585515;566.940471250521;573.6357413042748;7618.771436856792;7647.349975252055;7715.807104822425;7827.334676552443;8074.515529068275;455.2374772256457;516.1586613819525;555.7110302642603;559.527199516408;592.4934181274948;3945.82243799024;3984.880453586397;4138.503379594407;4163.377861260723;4256.616904478612;100286;102466;103922;105656;105940;88099;88601;89724.5513772427;90531;94374.5281273603;77318.6134069326;79693;80415.19584804194;80476;81331;7725.845483090419;7888.7633370998965;8030.799230019296;8045.477043992122;8270.83458330842;37550;37859;39385.40921886117;41102.1779564413;41703.7914810424;40111.81131343537;45721.59897614403;57972;60648;65354.67322663356;11391.886081139082;11511.481983310603;11657.941710291394;11673.066154707432;11835.112366572714;11571.479283432098;11994.280343179436;12205.20666156697;12323.69190770238;12529.749405012031;11200.615264758535;11442.599509017144;11517.654470365902;12039.03687704999;12078.456469459072;10193.133583645473;10287.691369258935;10323.122534584645;11291.491882865126;11548.711282217675;11497.770044599229;11564.074874009892;11884.10869184832;12652.936735316265;12704.047196460118;9303.441793492411;9502.857457138287;9726.513674316115;9871.40771553709;10437.843432348673;9190.356675032683;9856.457894815567;9945.154661853823;9985.800283994426;9987.151092157248 04:56:15 INFO - PROCESS | 31110 | __end_tp_report 04:56:15 INFO - PROCESS | 31110 | __start_cc_report 04:56:15 INFO - PROCESS | 31110 | _x_x_mozilla_cycle_collect,1275 04:56:15 INFO - PROCESS | 31110 | __end_cc_report 04:56:15 INFO - PROCESS | 31110 | __startTimestamp1474977375575__endTimestamp 04:56:15 INFO - PROCESS | 31110 | 04:56:15 INFO - PROCESS | 31110 | ------- Summary: start ------- 04:56:15 INFO - PROCESS | 31110 | Number of tests: 6 04:56:15 INFO - PROCESS | 31110 | 04:56:15 INFO - PROCESS | 31110 | [#0] dojo.html Cycles:165 Average:4686.71 Median:4806.50 stddev:481.65 (10.0%) stddev-sans-first:454.19 04:56:15 INFO - PROCESS | 31110 | Values: 2590.7 2613.3 2646.0 2655.1 2670.9 4641.3 4712.2 4733.9 4760.5 4853.3 4740.2 4741.3 4776.8 4808.9 4844.7 4325.9 4336.0 4381.7 4401.1 4404.5 4451.6 4499.7 4500.4 4506.8 4522.9 4303.5 4390.1 4403.9 4419.8 4490.5 4329.8 4352.8 4360.3 4378.4 4421.7 4324.9 4325.1 4334.1 4380.8 4398.4 4727.9 4737.3 4758.4 4778.3 4786.6 4934.9 4988.1 5006.3 5048.4 5102.3 5079.5 5081.1 5092.7 5140.8 5156.1 4728.7 4743.4 4744.9 4747.3 4816.6 5041.8 5081.4 5179.5 5265.7 5270.4 4920.4 5011.4 5060.1 5063.7 5143.7 5160.4 5168.3 5170.1 5172.2 5173.2 5070.1 5070.6 5113.9 5118.2 5164.4 4857.0 4921.4 4927.7 4997.2 5143.3 4287.2 4298.3 4338.4 4344.2 4401.1 3766.1 3773.9 3778.6 3820.2 3828.9 4372.1 4379.5 4381.2 4385.2 4434.9 4976.8 5024.5 5033.2 5058.0 5076.5 4348.1 4350.2 4402.4 4410.2 4411.2 4558.1 4584.1 4593.4 4638.9 4643.6 4621.8 4698.9 4745.9 4757.0 4817.8 4995.2 5032.4 5063.9 5086.1 5086.2 4685.7 4687.8 4696.5 4763.4 4764.3 4950.8 4954.0 4954.8 4955.6 5015.9 4874.6 4941.5 4955.4 5046.7 5087.0 4841.5 4854.7 4880.0 4954.2 4960.6 4873.4 4900.3 4911.4 4914.3 4964.1 4708.2 4806.5 4849.2 4878.0 4921.4 4883.6 4918.8 4950.6 4952.1 5010.2 4804.7 4838.3 4839.5 4845.8 4908.8 04:56:15 INFO - PROCESS | 31110 | 04:56:15 INFO - PROCESS | 31110 | [#1] ext.html Cycles:180 Average:47620.99 Median:19623.45 stddev:93177.55 (474.8%) stddev-sans-first:93371.93 04:56:15 INFO - PROCESS | 31110 | Values: 554.3 569.1 573.5 577.4 580.3 28561.7 38877.8 40194.4 40372.0 44393.0 41305.8 41883.6 41932.8 41934.4 41960.4 7329.6 7524.7 7655.6 7677.3 7688.2 7307.4 9710.8 9933.9 9978.1 10305.4 9930.4 9935.0 9956.1 9959.2 10053.3 9882.0 9955.1 10006.8 10019.2 10020.6 9792.0 9892.7 9894.1 9896.6 9898.8 37772.8 38162.0 38258.2 38286.2 38298.0 2952.7 3127.3 3303.3 3324.0 3579.7 25996.5 27934.7 28481.3 28546.4 28582.9 3515.3 3544.4 3558.6 3728.0 3743.7 254579.0 255642.0 255833.0 256446.0 256646.0 31025.7 53890.7 54213.7 54296.2 54327.0 31674.5 33828.7 33831.7 33852.3 33853.3 12870.8 12940.4 12984.5 12999.1 13036.4 9373.0 9583.0 10744.1 10819.1 10820.5 7352.7 7418.5 7426.8 7518.8 7780.9 2975.5 3022.9 3026.9 3047.6 3107.5 838.6 867.2 877.5 897.9 971.3 26632.9 27229.0 27814.0 27844.2 27855.4 920.2 976.9 995.0 1035.2 1035.3 14206.6 14856.1 14863.9 14896.6 14945.3 116849.4 410745.0 417260.0 418135.0 623778.0 49045.5 49149.0 49188.8 49221.3 49317.3 1073.2 1094.9 1165.4 1178.9 1184.3 25560.6 29483.9 31067.7 31542.0 31817.5 46800.8 47550.3 47681.3 47706.0 47736.3 342211.0 344432.0 345334.0 345505.0 346059.0 21811.5 22350.9 22498.7 25545.6 25883.0 35023.3 35184.5 39525.4 41727.2 41997.8 35688.3 35749.5 35824.3 35998.0 36024.1 35300.3 35430.5 35764.3 35953.1 36021.5 35167.8 35249.1 35945.5 36114.6 36404.3 30221.7 32430.0 32493.0 32966.0 33066.5 24558.0 25003.9 25559.0 25856.5 26050.6 04:56:15 INFO - PROCESS | 31110 | 04:56:15 INFO - PROCESS | 31110 | [#2] jquery.html Cycles:180 Average:23294.39 Median:4317.46 stddev:60851.95 (1409.4%) stddev-sans-first:60998.26 04:56:15 INFO - PROCESS | 31110 | Values: 345.0 362.6 364.1 373.0 389.6 12509.6 12656.4 13994.7 14500.6 17341.7 16674.3 16728.2 17275.7 17396.9 17432.6 4855.7 5072.1 5142.0 5150.2 5151.4 3677.9 5080.4 5158.3 5164.9 5174.5 3846.8 3913.8 3950.2 6009.5 6112.0 5902.6 6103.3 6105.8 6107.5 6116.4 5343.1 5367.9 5375.0 5375.7 5377.4 20558.7 20663.3 20674.8 20859.4 21022.5 1743.5 1810.2 1891.1 1907.4 1979.1 8760.2 8949.3 9111.7 9445.4 9589.4 1617.6 1660.8 1683.8 1691.3 1716.3 64554.0 64712.6 65824.7 67171.3 68157.7 9536.3 9785.5 9795.4 9951.5 10181.9 13175.6 13194.1 13260.5 13278.6 13358.9 6970.3 7293.9 7322.6 7431.3 7459.4 6518.8 6763.6 6858.9 7130.6 7151.7 4088.6 4227.8 4284.6 4350.3 4352.7 1736.9 1795.3 1823.6 1839.6 1867.0 820.6 827.7 842.4 888.7 933.3 15985.7 16670.2 17083.4 17291.0 17625.6 831.7 838.6 844.3 857.5 859.2 9117.8 9905.7 10025.5 10367.7 10464.9 354281.0 360522.0 373785.0 375988.0 377201.0 51523.0 58465.0 80266.0 80784.6 81960.2 907.6 925.1 944.1 946.2 949.5 15220.2 15591.8 16208.9 16463.3 16484.8 33785.0 36447.0 39555.2 39739.0 40711.4 46442.5 46947.8 48824.0 52806.2 55899.4 6223.0 6450.6 6669.1 6866.0 7064.9 8820.4 10778.5 11119.2 11260.9 11518.8 9819.9 10206.2 10246.2 10388.1 10705.0 10039.3 10155.2 10341.0 10386.7 10400.5 9507.5 9946.0 10139.7 10321.8 10796.0 6904.5 7033.7 7060.3 7127.7 7134.8 9332.4 10129.1 10248.9 10320.5 10350.8 04:56:15 INFO - PROCESS | 31110 | 04:56:15 INFO - PROCESS | 31110 | [#3] mootools.html Cycles:180 Average:5191.92 Median:4557.44 stddev:2997.57 (65.8%) stddev-sans-first:2992.10 04:56:15 INFO - PROCESS | 31110 | Values: 1353.0 1399.2 1462.2 1597.5 1683.6 7021.5 7276.0 7543.8 8183.0 8192.8 7643.4 7808.9 7879.1 8159.5 8163.5 2118.2 2133.5 2144.2 2146.3 2152.1 1760.5 1859.0 1965.5 2126.7 2167.1 1989.9 2030.0 2032.9 2032.9 2038.9 2091.6 2096.5 2099.1 2102.9 2135.0 2117.7 2123.6 2124.3 2126.9 2127.3 7963.7 8031.5 8033.2 8039.5 8064.0 4484.6 4490.6 4555.7 4559.2 4563.8 2809.9 2947.3 2984.9 2999.7 3007.5 866.9 880.3 881.2 886.6 900.3 11001.9 11062.2 11072.0 11086.9 11197.3 3900.4 4101.9 4167.7 4227.2 4228.9 9308.6 9330.4 9337.0 9342.2 9346.6 4547.4 4550.2 4552.8 4553.8 4555.3 4038.9 4156.7 4162.2 4163.8 4172.3 3646.5 3679.5 3750.5 3812.9 3814.7 1041.6 1089.5 1130.0 1172.5 1197.4 644.0 778.4 821.5 841.4 845.6 5158.5 5250.3 5265.6 5377.2 5402.8 815.2 855.1 871.2 880.7 895.7 3543.8 3548.9 3612.4 3632.0 3875.6 9901.4 10062.5 10076.4 10086.2 10165.7 9911.4 10022.7 10034.9 10043.9 10049.5 7404.7 7591.9 7618.4 7620.3 7623.7 5317.3 5353.3 5449.0 5450.8 5561.6 8703.7 8997.6 9012.7 9163.3 9310.6 9191.3 9295.9 9315.4 9326.6 9407.6 6695.0 6847.6 6850.6 6867.3 7059.5 7397.1 7534.7 7536.8 7538.8 7541.5 6805.9 6855.3 6884.4 7129.0 7132.6 6486.4 6517.0 6618.4 6632.8 6647.7 6058.8 6176.2 6181.2 6184.5 6194.4 4288.7 4415.6 4437.9 4514.0 4521.8 4417.9 4442.9 4471.1 4499.9 4516.2 04:56:15 INFO - PROCESS | 31110 | 04:56:15 INFO - PROCESS | 31110 | [#4] prototype.html Cycles:180 Average:4157.26 Median:4755.26 stddev:1196.77 (25.2%) stddev-sans-first:1164.50 04:56:15 INFO - PROCESS | 31110 | Values: 295.6 300.8 306.3 306.3 307.0 4810.4 4830.1 4834.7 4842.8 4860.0 4735.6 4754.6 4756.0 4768.1 4777.2 3579.0 3675.4 3695.9 3730.8 3735.5 3614.3 3684.6 3718.0 3754.4 3785.1 3704.0 3718.3 3726.7 3729.2 3732.3 3657.2 3707.1 3737.4 3741.5 3744.1 3316.2 3322.3 3326.6 3332.1 3342.3 4654.5 4661.4 4670.5 4676.3 4681.1 4293.0 4305.5 4307.3 4308.6 4311.4 4841.4 4884.4 4894.8 4954.7 4985.0 3590.7 3592.6 3592.9 3596.6 3604.6 5219.3 5226.6 5255.2 5262.8 5266.9 3599.1 3687.2 3696.5 3702.4 3717.5 3747.4 3775.3 3790.6 3791.1 3794.4 4258.7 4268.6 4278.1 4288.1 4303.4 4813.9 4980.0 4981.4 4995.2 5059.8 1302.2 1311.0 1317.4 1326.2 1327.8 824.8 848.5 859.2 864.4 866.0 3955.2 4207.0 4296.7 4351.5 4430.3 5047.9 5111.5 5150.7 5152.7 5158.7 4360.9 4365.6 4431.4 4449.6 4463.2 2648.9 2682.4 2714.7 2726.7 2739.2 4746.0 4759.9 4775.7 4778.3 4787.8 5230.1 5233.8 5243.5 5249.9 5250.7 4686.0 4795.4 4795.9 4809.0 4830.5 5117.6 5149.7 5157.7 5159.4 5180.5 5048.6 5057.7 5064.8 5066.7 5070.4 4602.6 4775.7 4784.0 4803.0 4807.5 3754.2 3765.0 3773.8 3779.3 3795.8 5083.5 5114.6 5156.3 5173.7 5186.9 4720.0 4970.7 5019.8 5041.3 5055.8 5030.4 5037.4 5039.9 5042.1 5047.3 4971.5 4977.7 4979.7 4984.8 4989.8 4782.9 4920.2 4939.6 4989.6 5035.3 4796.9 4916.0 4949.0 4953.4 4960.6 04:56:15 INFO - PROCESS | 31110 | 04:56:15 INFO - PROCESS | 31110 | [#5] yui.html Cycles:180 Average:17922.39 Median:23107.05 stddev:26426.97 (114.4%) stddev-sans-first:26468.91 04:56:15 INFO - PROCESS | 31110 | Values: 551.0 560.5 574.6 600.6 624.6 12062.9 12464.3 12490.9 13083.8 13093.5 12216.1 12457.6 12493.6 12497.1 12506.7 629.8 647.8 757.0 777.2 779.4 758.5 776.8 783.9 785.2 786.4 828.0 830.4 830.7 830.7 831.0 655.8 816.7 819.9 820.6 821.1 492.5 578.6 591.3 595.0 596.8 12187.4 12188.2 12189.0 12202.7 12222.5 11792.4 12055.5 12093.9 12960.6 13544.9 11540.4 11922.6 12045.9 12104.6 12110.1 4149.5 4241.5 4284.3 4301.6 4432.8 56515.0 68271.7 68563.3 68782.3 68815.0 9934.9 9984.2 9997.8 10069.8 10121.6 17672.8 18719.3 18930.7 18973.2 18978.9 6794.2 6893.6 6952.6 6962.7 7028.2 3536.6 3584.4 3670.2 3714.3 3755.2 2920.6 3027.1 3067.6 3069.8 3071.8 515.6 516.4 522.6 525.1 526.2 546.2 552.8 553.4 566.9 573.6 7618.8 7647.3 7715.8 7827.3 8074.5 455.2 516.2 555.7 559.5 592.5 3945.8 3984.9 4138.5 4163.4 4256.6 100286.0 102466.0 103922.0 105656.0 105940.0 88099.0 88601.0 89724.6 90531.0 94374.5 77318.6 79693.0 80415.2 80476.0 81331.0 7725.8 7888.8 8030.8 8045.5 8270.8 37550.0 37859.0 39385.4 41102.2 41703.8 40111.8 45721.6 57972.0 60648.0 65354.7 11391.9 11511.5 11657.9 11673.1 11835.1 11571.5 11994.3 12205.2 12323.7 12529.7 11200.6 11442.6 11517.7 12039.0 12078.5 10193.1 10287.7 10323.1 11291.5 11548.7 11497.8 11564.1 11884.1 12652.9 12704.0 9303.4 9502.9 9726.5 9871.4 10437.8 9190.4 9856.5 9945.2 9985.8 9987.2 04:56:15 INFO - PROCESS | 31110 | -------- Summary: end -------- 04:56:15 INFO - PROCESS | 31110 | 04:56:16 INFO - TEST-INFO | 31110: exit 0 04:56:16 INFO - TEST-OK | dromaeo_css | took 1121794ms 04:56:16 INFO - TEST-START | kraken 04:56:16 INFO - operating with platform_type : linux_ 04:56:16 INFO - Initialising browser for kraken test... 04:56:16 INFO - TEST-INFO | started process 31415 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdU3hNg/profile http://localhost:50291/getInfo.html) 04:56:21 INFO - PROCESS | 31415 | __metrics Screen width/height:1600/1200 04:56:21 INFO - PROCESS | 31415 | colorDepth:24 04:56:21 INFO - PROCESS | 31415 | Browser inner width/height: 1024/697 04:56:21 INFO - PROCESS | 31415 | __metrics 04:56:21 INFO - PROCESS | 31415 | 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" 04:56:21 INFO - PROCESS | 31415 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:56:22 INFO - PROCESS | 31415 | console.error: PushService: 04:56:22 INFO - PROCESS | 31415 | stateChangeProcessEnqueue: Error transitioning state 04:56:22 INFO - PROCESS | 31415 | UnknownError 04:56:23 INFO - TEST-INFO | 31415: exit 0 04:56:23 INFO - Browser initialized. 04:56:23 INFO - Running cycle 1/1 for kraken test... 04:56:23 INFO - TEST-INFO | started process 31498 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdU3hNg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:56:35 INFO - PROCESS | 31498 | RSS: Main: 176181248 04:56:35 INFO - PROCESS | 31498 | 04:56:38 INFO - PROCESS | 31498 | Cycle 1(1): loaded http://localhost:50291/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50291/tests/kraken/driver.html?testName=audio-beat-detection) 04:56:38 INFO - PROCESS | 31498 | RSS: Main: 234778624 04:56:38 INFO - PROCESS | 31498 | 04:56:41 INFO - PROCESS | 31498 | Cycle 1(1): loaded http://localhost:50291/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50291/tests/kraken/driver.html?testName=audio-dft) 04:56:42 INFO - PROCESS | 31498 | RSS: Main: 218406912 04:56:42 INFO - PROCESS | 31498 | 04:56:45 INFO - PROCESS | 31498 | Cycle 1(1): loaded http://localhost:50291/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50291/tests/kraken/driver.html?testName=audio-fft) 04:56:46 INFO - PROCESS | 31498 | RSS: Main: 300396544 04:56:46 INFO - PROCESS | 31498 | 04:56:48 INFO - PROCESS | 31498 | Cycle 1(1): loaded http://localhost:50291/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50291/tests/kraken/driver.html?testName=audio-oscillator) 04:56:49 INFO - PROCESS | 31498 | RSS: Main: 209608704 04:56:49 INFO - PROCESS | 31498 | 04:56:51 INFO - PROCESS | 31498 | Cycle 1(1): loaded http://localhost:50291/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50291/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:56:51 INFO - PROCESS | 31498 | RSS: Main: 214618112 04:56:51 INFO - PROCESS | 31498 | 04:56:55 INFO - PROCESS | 31498 | Cycle 1(1): loaded http://localhost:50291/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50291/tests/kraken/driver.html?testName=imaging-darkroom) 04:56:55 INFO - PROCESS | 31498 | RSS: Main: 251564032 04:56:55 INFO - PROCESS | 31498 | 04:56:59 INFO - PROCESS | 31498 | Cycle 1(1): loaded http://localhost:50291/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50291/tests/kraken/driver.html?testName=imaging-desaturate) 04:56:59 INFO - PROCESS | 31498 | RSS: Main: 244858880 04:56:59 INFO - PROCESS | 31498 | 04:57:02 INFO - PROCESS | 31498 | Cycle 1(1): loaded http://localhost:50291/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50291/tests/kraken/driver.html?testName=json-parse-financial) 04:57:03 INFO - PROCESS | 31498 | RSS: Main: 248053760 04:57:03 INFO - PROCESS | 31498 | 04:57:05 INFO - PROCESS | 31498 | Cycle 1(1): loaded http://localhost:50291/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50291/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:57:05 INFO - PROCESS | 31498 | RSS: Main: 211161088 04:57:05 INFO - PROCESS | 31498 | 04:57:07 INFO - PROCESS | 31498 | Cycle 1(1): loaded http://localhost:50291/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50291/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:57:08 INFO - PROCESS | 31498 | RSS: Main: 218660864 04:57:08 INFO - PROCESS | 31498 | 04:57:10 INFO - PROCESS | 31498 | Cycle 1(1): loaded http://localhost:50291/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50291/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:57:11 INFO - PROCESS | 31498 | RSS: Main: 222838784 04:57:11 INFO - PROCESS | 31498 | 04:57:13 INFO - PROCESS | 31498 | Cycle 1(1): loaded http://localhost:50291/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:57:14 INFO - PROCESS | 31498 | RSS: Main: 223313920 04:57:14 INFO - PROCESS | 31498 | 04:57:17 INFO - PROCESS | 31498 | Cycle 1(1): loaded http://localhost:50291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:57:18 INFO - PROCESS | 31498 | RSS: Main: 222347264 04:57:18 INFO - PROCESS | 31498 | 04:57:19 INFO - PROCESS | 31498 | Cycle 1(1): loaded http://localhost:50291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50291/tests/kraken/driver.html?testName=ai-astar) 04:57:20 INFO - PROCESS | 31498 | RSS: Main: 272949248 04:57:20 INFO - PROCESS | 31498 | 04:57:20 INFO - PROCESS | 31498 | __start_tp_report 04:57:20 INFO - PROCESS | 31498 | _x_x_mozilla_page_load 04:57:20 INFO - PROCESS | 31498 | _x_x_mozilla_page_load_details 04:57:20 INFO - PROCESS | 31498 | |i|pagename|runs| 04:57:20 INFO - PROCESS | 31498 | |0;ai-astar;110;113;112;114;114;114;113;114;113;112 04:57:20 INFO - PROCESS | 31498 | |1;audio-beat-detection;159;132;129;175;127;127;127;129;162;126 04:57:20 INFO - PROCESS | 31498 | |2;audio-dft;163;162;163;162;162;163;163;162;162;161 04:57:20 INFO - PROCESS | 31498 | |3;audio-fft;76;77;77;111;76;76;77;76;109;77 04:57:20 INFO - PROCESS | 31498 | |4;audio-oscillator;84;84;134;86;86;85;120;85;86;115 04:57:20 INFO - PROCESS | 31498 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;118;117;116 04:57:20 INFO - PROCESS | 31498 | |6;imaging-darkroom;148;146;146;147;147;147;147;146;147;146 04:57:20 INFO - PROCESS | 31498 | |7;imaging-desaturate;94;95;96;94;95;95;95;96;94;95 04:57:20 INFO - PROCESS | 31498 | |8;json-parse-financial;64;63;64;63;64;65;64;68;63;63 04:57:20 INFO - PROCESS | 31498 | |9;json-stringify-tinderbox;66;67;67;68;67;68;67;68;67;68 04:57:20 INFO - PROCESS | 31498 | |10;stanford-crypto-aes;82;83;83;83;89;90;82;90;82;81 04:57:20 INFO - PROCESS | 31498 | |11;stanford-crypto-ccm;148;137;141;133;134;131;133;134;162;139 04:57:20 INFO - PROCESS | 31498 | |12;stanford-crypto-pbkdf2;178;183;175;171;172;178;176;170;172;172 04:57:20 INFO - PROCESS | 31498 | |13;stanford-crypto-sha256-iterative;72;71;69;71;72;70;73;70;70;70 04:57:20 INFO - PROCESS | 31498 | __end_tp_report 04:57:20 INFO - PROCESS | 31498 | __start_cc_report 04:57:20 INFO - PROCESS | 31498 | _x_x_mozilla_cycle_collect,1905 04:57:20 INFO - PROCESS | 31498 | __end_cc_report 04:57:20 INFO - PROCESS | 31498 | __startTimestamp1474977440116__endTimestamp 04:57:20 INFO - PROCESS | 31498 | 04:57:20 INFO - PROCESS | 31498 | ------- Summary: start ------- 04:57:20 INFO - PROCESS | 31498 | Number of tests: 14 04:57:20 INFO - PROCESS | 31498 | 04:57:20 INFO - PROCESS | 31498 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.50 stddev:1.29 (1.1%) stddev-sans-first:0.83 04:57:20 INFO - PROCESS | 31498 | Values: 110.0 113.0 112.0 114.0 114.0 114.0 113.0 114.0 113.0 112.0 04:57:20 INFO - PROCESS | 31498 | 04:57:20 INFO - PROCESS | 31498 | [#1] audio-beat-detection Cycles:10 Average:139.30 Median:130.50 stddev:18.48 (14.2%) stddev-sans-first:18.18 04:57:20 INFO - PROCESS | 31498 | Values: 159.0 132.0 129.0 175.0 127.0 127.0 127.0 129.0 162.0 126.0 04:57:20 INFO - PROCESS | 31498 | 04:57:20 INFO - PROCESS | 31498 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 04:57:20 INFO - PROCESS | 31498 | Values: 163.0 162.0 163.0 162.0 162.0 163.0 163.0 162.0 162.0 161.0 04:57:20 INFO - PROCESS | 31498 | 04:57:20 INFO - PROCESS | 31498 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.50 stddev:14.14 (18.5%) stddev-sans-first:14.76 04:57:20 INFO - PROCESS | 31498 | Values: 76.0 77.0 77.0 111.0 76.0 76.0 77.0 76.0 109.0 77.0 04:57:20 INFO - PROCESS | 31498 | 04:57:20 INFO - PROCESS | 31498 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:85.00 stddev:18.88 (22.2%) stddev-sans-first:19.48 04:57:20 INFO - PROCESS | 31498 | Values: 84.0 84.0 134.0 86.0 86.0 85.0 120.0 85.0 86.0 115.0 04:57:20 INFO - PROCESS | 31498 | 04:57:20 INFO - PROCESS | 31498 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 04:57:20 INFO - PROCESS | 31498 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 118.0 117.0 116.0 04:57:20 INFO - PROCESS | 31498 | 04:57:20 INFO - PROCESS | 31498 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.53 04:57:20 INFO - PROCESS | 31498 | Values: 148.0 146.0 146.0 147.0 147.0 147.0 147.0 146.0 147.0 146.0 04:57:20 INFO - PROCESS | 31498 | 04:57:20 INFO - PROCESS | 31498 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 04:57:20 INFO - PROCESS | 31498 | Values: 94.0 95.0 96.0 94.0 95.0 95.0 95.0 96.0 94.0 95.0 04:57:20 INFO - PROCESS | 31498 | 04:57:20 INFO - PROCESS | 31498 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.00 stddev:1.52 (2.4%) stddev-sans-first:1.62 04:57:20 INFO - PROCESS | 31498 | Values: 64.0 63.0 64.0 63.0 64.0 65.0 64.0 68.0 63.0 63.0 04:57:20 INFO - PROCESS | 31498 | 04:57:20 INFO - PROCESS | 31498 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.50 stddev:0.67 (1.0%) stddev-sans-first:0.53 04:57:20 INFO - PROCESS | 31498 | Values: 66.0 67.0 67.0 68.0 67.0 68.0 67.0 68.0 67.0 68.0 04:57:20 INFO - PROCESS | 31498 | 04:57:20 INFO - PROCESS | 31498 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:83.00 stddev:3.63 (4.4%) stddev-sans-first:3.73 04:57:20 INFO - PROCESS | 31498 | Values: 82.0 83.0 83.0 83.0 89.0 90.0 82.0 90.0 82.0 81.0 04:57:20 INFO - PROCESS | 31498 | 04:57:20 INFO - PROCESS | 31498 | [#11] stanford-crypto-ccm Cycles:10 Average:139.20 Median:138.00 stddev:9.45 (6.8%) stddev-sans-first:9.47 04:57:20 INFO - PROCESS | 31498 | Values: 148.0 137.0 141.0 133.0 134.0 131.0 133.0 134.0 162.0 139.0 04:57:20 INFO - PROCESS | 31498 | 04:57:20 INFO - PROCESS | 31498 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.70 Median:175.50 stddev:4.08 (2.3%) stddev-sans-first:4.15 04:57:20 INFO - PROCESS | 31498 | Values: 178.0 183.0 175.0 171.0 172.0 178.0 176.0 170.0 172.0 172.0 04:57:20 INFO - PROCESS | 31498 | 04:57:20 INFO - PROCESS | 31498 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:1.23 (1.7%) stddev-sans-first:1.22 04:57:20 INFO - PROCESS | 31498 | Values: 72.0 71.0 69.0 71.0 72.0 70.0 73.0 70.0 70.0 70.0 04:57:20 INFO - PROCESS | 31498 | -------- Summary: end -------- 04:57:20 INFO - PROCESS | 31498 | 04:57:21 INFO - TEST-INFO | 31498: exit 0 04:57:21 INFO - TEST-OK | kraken | took 64824ms 04:57:21 INFO - SUITE-END | took 1186s 04:57:21 INFO - Completed test suite (00:19:46) 04:57:21 INFO - javascript benchmark 04:57:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2590.676165479315, 2613.333599932017, 2645.973540264597, 2655.070725246164, 2670.8531030793297, 4641.25739881619, 4712.175369310366, 4733.934864655451, 4760.500147484512, 4853.2720091986175, 4740.241561350184, 4741.336212930192, 4776.785044672989, 4808.855734327967, 4844.66087373884, 4325.870223893288, 4336.0, 4381.671374646899, 4401.141777353418, 4404.515503294635, 4451.5993560579545, 4499.707519011254, 4500.356656507369, 4506.8422605208825, 4522.932156017662, 4303.483581970152, 4390.121975604892, 4403.889902752425, 4419.756913369763, 4490.461144662645, 4329.783510824478, 4352.825886964518, 4360.345948107777, 4378.408914796493, 4421.668374871898, 4324.891877703051, 4325.070109926381, 4334.068175342285, 4380.846670366522, 4398.3622374755805, 4727.929081063787, 4737.336772851803, 4758.405199350082, 4778.259369797652, 4786.64100192487, 4934.876628084291, 4988.077205716918, 5006.299118123466, 5048.419431765357, 5102.311187989611, 5079.542841144278, 5081.136206844808, 5092.719900405476, 5140.845774626767, 5156.097682905514, 4728.739919304402, 4743.359646447754, 4744.881377965578, 4747.264174053027, 4816.638752093607, 5041.773120209599, 5081.415637201695, 5179.533841954242, 5265.736713164327, 5270.420253772082, 4920.434150072788, 5011.4487406386, 5060.063888180698, 5063.670861394071, 5143.71709555978, 5160.380754309432, 5168.2764412982215, 5170.069387510284, 5172.19830926207, 5173.1722924331925, 5070.112730272188, 5070.61970352225, 5113.948860511347, 5118.232265160255, 5164.406093299243, 4856.975715121402, 4921.409430868319, 4927.704337739747, 4997.175466048134, 5143.254228136899, 4287.249731297011, 4298.333758267411, 4338.392625032498, 4344.196323680129, 4401.053773438726, 3766.0961369271176, 3773.867914622975, 3778.6221377861993, 3820.1595648957186, 3828.885133446001, 4372.060007098426, 4379.4525684289465, 4381.18947994622, 4385.188740083031, 4434.933475997863, 4976.825811096666, 5024.472430394829, 5033.245013247969, 5057.974710126426, 5076.543111120017, 4348.130373925228, 4350.2387082260475, 4402.361657559636, 4410.16206920684, 4411.228035093845, 4558.0655965526985, 4584.083183363341, 4593.448786145684, 4638.884027899329, 4643.558861908114, 4621.768911554476, 4698.859034228979, 4745.857624271277, 4756.952430475721, 4817.759112044314, 4995.225740010304, 5032.370953630796, 5063.898722025465, 5086.135356989246, 5086.160783470686, 4685.718856868599, 4687.835925742719, 4696.4599071105895, 4763.428388593391, 4764.30917516965, 4950.801967921387, 4953.975230123826, 4954.77703503336, 4955.603551715926, 5015.899682006412, 4874.561289483963, 4941.456439791692, 4955.430125535466, 5046.747662616781, 5087.033463641897, 4841.491643377535, 4854.73298968546, 4880.048390563948, 4954.232094025432, 4960.627952903475, 4873.390826146731, 4900.313956046085, 4911.435184953776, 4914.311996320446, 4964.131277026434, 4708.199606067045, 4806.49531799156, 4849.151398505177, 4877.975610121926, 4921.434035085867, 4883.560479556857, 4918.754062296943, 4950.603951683928, 4952.108620448354, 5010.198368261061, 4804.663673542818, 4838.322634831056, 4839.540243676845, 4845.830395936126, 4908.779104940215], "value": 4656.259505749869, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.282204545114, 569.0951387294202, 573.5096492498916, 577.3677822784052, 580.3355158343696, 28561.714382856164, 38877.80561097194, 40194.39708404369, 40372.0, 44393.0, 41305.79347103268, 41883.58116418835, 41932.790336048274, 41934.37098443518, 41960.370594441105, 7329.596872172028, 7524.661390237453, 7655.578943158124, 7677.270659287359, 7688.231176882323, 7307.415406767446, 9710.805783884318, 9933.900660993406, 9978.052085051908, 10305.381677099398, 9930.404175749441, 9934.950325248363, 9956.103950644441, 9959.153471954856, 10053.296269261155, 9881.95059024704, 9955.05426984439, 10006.799864002753, 10019.246631839473, 10020.599176033023, 9792.0, 9892.703218903373, 9894.10953014225, 9896.564998075239, 9898.80202395948, 37772.81113594415, 38162.0, 38258.23483530342, 38286.23427531434, 38298.0, 2952.7342539171577, 3127.3276245607076, 3303.306305675787, 3323.96676033239, 3579.6599323064265, 25996.480070398677, 27934.720652793414, 28481.287967800763, 28546.429071418665, 28582.857085714437, 3515.3145136698354, 3544.3974524330924, 3558.6085530591613, 3727.9813600932093, 3743.681787048104, 254579.0, 255642.0, 255833.0, 256446.0, 256646.0, 31025.68974310228, 53890.73054634702, 54213.72893135588, 54296.185557216675, 54327.03603905311, 31674.524882126785, 33828.661713383044, 33831.66168338335, 33852.32295354079, 33853.32293354119, 12870.806937895939, 12940.417681204368, 12984.545540906023, 12999.09006369564, 13036.41336139857, 9373.0, 9582.952085239669, 10744.14046876248, 10819.080378167786, 10820.458977051116, 7352.742654007191, 7418.480706350611, 7426.777196684108, 7518.812029699301, 7780.8832867507035, 2975.523916173402, 3022.9395412092076, 3026.9243268918012, 3047.588575542318, 3107.502799552061, 838.6058552480324, 867.2108381372921, 877.4998250996871, 897.9146981036791, 971.3297824501071, 26632.866835665696, 27229.0, 27814.0, 27844.16467505978, 27855.442891142062, 920.2040235196507, 976.8876579193342, 995.0, 1035.2028937717914, 1035.30634474902, 14206.560173155822, 14856.108633482027, 14863.851361486462, 14896.553103406915, 14945.317160469234, 116849.41575292069, 410745.0, 417260.0, 418135.0, 623778.0, 49045.50954490481, 49149.0, 49188.7540562302, 49221.261681074815, 49317.26024109641, 1073.1575713065051, 1094.9124070074533, 1165.4056431220138, 1178.8644305904932, 1184.265755231762, 25560.616590751524, 29483.85258073696, 31067.689323107385, 31542.0, 31817.522737159423, 46800.7659961698, 47550.28674569954, 47681.28478072762, 47706.0, 47736.28395574, 342211.0, 344432.0, 345334.0, 345505.0, 346059.0, 21811.454713632287, 22350.888245558668, 22498.66252006254, 25545.61681574815, 25883.0, 35023.29953400969, 35184.472232916014, 39525.40711889266, 41727.16545669009, 41997.79001105097, 35688.286234275685, 35749.46375804313, 35824.28351433009, 35998.0, 36024.099397515274, 35300.29399411946, 35430.46854297136, 35764.284714306086, 35953.101172470895, 36021.45967810538, 35167.824160879034, 35249.1187720309, 35945.460818087224, 36114.63885361218, 36404.27191456209, 30221.69778302189, 32430.0, 32493.025209243762, 32966.0, 33066.504002440466, 24558.0, 25003.87498062498, 25559.0, 25856.48287034211, 26050.609240861024], "value": 16836.9628482607, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.9758516903818, 362.6192497877228, 364.14971042615485, 372.9757565758226, 389.58509187715083, 12509.562165324203, 12656.367876848433, 13994.650133746649, 14500.564983050499, 17341.653166936652, 16674.33302667895, 16728.247228874698, 17275.654486910254, 17396.913015434904, 17432.56418589536, 4855.732934688591, 5072.137736584771, 5141.974290128563, 5150.1759718445055, 5151.4333423323405, 3677.8712745053926, 5080.41575218849, 5158.303629010074, 5164.896702065957, 5174.508421699951, 3846.8076596170217, 3913.7651740895494, 3950.2494526040105, 6009.549283803733, 6111.969440152793, 5902.557308201859, 6103.298120716108, 6105.81682549522, 6107.4808641265545, 6116.418940200674, 5343.064963631349, 5367.946320536823, 5375.0, 5375.731213439312, 5377.354717433933, 20558.69161962572, 20663.27678531259, 20674.793252067437, 20859.37421877346, 21022.474438139016, 1743.4943866278763, 1810.185416562552, 1891.0828248299563, 1907.437305994735, 1979.1094007696595, 8760.21158095768, 8949.284057275403, 9111.681091161843, 9445.386049906734, 9589.376690515164, 1617.5632579203666, 1660.767492551044, 1683.8400351966543, 1691.2727527163315, 1716.3048965169125, 64554.0, 64712.55805582371, 65824.67087664531, 67171.32828671699, 68157.65921170362, 9536.28477864163, 9785.510724463747, 9795.363301385387, 9951.476930303606, 10181.949090254502, 13175.60473185806, 13194.142380745221, 13260.53588124411, 13278.601641950758, 13358.933205333911, 6970.302969702989, 7293.854122917618, 7322.560646361236, 7431.29402706742, 7459.365953893871, 6518.804435866931, 6763.628000459924, 6858.947768243084, 7130.643467826588, 7151.749688760972, 4088.5707000765087, 4227.830886764495, 4284.592963668447, 4350.325699516517, 4352.651787856964, 1736.8957862528036, 1795.317779243879, 1823.589692319244, 1839.6412699523464, 1866.9719954200698, 820.6471217376585, 827.7392621324263, 842.3513894301353, 888.7422647432302, 933.332667142996, 15985.680286394207, 16670.249838757285, 17083.40208092711, 17291.0, 17625.647487050188, 831.6839600951721, 838.5723281126669, 844.27814218842, 857.511218605389, 859.1923591823665, 9117.77205569866, 9905.653302134391, 10025.498725063717, 10367.740806479898, 10464.854704785654, 354281.0, 360522.0, 373785.0, 375988.0, 377201.0, 51523.0, 58465.0, 80266.0, 80784.59607701923, 81960.18039819645, 907.6414816147585, 925.134998776133, 944.1219665710955, 946.1815529566875, 949.4872768704822, 15220.162891041098, 15591.76612350793, 16208.918955405148, 16463.259153337887, 16484.752728708838, 33785.0, 36447.0, 39555.163775629764, 39739.0, 40711.389329159494, 46442.53557464382, 46947.765261173474, 48824.0, 52806.2079068822, 55899.441005589426, 6223.0, 6450.612963222222, 6669.1330127083165, 6866.0, 7064.894026589708, 8820.382573219813, 10778.461076946278, 11119.221654484109, 11260.94369528147, 11518.769624607628, 9819.9018009819, 10206.234532410248, 10246.23153263523, 10388.11701005423, 10705.0, 10039.297249192487, 10155.238357123097, 10341.0, 10386.688399348031, 10400.531976061247, 9507.477088759908, 9945.950270248602, 10139.695809125738, 10321.793564128826, 10796.0, 6904.482163837632, 7033.683484243119, 7060.258672839484, 7127.714891404493, 7134.750283740044, 9332.440053596805, 10129.058660305276, 10248.948755256177, 10320.535575899252, 10350.844737328796], "value": 8008.782386840858, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1352.966175845604, 1399.174487052639, 1462.195792314227, 1597.5287290249375, 1683.6464342488084, 7021.508494405393, 7276.0, 7543.773686789398, 8183.0, 8192.795180120493, 7643.350315223212, 7808.92191078089, 7879.133295337509, 8159.510429374227, 8163.510189388641, 2118.184498967893, 2133.5412886229456, 2144.15305954148, 2146.2702681088426, 2152.0638522242875, 1760.489458057162, 1859.0333026826042, 1965.547923977486, 2126.7447906251195, 2167.1223154622403, 1989.870658407206, 2029.9797002029939, 2032.9186832526755, 2032.928847490338, 2038.918443262275, 2091.5816836632657, 2096.517800905785, 2099.1078791513696, 2102.873827570351, 2134.967975480369, 2117.7035215069905, 2123.6283650361124, 2124.2989813361555, 2126.8830214338204, 2127.2767259131815, 7963.721269755531, 8031.518108913484, 8033.1565185655245, 8039.477433966774, 8064.0, 4484.596386325246, 4490.640748740093, 4555.726656400627, 4559.156556037144, 4563.840265590688, 2809.90165344212, 2947.336849208932, 2984.8955286565083, 2999.7150270724246, 3007.548867669845, 866.9393142480029, 880.300161371711, 881.180502133016, 886.609891647673, 900.3472482450237, 11001.889981100167, 11062.22564420491, 11071.99999999992, 11086.889131108746, 11197.27217730853, 3900.356441187229, 4101.85643502476, 4167.666586673059, 4227.175700738388, 4228.88555722139, 9308.581113849894, 9330.393524420891, 9336.95331523338, 9342.205912497513, 9346.57940392684, 4547.363369128325, 4550.249208880564, 4552.795124219418, 4553.772311384484, 4555.339475775994, 4038.8788336349958, 4156.667466602665, 4162.167566486654, 4163.791810409467, 4172.290710579209, 3646.538586454186, 3679.5400574928135, 3750.4936833527127, 3812.866549670748, 3814.6948244140403, 1041.6406339812752, 1089.54239219528, 1129.9830502542468, 1172.5309876049648, 1197.4312201704122, 643.9517036222302, 778.4434129597252, 821.5399376349263, 841.389992255622, 845.5772113943028, 5158.535731784157, 5250.343707036621, 5265.578753699695, 5377.247185394048, 5402.783888644489, 815.233680340478, 855.1192271959891, 871.1549796697194, 880.6609455359604, 895.7178488776015, 3543.7519373644113, 3548.929021419557, 3612.3678356287546, 3631.963680363215, 3875.612438756158, 9901.405915645084, 10062.496875156214, 10076.3954162749, 10086.243531735003, 10165.745856353651, 9911.355761875455, 10022.74943126413, 10034.899651003543, 10043.899561004442, 10049.497525123714, 7404.703811847466, 7591.8861217081785, 7618.352440042548, 7620.314171724572, 7623.69505219785, 5317.308749862493, 5353.250544923636, 5449.0, 5450.754716037709, 5561.63849349791, 8703.695370661997, 8997.55012249398, 9012.729618111467, 9163.266938645025, 9310.627574896927, 9191.264698823945, 9295.907040929775, 9315.441073535609, 9326.580303886478, 9407.623695052122, 6694.966525167343, 6847.589144651337, 6850.588964662136, 6867.283179205198, 7059.505834591735, 7397.112346518452, 7534.698612055457, 7536.849263014599, 7538.773836784905, 7541.472096953161, 6805.89791153143, 6855.280195579592, 6884.4148247399535, 7129.0, 7132.607706576188, 6486.383793539606, 6516.967415162894, 6618.371254730793, 6632.767853125118, 6647.6676166192465, 6058.787942421994, 6176.166217560752, 6181.165542651865, 6184.536159788124, 6194.442500175006, 4288.678349123766, 4415.646748260196, 4437.911241775211, 4514.0, 4521.751303678329, 4417.889552761207, 4442.911141777082, 4471.128130014616, 4499.932501012422, 4516.232240519054], "value": 4128.156736949474, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.55666500249623, 300.81800510691033, 306.29246440721926, 306.3016322784052, 307.0404984423676, 4810.39870016248, 4830.058138662957, 4834.685745426545, 4842.75786210689, 4859.951400485994, 4735.5974742146955, 4754.573627911622, 4755.952440475594, 4768.141734487791, 4777.235642297233, 3578.9821050894775, 3675.44868269759, 3695.870644527429, 3730.7501986834445, 3735.533058367704, 3614.34941710492, 3684.5578530576236, 3717.9814100929593, 3754.361758501048, 3785.129420233348, 3703.9814800925956, 3718.2563487302646, 3726.6646001859826, 3729.1982223821874, 3732.3095227382887, 3657.231981283907, 3707.1473561080966, 3737.4020156774923, 3741.4761933329355, 3744.0826997385543, 3316.2372654289406, 3322.302316513535, 3326.550915626384, 3332.100332910125, 3342.331533693271, 4654.534546545352, 4661.417322834645, 4670.486246512881, 4676.298555216711, 4681.0871879983415, 4292.991147080434, 4305.526392096866, 4307.267764480046, 4308.590683885026, 4311.353297005474, 4841.419029716421, 4884.438289596706, 4894.804207831682, 4954.653174277802, 4985.0, 3590.694790942773, 3592.586852511942, 3592.892213233607, 3596.62235465275, 3604.567451905788, 5219.347581552306, 5226.608004399647, 5255.159174532057, 5262.842114736564, 5266.894662106774, 3599.136207310279, 3687.1703866629796, 3696.5194524711615, 3702.407614781676, 3717.4572552390996, 3747.4191500317493, 3775.2826962876966, 3790.639889210521, 3791.109089363997, 3794.4118661607495, 4258.701890867609, 4268.615824575803, 4278.144371125787, 4288.120935208275, 4303.354496825501, 4813.879653008703, 4980.0, 4981.427135879348, 4995.150824359867, 5059.822906198266, 1302.160106731153, 1310.960671179866, 1317.367663521515, 1326.1777697827215, 1327.7809161488246, 824.8286070427004, 848.5078654380444, 859.1537335724306, 864.3690106222493, 865.9696910608099, 3955.169414422946, 4207.0, 4296.720713153698, 4351.456067991501, 4430.291153415438, 5047.899042019139, 5111.488851114858, 5150.690958542499, 5152.6650767699975, 5158.710322419395, 4360.9127817444105, 4365.628921541641, 4431.446069241345, 4449.555044495589, 4463.218936686132, 2648.8940442382473, 2682.4366882954796, 2714.67894949819, 2726.740959608834, 2739.1919383781833, 4745.95254047462, 4759.928601070987, 4775.6657034007285, 4778.259369797687, 4787.760611969387, 5230.08473517133, 5233.816816411483, 5243.501867322599, 5249.921251181236, 5250.684958902478, 4685.976570117127, 4795.424549054136, 4795.928061079087, 4808.9519104808505, 4830.492798256273, 5117.5650069743, 5149.69101853875, 5157.716325602128, 5159.380874294959, 5180.533751962342, 5048.621353398436, 5057.74711264428, 5064.772085256246, 5066.746662666926, 5070.41690205631, 4602.585767280961, 4775.71055814935, 4783.95216047835, 4803.0, 4807.519248075165, 3754.2491501700315, 3764.9834544672235, 3773.8490460382377, 3779.281936432069, 3795.8102094894593, 5083.517065878736, 5114.616403769658, 5156.2671783954565, 5173.741312934413, 5186.948130518646, 4719.976400118115, 4970.652054356305, 5019.84940451787, 5041.269015992734, 5055.848324550269, 5030.446650868328, 5037.395512538519, 5039.949600504095, 5042.14283571801, 5047.318611987482, 4971.458847757207, 4977.676451030671, 4979.651424400257, 4984.775685094107, 4989.750512474289, 4782.904341913212, 4920.163572192664, 4939.629527785359, 4989.575886049726, 5035.29505869186, 4796.880077998078, 4915.95084049155, 4948.975255123702, 4953.380827396575, 4960.578350840219], "value": 3779.742829004577, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.9531689806365, 560.4815545620302, 574.6264927796929, 600.5735927491481, 624.5596854217777, 12062.879371206285, 12464.314462704548, 12490.937545312283, 13083.803742943863, 13093.54172603959, 12216.083793715485, 12457.626271211879, 12493.625191244255, 12497.06272029597, 12506.749865002694, 629.7638385605399, 647.795944277551, 757.046121886423, 777.1567848883967, 779.3842864137325, 758.5297115788219, 776.8329809091044, 783.8667426537502, 785.1677222144546, 786.3866184376195, 827.9586020698971, 830.3979614779267, 830.730012745857, 830.7424698343502, 831.0152469323871, 655.8229278094888, 816.6814942172557, 819.9098099209082, 820.5979070255592, 821.0721884270796, 492.49519242776086, 578.5949835115393, 591.3288417646003, 594.9524038076944, 596.84780381003, 12187.39063046844, 12188.20776649515, 12189.0, 12202.694932626666, 12222.511099556006, 11792.351420671945, 12055.457504412234, 12093.939530302292, 12960.611181664472, 13544.864551354558, 11540.422978851024, 11922.642320730392, 12045.879541204564, 12104.576339828152, 12110.091743119301, 4149.543550209474, 4241.49102107746, 4284.3145096784365, 4301.5913488218885, 4432.800523976396, 56515.0, 68271.65864170647, 68563.31436685669, 68782.31217687808, 68815.0, 9934.850977235346, 9984.15134713543, 9997.750056248651, 10069.798604028025, 10121.595136194617, 17672.823271767375, 18719.344822931133, 18930.716039259423, 18973.241070357308, 18978.905105474383, 6794.184697836291, 6893.586384816927, 6952.617606031616, 6962.721491140399, 7028.226895041541, 3536.575610926654, 3584.444411116281, 3670.15586415126, 3714.312852122366, 3755.230177813596, 2920.6495220573665, 3027.061610900628, 3067.585875906724, 3069.754419646423, 3071.8156910585435, 515.6081378152631, 516.4267662894184, 522.6263221796434, 525.1282870435059, 526.194921769693, 546.1698218707543, 552.8313864271355, 553.3691591585515, 566.940471250521, 573.6357413042748, 7618.771436856792, 7647.349975252055, 7715.807104822425, 7827.334676552443, 8074.515529068275, 455.2374772256457, 516.1586613819525, 555.7110302642603, 559.527199516408, 592.4934181274948, 3945.82243799024, 3984.880453586397, 4138.503379594407, 4163.377861260723, 4256.616904478612, 100286.0, 102466.0, 103922.0, 105656.0, 105940.0, 88099.0, 88601.0, 89724.5513772427, 90531.0, 94374.5281273603, 77318.6134069326, 79693.0, 80415.19584804194, 80476.0, 81331.0, 7725.845483090419, 7888.7633370998965, 8030.799230019296, 8045.477043992122, 8270.83458330842, 37550.0, 37859.0, 39385.40921886117, 41102.1779564413, 41703.7914810424, 40111.81131343537, 45721.59897614403, 57972.0, 60648.0, 65354.67322663356, 11391.886081139082, 11511.481983310603, 11657.941710291394, 11673.066154707432, 11835.112366572714, 11571.479283432098, 11994.280343179436, 12205.20666156697, 12323.69190770238, 12529.749405012031, 11200.615264758535, 11442.599509017144, 11517.654470365902, 12039.03687704999, 12078.456469459072, 10193.133583645473, 10287.691369258935, 10323.122534584645, 11291.491882865126, 11548.711282217675, 11497.770044599229, 11564.074874009892, 11884.10869184832, 12652.936735316265, 12704.047196460118, 9303.441793492411, 9502.857457138287, 9726.513674316115, 9871.40771553709, 10437.843432348673, 9190.356675032683, 9856.457894815567, 9945.154661853823, 9985.800283994426, 9987.151092157248], "value": 6499.386719394489, "unit": "score"}], "name": "dromaeo_css", "value": 6319.281186617823, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 112.0, 114.0, 114.0, 114.0, 113.0, 114.0, 113.0, 112.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 132.0, 129.0, 175.0, 127.0, 127.0, 127.0, 129.0, 162.0, 126.0], "value": 139.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 162.0, 162.0, 163.0, 163.0, 162.0, 162.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 111.0, 76.0, 76.0, 77.0, 76.0, 109.0, 77.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 134.0, 86.0, 86.0, 85.0, 120.0, 85.0, 86.0, 115.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 63.0, 64.0, 65.0, 64.0, 68.0, 63.0, 63.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 68.0, 67.0, 68.0, 67.0, 68.0, 67.0, 68.0], "value": 67.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 83.0, 83.0, 89.0, 90.0, 82.0, 90.0, 82.0, 81.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 137.0, 141.0, 133.0, 134.0, 131.0, 133.0, 134.0, 162.0, 139.0], "value": 139.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 183.0, 175.0, 171.0, 172.0, 178.0, 176.0, 170.0, 172.0, 172.0], "value": 174.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 69.0, 71.0, 72.0, 70.0, 73.0, 70.0, 70.0, 70.0], "value": 70.8, "unit": "score"}], "name": "kraken", "value": 1553.2, "alertThreshold": 2.0}]} 04:57:21 INFO - Return code: 0 04:57:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:57:21 INFO - # TBPL SUCCESS # 04:57:21 INFO - Running post-action listener: _resource_record_post_action 04:57:21 INFO - [mozharness: 2016-09-27 11:57:21.903328Z] Finished run-tests step (success) 04:57:21 INFO - Running post-run listener: _resource_record_post_run 04:57:21 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401870848; Read time: 8; Write time: 298248 04:57:21 INFO - TinderboxPrint: CPU usage
13.0% 04:57:21 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 04:57:21 INFO - TinderboxPrint: I/O write bytes / time
401,870,848 / 298,248 04:57:21 INFO - TinderboxPrint: CPU idle
8,349.2 (87.0%) 04:57:21 INFO - TinderboxPrint: CPU user
1,200.4 (12.5%) 04:57:21 INFO - TinderboxPrint: Swap in / out
0 / 0 04:57:21 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99893248; Read time: 0; Write time: 87028 04:57:21 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 290578432; Read time: 0; Write time: 208984 04:57:22 INFO - Running post-run listener: _upload_blobber_files 04:57:22 INFO - Blob upload gear active. 04:57:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:57:22 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 04:57:22 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'] 04:57:22 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 04:57:22 INFO - (blobuploader) - INFO - Open directory for files ... 04:57:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:57:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:57:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:24 INFO - (blobuploader) - INFO - Done attempting. 04:57:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:57:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:57:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:25 INFO - (blobuploader) - INFO - Done attempting. 04:57:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:57:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:57:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:32 INFO - (blobuploader) - INFO - Done attempting. 04:57:32 INFO - (blobuploader) - INFO - Iteration through files over. 04:57:32 INFO - Return code: 0 04:57:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:57:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:57:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/55712f197ce16eee779c6e4fece86ff0a39d245843b1f32e0ce91c0631a3f52a680d783c40065c3cd982022b1455a166fd22eb2f785734527f3342c21b18a9a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1e6d230c81021e5654c2a53906a13355fc2632deb51023d8120d9f07443a28f3749e7dccfd51a57d0266392bc8e484ef6d013c01fbd3b62afa80e1c0a668a47c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d448b3dcd53a5810b7fcb80eb766a97aceaddc4087498af3ba86035153b49cc352cff0d828ca12e52e93005d122e7f977fcb8e36fb894e2f581c93e5b23f130c"} 04:57:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:57:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:57:32 INFO - Contents: 04:57:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/55712f197ce16eee779c6e4fece86ff0a39d245843b1f32e0ce91c0631a3f52a680d783c40065c3cd982022b1455a166fd22eb2f785734527f3342c21b18a9a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1e6d230c81021e5654c2a53906a13355fc2632deb51023d8120d9f07443a28f3749e7dccfd51a57d0266392bc8e484ef6d013c01fbd3b62afa80e1c0a668a47c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d448b3dcd53a5810b7fcb80eb766a97aceaddc4087498af3ba86035153b49cc352cff0d828ca12e52e93005d122e7f977fcb8e36fb894e2f581c93e5b23f130c"} 04:57:32 INFO - Running post-run listener: copy_logs_to_upload_dir 04:57:32 INFO - Copying logs to upload dir... 04:57:32 INFO - mkdir: /builds/slave/test/build/upload/logs 04:57:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.473231 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-09-27 04:57:31.278718) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 04:57:31.282558) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442 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/55712f197ce16eee779c6e4fece86ff0a39d245843b1f32e0ce91c0631a3f52a680d783c40065c3cd982022b1455a166fd22eb2f785734527f3342c21b18a9a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1e6d230c81021e5654c2a53906a13355fc2632deb51023d8120d9f07443a28f3749e7dccfd51a57d0266392bc8e484ef6d013c01fbd3b62afa80e1c0a668a47c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d448b3dcd53a5810b7fcb80eb766a97aceaddc4087498af3ba86035153b49cc352cff0d828ca12e52e93005d122e7f977fcb8e36fb894e2f581c93e5b23f130c"} build_url:https://queue.taskcluster.net/v1/task/d8kijwZsSyyyeucAXl1ERg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011398 build_url: 'https://queue.taskcluster.net/v1/task/d8kijwZsSyyyeucAXl1ERg/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/55712f197ce16eee779c6e4fece86ff0a39d245843b1f32e0ce91c0631a3f52a680d783c40065c3cd982022b1455a166fd22eb2f785734527f3342c21b18a9a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1e6d230c81021e5654c2a53906a13355fc2632deb51023d8120d9f07443a28f3749e7dccfd51a57d0266392bc8e484ef6d013c01fbd3b62afa80e1c0a668a47c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d448b3dcd53a5810b7fcb80eb766a97aceaddc4087498af3ba86035153b49cc352cff0d828ca12e52e93005d122e7f977fcb8e36fb894e2f581c93e5b23f130c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 04:57:31.307793) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 04:57:31.308121) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1474975967.937788-1056806442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 04:57:31.391968) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 04:57:31.392312) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 04:57:31.392591) ========= ========= Total master_lag: 0.17 =========