builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1474653702.8 results: success (0) buildid: 20160923101223 builduid: 0d68c3f7956543978445e623efb0f45e revision: 5a9ce5f4d4d6b16aba8456635f664c2f87574e86 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 11:01:42.799825) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 11:01:42.800301) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 11:01:42.800572) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 11:01:42.815110) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 11:01:42.815395) ========= 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=62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-23 11:01:42-- 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% 43.0M=0s 2016-09-23 11:01:42 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114755 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 11:01:42.943909) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 11:01:42.944221) ========= 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=62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019045 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 11:01:42.993629) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 11:01:42.993988) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5a9ce5f4d4d6b16aba8456635f664c2f87574e86 --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 5a9ce5f4d4d6b16aba8456635f664c2f87574e86 --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=62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-23 11:01:43,060 truncating revision to first 12 chars 2016-09-23 11:01:43,061 Setting DEBUG logging. 2016-09-23 11:01:43,061 attempt 1/10 2016-09-23 11:01:43,061 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5a9ce5f4d4d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 11:01:43,382 unpacking tar archive at: fx-team-5a9ce5f4d4d6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.685520 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 11:01:43.693101) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 11:01:43.693426) ========= script_repo_revision: 5a9ce5f4d4d6b16aba8456635f664c2f87574e86 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 11:01:43.693831) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 11:01:43.694105) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 11:01:43.704706) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-09-23 11:01:43.704979) ========= /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=62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:01:43 INFO - MultiFileLogger online at 20160923 11:01:43 in /builds/slave/test 11:01:43 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 11:01:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:01:43 INFO - {'append_to_log': False, 11:01:43 INFO - 'base_work_dir': '/builds/slave/test', 11:01:43 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:01:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:01:43 INFO - 'branch': 'Fx-Team-Non-PGO', 11:01:43 INFO - 'buildbot_json_path': 'buildprops.json', 11:01:43 INFO - 'config_files': ('talos/linux_config.py',), 11:01:43 INFO - 'default_actions': ('clobber', 11:01:43 INFO - 'read-buildbot-config', 11:01:43 INFO - 'download-and-extract', 11:01:43 INFO - 'populate-webroot', 11:01:43 INFO - 'create-virtualenv', 11:01:43 INFO - 'install', 11:01:43 INFO - 'run-tests'), 11:01:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:01:43 INFO - 'download_minidump_stackwalk': True, 11:01:43 INFO - 'download_symbols': 'ondemand', 11:01:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:01:43 INFO - 'tooltool.py': '/tools/tooltool.py', 11:01:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:01:43 INFO - '/tools/misc-python/virtualenv.py')}, 11:01:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:01:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:01:43 INFO - 'installer_path': 'installer.exe', 11:01:43 INFO - 'log_level': 'info', 11:01:43 INFO - 'log_name': 'talos', 11:01:43 INFO - 'log_to_console': True, 11:01:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:01:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:01:43 INFO - 'opt_config_files': (), 11:01:43 INFO - 'pip_index': False, 11:01:43 INFO - 'sps_profile': False, 11:01:43 INFO - 'sps_profile_interval': 0, 11:01:43 INFO - 'suite': 'dromaeojs', 11:01:43 INFO - 'system_bits': '32', 11:01:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:01:43 INFO - 'title': 'talos-linux64-ix-018', 11:01:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:01:43 INFO - 'use_talos_json': True, 11:01:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:01:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:01:43 INFO - 'work_dir': 'build'} 11:01:43 INFO - [mozharness: 2016-09-23 18:01:43.867110Z] Running clobber step. 11:01:43 INFO - Running pre-action listener: _resource_record_pre_action 11:01:43 INFO - Running main action method: clobber 11:01:43 INFO - rmtree: /builds/slave/test/build 11:01:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:01:44 INFO - Running post-action listener: _resource_record_post_action 11:01:44 INFO - [mozharness: 2016-09-23 18:01:44.311973Z] Finished clobber step (success) 11:01:44 INFO - [mozharness: 2016-09-23 18:01:44.312074Z] Running read-buildbot-config step. 11:01:44 INFO - Running pre-action listener: _resource_record_pre_action 11:01:44 INFO - Running main action method: read_buildbot_config 11:01:44 INFO - Using buildbot properties: 11:01:44 INFO - { 11:01:44 INFO - "project": "", 11:01:44 INFO - "product": "firefox", 11:01:44 INFO - "script_repo_revision": "production", 11:01:44 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:01:44 INFO - "repository": "", 11:01:44 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:01:44 INFO - "buildid": "20160923101223", 11:01:44 INFO - "pgo_build": "False", 11:01:44 INFO - "basedir": "/builds/slave/test", 11:01:44 INFO - "buildnumber": 1951, 11:01:44 INFO - "slavename": "talos-linux64-ix-018", 11:01:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:01:44 INFO - "platform": "ubuntu64_hw", 11:01:44 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:01:44 INFO - "branch": "fx-team", 11:01:44 INFO - "repo_path": "integration/fx-team", 11:01:44 INFO - "revision": "5a9ce5f4d4d6b16aba8456635f664c2f87574e86", 11:01:44 INFO - "stage_platform": "linux64", 11:01:44 INFO - "builduid": "0d68c3f7956543978445e623efb0f45e", 11:01:44 INFO - "slavebuilddir": "test" 11:01:44 INFO - } 11:01:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/T8e0YgmgTJ-087zujTHWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 11:01:44 INFO - Running post-action listener: _resource_record_post_action 11:01:44 INFO - [mozharness: 2016-09-23 18:01:44.314526Z] Finished read-buildbot-config step (success) 11:01:44 INFO - [mozharness: 2016-09-23 18:01:44.314615Z] Running download-and-extract step. 11:01:44 INFO - Running pre-action listener: _resource_record_pre_action 11:01:44 INFO - Running main action method: download_and_extract 11:01:44 INFO - mkdir: /builds/slave/test/build/tests 11:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:44 INFO - trying https://queue.taskcluster.net/v1/task/T8e0YgmgTJ-087zujTHWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:01:44 INFO - Downloading https://queue.taskcluster.net/v1/task/T8e0YgmgTJ-087zujTHWHQ/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 11:01:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T8e0YgmgTJ-087zujTHWHQ/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 11:01:44 INFO - Downloaded 1361 bytes. 11:01:44 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:01:44 INFO - Using the following test package requirements: 11:01:44 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 11:01:44 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:01:44 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:01:44 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:44 INFO - u'jsshell-linux-x86_64.zip'], 11:01:44 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:01:44 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 11:01:44 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:01:44 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:01:44 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:01:44 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:01:44 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:01:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T8e0YgmgTJ-087zujTHWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 11:01:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T8e0YgmgTJ-087zujTHWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:01:44 INFO - Fetch https://queue.taskcluster.net/v1/task/T8e0YgmgTJ-087zujTHWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:01:45 INFO - Expected file size: 20377253 11:01:49 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 11:01:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T8e0YgmgTJ-087zujTHWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 11:01:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T8e0YgmgTJ-087zujTHWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:01:49 INFO - Fetch https://queue.taskcluster.net/v1/task/T8e0YgmgTJ-087zujTHWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:01:50 INFO - Expected file size: 20377253 11:01:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T8e0YgmgTJ-087zujTHWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 11:01:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T8e0YgmgTJ-087zujTHWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:01:54 INFO - Fetch https://queue.taskcluster.net/v1/task/T8e0YgmgTJ-087zujTHWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 11:01:55 INFO - Expected file size: 14414059 11:01:57 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')]} 11:01:57 INFO - trying https://queue.taskcluster.net/v1/task/T8e0YgmgTJ-087zujTHWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:01:57 INFO - Downloading https://queue.taskcluster.net/v1/task/T8e0YgmgTJ-087zujTHWHQ/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 11:01:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T8e0YgmgTJ-087zujTHWHQ/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 11:01:58 INFO - Downloaded 55728463 bytes. 11:01:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T8e0YgmgTJ-087zujTHWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:01:58 INFO - mkdir: /builds/slave/test/properties 11:01:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:01:58 INFO - Writing to file /builds/slave/test/properties/build_url 11:01:58 INFO - Contents: 11:01:58 INFO - build_url:https://queue.taskcluster.net/v1/task/T8e0YgmgTJ-087zujTHWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:01:59 INFO - Running post-action listener: _resource_record_post_action 11:01:59 INFO - Running post-action listener: set_extra_try_arguments 11:01:59 INFO - [mozharness: 2016-09-23 18:01:59.488147Z] Finished download-and-extract step (success) 11:01:59 INFO - [mozharness: 2016-09-23 18:01:59.488376Z] Running populate-webroot step. 11:01:59 INFO - Running pre-action listener: _resource_record_pre_action 11:01:59 INFO - Running main action method: populate_webroot 11:01:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:01:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:01:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:01:59 INFO - '--tppagecycles', 11:01:59 INFO - '7'], 11:01:59 INFO - 'tests': ['tsvgm']}}, 11:01:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:01:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:01:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:01:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:01:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:01:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:01:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:59 INFO - 'talos_options': ['--disable-e10s'], 11:01:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:01:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:01:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:59 INFO - 'talos_options': ['--disable-e10s'], 11:01:59 INFO - 'tests': ['damp', 'tps']}, 11:01:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:59 INFO - 'tests': ['damp', 'tps']}, 11:01:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:01:59 INFO - 'tests': ['dromaeo_dom']}, 11:01:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:01:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:01:59 INFO - 'tests': ['basic_compositor_video']}, 11:01:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:01:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:01:59 INFO - 'tests': ['a11yr', 11:01:59 INFO - 'ts_paint', 11:01:59 INFO - 'tpaint', 11:01:59 INFO - 'sessionrestore', 11:01:59 INFO - 'sessionrestore_no_auto_restore', 11:01:59 INFO - 'tabpaint']}, 11:01:59 INFO - 'other-e10s': {'tests': ['a11yr', 11:01:59 INFO - 'ts_paint', 11:01:59 INFO - 'tpaint', 11:01:59 INFO - 'sessionrestore', 11:01:59 INFO - 'sessionrestore_no_auto_restore', 11:01:59 INFO - 'tabpaint']}, 11:01:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:01:59 INFO - 'ts_paint', 11:01:59 INFO - 'tpaint', 11:01:59 INFO - 'sessionrestore', 11:01:59 INFO - 'sessionrestore_no_auto_restore', 11:01:59 INFO - 'tabpaint']}, 11:01:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:01:59 INFO - 'ts_paint', 11:01:59 INFO - 'tpaint', 11:01:59 INFO - 'sessionrestore', 11:01:59 INFO - 'sessionrestore_no_auto_restore', 11:01:59 INFO - 'tabpaint']}, 11:01:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:01:59 INFO - 'tests': ['a11yr', 11:01:59 INFO - 'ts_paint', 11:01:59 INFO - 'tpaint', 11:01:59 INFO - 'sessionrestore', 11:01:59 INFO - 'sessionrestore_no_auto_restore', 11:01:59 INFO - 'tabpaint']}, 11:01:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:01:59 INFO - 'tests': ['a11yr', 11:01:59 INFO - 'ts_paint', 11:01:59 INFO - 'tpaint', 11:01:59 INFO - 'sessionrestore', 11:01:59 INFO - 'sessionrestore_no_auto_restore', 11:01:59 INFO - 'tabpaint']}, 11:01:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:01:59 INFO - 'tests': ['tsvgx', 11:01:59 INFO - 'tsvgr_opacity', 11:01:59 INFO - 'tart', 11:01:59 INFO - 'tscrollx', 11:01:59 INFO - 'cart']}, 11:01:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:01:59 INFO - 'tsvgr_opacity', 11:01:59 INFO - 'tart', 11:01:59 INFO - 'tscrollx', 11:01:59 INFO - 'cart']}, 11:01:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:59 INFO - 'talos_options': ['--disable-e10s'], 11:01:59 INFO - 'tests': ['tp5o']}, 11:01:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:59 INFO - 'tests': ['tp5o']}, 11:01:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:59 INFO - 'talos_options': ['--disable-e10s', 11:01:59 INFO - '--xperf_path', 11:01:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:01:59 INFO - 'tests': ['tp5n']}, 11:01:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:59 INFO - 'talos_options': ['--xperf_path', 11:01:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:01:59 INFO - 'tests': ['tp5n']}}, 11:01:59 INFO - 'talos.zip': {'path': '', 11:01:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:01:59 INFO - Running post-action listener: _resource_record_post_action 11:01:59 INFO - [mozharness: 2016-09-23 18:01:59.509993Z] Finished populate-webroot step (success) 11:01:59 INFO - [mozharness: 2016-09-23 18:01:59.510082Z] Running create-virtualenv step. 11:01:59 INFO - Running pre-action listener: _resource_record_pre_action 11:01:59 INFO - Running main action method: create_virtualenv 11:01:59 INFO - Creating virtualenv /builds/slave/test/build/venv 11:01:59 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 11:01:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:01:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:01:59 INFO - Using real prefix '/usr' 11:01:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:02:00 INFO - Installing distribute.............................................................................................................................................................................................done. 11:02:02 INFO - Installing pip.................done. 11:02:02 INFO - Return code: 0 11:02:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4391a7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec9f60>, '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 0xecad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950', '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 11:02:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:02:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:02:02 INFO - Using env: {'DISPLAY': ':0', 11:02:02 INFO - 'HOME': '/home/cltbld', 11:02:02 INFO - 'LANG': 'en_US.UTF-8', 11:02:02 INFO - 'LANGUAGE': 'en_US:en', 11:02:02 INFO - 'LOGNAME': 'cltbld', 11:02:02 INFO - 'MAIL': '/var/mail/cltbld', 11:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:02 INFO - 'MOZ_NO_REMOTE': '1', 11:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:02 INFO - 'NO_EM_RESTART': '1', 11:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:02 INFO - 'PWD': '/builds/slave/test', 11:02:02 INFO - 'SHELL': '/bin/bash', 11:02:02 INFO - 'SHLVL': '1', 11:02:02 INFO - 'TERM': 'linux', 11:02:02 INFO - 'TMOUT': '86400', 11:02:02 INFO - 'USER': 'cltbld', 11:02:02 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950', 11:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:02 INFO - '_': '/tools/buildbot/bin/python'} 11:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:02 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 11:02:02 INFO - Cleaning up... 11:02:02 INFO - Return code: 0 11:02:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4391a7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec9f60>, '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 0xecad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950', '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 11:02:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:02:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:02:02 INFO - Using env: {'DISPLAY': ':0', 11:02:02 INFO - 'HOME': '/home/cltbld', 11:02:02 INFO - 'LANG': 'en_US.UTF-8', 11:02:02 INFO - 'LANGUAGE': 'en_US:en', 11:02:02 INFO - 'LOGNAME': 'cltbld', 11:02:02 INFO - 'MAIL': '/var/mail/cltbld', 11:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:02 INFO - 'MOZ_NO_REMOTE': '1', 11:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:02 INFO - 'NO_EM_RESTART': '1', 11:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:02 INFO - 'PWD': '/builds/slave/test', 11:02:02 INFO - 'SHELL': '/bin/bash', 11:02:02 INFO - 'SHLVL': '1', 11:02:02 INFO - 'TERM': 'linux', 11:02:02 INFO - 'TMOUT': '86400', 11:02:02 INFO - 'USER': 'cltbld', 11:02:02 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950', 11:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:02 INFO - '_': '/tools/buildbot/bin/python'} 11:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:02 INFO - Downloading/unpacking psutil>=3.1.1 11:02: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 11:02: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 11:02: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 11:02: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 11:02: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 11:02: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 11:02:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:02:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:02:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:02:04 INFO - Installing collected packages: psutil 11:02:04 INFO - Running setup.py install for psutil 11:02:04 INFO - building 'psutil._psutil_linux' extension 11:02:04 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 11:02:04 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 11:02:04 INFO - building 'psutil._psutil_posix' extension 11:02:04 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 11:02:04 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 11:02:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:02:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:02:04 INFO - Successfully installed psutil 11:02:04 INFO - Cleaning up... 11:02:05 INFO - Return code: 0 11:02:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:05 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 0x7f4391a7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec9f60>, '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 0xecad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950', '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 11:02:05 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 11:02:05 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 11:02:05 INFO - Using env: {'DISPLAY': ':0', 11:02:05 INFO - 'HOME': '/home/cltbld', 11:02:05 INFO - 'LANG': 'en_US.UTF-8', 11:02:05 INFO - 'LANGUAGE': 'en_US:en', 11:02:05 INFO - 'LOGNAME': 'cltbld', 11:02:05 INFO - 'MAIL': '/var/mail/cltbld', 11:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:05 INFO - 'MOZ_NO_REMOTE': '1', 11:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:05 INFO - 'NO_EM_RESTART': '1', 11:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:05 INFO - 'PWD': '/builds/slave/test', 11:02:05 INFO - 'SHELL': '/bin/bash', 11:02:05 INFO - 'SHLVL': '1', 11:02:05 INFO - 'TERM': 'linux', 11:02:05 INFO - 'TMOUT': '86400', 11:02:05 INFO - 'USER': 'cltbld', 11:02:05 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950', 11:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:05 INFO - '_': '/tools/buildbot/bin/python'} 11:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:02:05 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 11:02:05 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 11:02:05 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 11:02:05 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 11:02:05 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 11:02:05 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 11:02:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:02:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:02:08 INFO - Installing collected packages: mozsystemmonitor 11:02:08 INFO - Running setup.py install for mozsystemmonitor 11:02:08 INFO - Successfully installed mozsystemmonitor 11:02:08 INFO - Cleaning up... 11:02:08 INFO - Return code: 0 11:02:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:08 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 0x7f4391a7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec9f60>, '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 0xecad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950', '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 11:02:08 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 11:02:08 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 11:02:08 INFO - Using env: {'DISPLAY': ':0', 11:02:08 INFO - 'HOME': '/home/cltbld', 11:02:08 INFO - 'LANG': 'en_US.UTF-8', 11:02:08 INFO - 'LANGUAGE': 'en_US:en', 11:02:08 INFO - 'LOGNAME': 'cltbld', 11:02:08 INFO - 'MAIL': '/var/mail/cltbld', 11:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:08 INFO - 'MOZ_NO_REMOTE': '1', 11:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:08 INFO - 'NO_EM_RESTART': '1', 11:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:08 INFO - 'PWD': '/builds/slave/test', 11:02:08 INFO - 'SHELL': '/bin/bash', 11:02:08 INFO - 'SHLVL': '1', 11:02:08 INFO - 'TERM': 'linux', 11:02:08 INFO - 'TMOUT': '86400', 11:02:08 INFO - 'USER': 'cltbld', 11:02:08 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950', 11:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:08 INFO - '_': '/tools/buildbot/bin/python'} 11:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:08 INFO - Downloading/unpacking jsonschema==2.5.1 11:02:08 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 11:02:08 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 11:02:08 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 11:02:08 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 11:02:08 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 11:02:08 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 11:02:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:02:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:10 INFO - Downloading functools32-3.2.3-2.tar.gz 11:02:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:02:10 INFO - warning: no files found matching '*.txt' 11:02:10 INFO - no previously-included directories found matching 'build' 11:02:10 INFO - no previously-included directories found matching 'dist' 11:02:10 INFO - no previously-included directories found matching '.git*' 11:02:10 INFO - Installing collected packages: jsonschema, functools32 11:02:10 INFO - Running setup.py install for functools32 11:02:10 INFO - warning: no files found matching '*.txt' 11:02:10 INFO - no previously-included directories found matching 'build' 11:02:10 INFO - no previously-included directories found matching 'dist' 11:02:10 INFO - no previously-included directories found matching '.git*' 11:02:10 INFO - Successfully installed jsonschema functools32 11:02:10 INFO - Cleaning up... 11:02:10 INFO - Return code: 0 11:02:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:02: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')]} 11:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02: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')]} 11:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:10 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 0x7f4391a7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec9f60>, '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 0xecad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950', '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 11:02:10 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 11:02:10 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 11:02:10 INFO - Using env: {'DISPLAY': ':0', 11:02:10 INFO - 'HOME': '/home/cltbld', 11:02:10 INFO - 'LANG': 'en_US.UTF-8', 11:02:10 INFO - 'LANGUAGE': 'en_US:en', 11:02:10 INFO - 'LOGNAME': 'cltbld', 11:02:10 INFO - 'MAIL': '/var/mail/cltbld', 11:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:10 INFO - 'MOZ_NO_REMOTE': '1', 11:02:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:10 INFO - 'NO_EM_RESTART': '1', 11:02:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:10 INFO - 'PWD': '/builds/slave/test', 11:02:10 INFO - 'SHELL': '/bin/bash', 11:02:10 INFO - 'SHLVL': '1', 11:02:10 INFO - 'TERM': 'linux', 11:02:10 INFO - 'TMOUT': '86400', 11:02:10 INFO - 'USER': 'cltbld', 11:02:10 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950', 11:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:10 INFO - '_': '/tools/buildbot/bin/python'} 11:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:02:11 INFO - Cleaning up... 11:02:11 INFO - Return code: 0 11:02:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:02:11 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')]} 11:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:11 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')]} 11:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:11 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 0x7f4391a7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec9f60>, '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 0xecad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950', '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 11:02:11 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 11:02:11 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 11:02:11 INFO - Using env: {'DISPLAY': ':0', 11:02:11 INFO - 'HOME': '/home/cltbld', 11:02:11 INFO - 'LANG': 'en_US.UTF-8', 11:02:11 INFO - 'LANGUAGE': 'en_US:en', 11:02:11 INFO - 'LOGNAME': 'cltbld', 11:02:11 INFO - 'MAIL': '/var/mail/cltbld', 11:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:11 INFO - 'MOZ_NO_REMOTE': '1', 11:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:11 INFO - 'NO_EM_RESTART': '1', 11:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:11 INFO - 'PWD': '/builds/slave/test', 11:02:11 INFO - 'SHELL': '/bin/bash', 11:02:11 INFO - 'SHLVL': '1', 11:02:11 INFO - 'TERM': 'linux', 11:02:11 INFO - 'TMOUT': '86400', 11:02:11 INFO - 'USER': 'cltbld', 11:02:11 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950', 11:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:11 INFO - '_': '/tools/buildbot/bin/python'} 11:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:11 INFO - Downloading/unpacking blobuploader==1.2.4 11:02:11 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 11:02:11 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 11:02:11 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 11:02:11 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 11:02:11 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 11:02:11 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 11:02:13 INFO - Downloading blobuploader-1.2.4.tar.gz 11:02:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:02:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:02:13 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 11:02:13 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 11:02:13 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 11:02:13 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 11:02:13 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 11:02:13 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 11:02:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:02:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:02:13 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 11:02:13 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 11:02:13 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 11:02:13 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 11:02:13 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 11:02:13 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 11:02:13 INFO - Downloading docopt-0.6.1.tar.gz 11:02:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:02:14 INFO - Installing collected packages: blobuploader, requests, docopt 11:02:14 INFO - Running setup.py install for blobuploader 11:02:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:02:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:02:14 INFO - Running setup.py install for requests 11:02:14 INFO - Running setup.py install for docopt 11:02:14 INFO - Successfully installed blobuploader requests docopt 11:02:14 INFO - Cleaning up... 11:02:14 INFO - Return code: 0 11:02:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:02:14 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')]} 11:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:14 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')]} 11:02:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:14 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 0x7f4391a7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec9f60>, '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 0xecad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950', '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 11:02:14 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 11:02:14 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 11:02:14 INFO - Using env: {'DISPLAY': ':0', 11:02:14 INFO - 'HOME': '/home/cltbld', 11:02:14 INFO - 'LANG': 'en_US.UTF-8', 11:02:14 INFO - 'LANGUAGE': 'en_US:en', 11:02:14 INFO - 'LOGNAME': 'cltbld', 11:02:14 INFO - 'MAIL': '/var/mail/cltbld', 11:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:14 INFO - 'MOZ_NO_REMOTE': '1', 11:02:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:14 INFO - 'NO_EM_RESTART': '1', 11:02:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:14 INFO - 'PWD': '/builds/slave/test', 11:02:14 INFO - 'SHELL': '/bin/bash', 11:02:14 INFO - 'SHLVL': '1', 11:02:14 INFO - 'TERM': 'linux', 11:02:14 INFO - 'TMOUT': '86400', 11:02:14 INFO - 'USER': 'cltbld', 11:02:14 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950', 11:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:14 INFO - '_': '/tools/buildbot/bin/python'} 11:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:02:14 INFO - Running setup.py (path:/tmp/pip-TlyXrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:02:14 INFO - Running setup.py (path:/tmp/pip-gEg1sR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:02:14 INFO - Running setup.py (path:/tmp/pip-C4VSEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:02:15 INFO - Running setup.py (path:/tmp/pip-Np2e4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:02:15 INFO - Running setup.py (path:/tmp/pip-6hvLNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:02:15 INFO - Running setup.py (path:/tmp/pip-IIHpGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:02:15 INFO - Running setup.py (path:/tmp/pip-GaKEgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:02:15 INFO - Running setup.py (path:/tmp/pip-WLBETG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:02:15 INFO - Running setup.py (path:/tmp/pip-bYWP4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:02:15 INFO - Running setup.py (path:/tmp/pip-YTj4dV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:02:15 INFO - Running setup.py (path:/tmp/pip-twsb7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:02:15 INFO - Running setup.py (path:/tmp/pip-SlJ5hL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:02:15 INFO - Running setup.py (path:/tmp/pip-UstyEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:02:15 INFO - Running setup.py (path:/tmp/pip-HCH0p5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:02:15 INFO - Running setup.py (path:/tmp/pip-FFLCUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:02:15 INFO - Running setup.py (path:/tmp/pip-rjQB7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:02:15 INFO - Running setup.py (path:/tmp/pip-C4vnmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:02:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:02:16 INFO - Running setup.py install for manifestparser 11:02:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:02:16 INFO - Running setup.py install for mozcrash 11:02:16 INFO - Running setup.py install for mozdebug 11:02:16 INFO - Running setup.py install for mozdevice 11:02:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:02:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:02:16 INFO - Running setup.py install for mozfile 11:02:16 INFO - Running setup.py install for mozhttpd 11:02:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:02:16 INFO - Running setup.py install for mozinfo 11:02:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:02:16 INFO - Running setup.py install for mozInstall 11:02:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:02:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:02:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:02:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:02:16 INFO - Running setup.py install for mozleak 11:02:16 INFO - Running setup.py install for mozlog 11:02:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:02:17 INFO - Running setup.py install for moznetwork 11:02:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:02:17 INFO - Running setup.py install for mozprocess 11:02:17 INFO - Running setup.py install for mozprofile 11:02:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:02:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:02:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:02:17 INFO - Running setup.py install for mozrunner 11:02:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:02:17 INFO - Running setup.py install for mozscreenshot 11:02:17 INFO - Running setup.py install for moztest 11:02:17 INFO - Running setup.py install for mozversion 11:02:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:02:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:02:17 INFO - Cleaning up... 11:02:17 INFO - Return code: 0 11:02:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:02: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')]} 11:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02: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')]} 11:02:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:17 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 0x7f4391a7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec9f60>, '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 0xecad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950', '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 11:02:17 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 11:02:17 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 11:02:17 INFO - Using env: {'DISPLAY': ':0', 11:02:17 INFO - 'HOME': '/home/cltbld', 11:02:17 INFO - 'LANG': 'en_US.UTF-8', 11:02:17 INFO - 'LANGUAGE': 'en_US:en', 11:02:17 INFO - 'LOGNAME': 'cltbld', 11:02:17 INFO - 'MAIL': '/var/mail/cltbld', 11:02:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:17 INFO - 'MOZ_NO_REMOTE': '1', 11:02:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:17 INFO - 'NO_EM_RESTART': '1', 11:02:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:17 INFO - 'PWD': '/builds/slave/test', 11:02:17 INFO - 'SHELL': '/bin/bash', 11:02:17 INFO - 'SHLVL': '1', 11:02:17 INFO - 'TERM': 'linux', 11:02:17 INFO - 'TMOUT': '86400', 11:02:17 INFO - 'USER': 'cltbld', 11:02:17 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950', 11:02:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:17 INFO - '_': '/tools/buildbot/bin/python'} 11:02:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:02:18 INFO - Running setup.py (path:/tmp/pip-GvHq_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:02:18 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)) 11:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:02:18 INFO - Running setup.py (path:/tmp/pip-5P4XGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:02:18 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)) 11:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:02:18 INFO - Running setup.py (path:/tmp/pip-6xYPaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:02:18 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)) 11:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:02:18 INFO - Running setup.py (path:/tmp/pip-cjhQKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:02:18 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)) 11:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:02:18 INFO - Running setup.py (path:/tmp/pip-DM5PA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:02:18 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)) 11:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:02:18 INFO - Running setup.py (path:/tmp/pip-Rf5zpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:02:18 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)) 11:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:02:18 INFO - Running setup.py (path:/tmp/pip-_NUgic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:02:18 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)) 11:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:02:18 INFO - Running setup.py (path:/tmp/pip-E8Zb3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:02:18 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)) 11:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:02:18 INFO - Running setup.py (path:/tmp/pip-jIWBnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:02:18 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)) 11:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:02:18 INFO - Running setup.py (path:/tmp/pip-Ar0WCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:02:18 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)) 11:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:02:18 INFO - Running setup.py (path:/tmp/pip-_uE2MS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:02:18 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)) 11:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:02:18 INFO - Running setup.py (path:/tmp/pip-u8P9qD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:02:18 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)) 11:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:02:18 INFO - Running setup.py (path:/tmp/pip-5T7dcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:02:19 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)) 11:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:02:19 INFO - Running setup.py (path:/tmp/pip-TOfsyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:02:19 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)) 11:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:02:19 INFO - Running setup.py (path:/tmp/pip-1tQDon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:02:19 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)) 11:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:02:19 INFO - Running setup.py (path:/tmp/pip-faeodN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:02:19 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)) 11:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:02:19 INFO - Running setup.py (path:/tmp/pip-SULmnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:02:19 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)) 11:02:19 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)) 11:02:19 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)) 11:02:19 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)) 11:02:19 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)) 11:02:19 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)) 11:02:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:02:19 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 11:02:19 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 11:02:19 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 11:02:19 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 11:02:19 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 11:02:19 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 11:02:21 INFO - Downloading blessings-1.6.tar.gz 11:02:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:02:21 INFO - Installing collected packages: blessings 11:02:21 INFO - Running setup.py install for blessings 11:02:21 INFO - Successfully installed blessings 11:02:21 INFO - Cleaning up... 11:02:21 INFO - Return code: 0 11:02:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:02:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:02:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:02:21 INFO - Reading from file tmpfile_stdout 11:02:21 INFO - Current package versions: 11:02:21 INFO - argparse == 1.2.1 11:02:21 INFO - blessings == 1.6 11:02:21 INFO - blobuploader == 1.2.4 11:02:21 INFO - docopt == 0.6.1 11:02:21 INFO - functools32 == 3.2.3-2 11:02:21 INFO - jsonschema == 2.5.1 11:02:21 INFO - manifestparser == 1.1 11:02:21 INFO - mozInstall == 1.12 11:02:21 INFO - mozcrash == 0.17 11:02:21 INFO - mozdebug == 0.1 11:02:21 INFO - mozdevice == 0.48 11:02:21 INFO - mozfile == 1.2 11:02:21 INFO - mozhttpd == 0.7 11:02:21 INFO - mozinfo == 0.9 11:02:21 INFO - mozleak == 0.1 11:02:21 INFO - mozlog == 3.4 11:02:21 INFO - moznetwork == 0.27 11:02:21 INFO - mozprocess == 0.23 11:02:21 INFO - mozprofile == 0.28 11:02:21 INFO - mozrunner == 6.12 11:02:21 INFO - mozscreenshot == 0.1 11:02:21 INFO - mozsystemmonitor == 0.3 11:02:21 INFO - moztest == 0.7 11:02:21 INFO - mozversion == 1.4 11:02:21 INFO - psutil == 3.1.1 11:02:21 INFO - requests == 1.2.3 11:02:21 INFO - wsgiref == 0.1.2 11:02:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:02:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:21 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 0x7f4391a7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec9f60>, '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 0xecad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950', '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 11:02:21 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 11:02:21 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 11:02:21 INFO - Using env: {'DISPLAY': ':0', 11:02:21 INFO - 'HOME': '/home/cltbld', 11:02:21 INFO - 'LANG': 'en_US.UTF-8', 11:02:21 INFO - 'LANGUAGE': 'en_US:en', 11:02:21 INFO - 'LOGNAME': 'cltbld', 11:02:21 INFO - 'MAIL': '/var/mail/cltbld', 11:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:21 INFO - 'MOZ_NO_REMOTE': '1', 11:02:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:21 INFO - 'NO_EM_RESTART': '1', 11:02:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:21 INFO - 'PWD': '/builds/slave/test', 11:02:21 INFO - 'SHELL': '/bin/bash', 11:02:21 INFO - 'SHLVL': '1', 11:02:21 INFO - 'TERM': 'linux', 11:02:21 INFO - 'TMOUT': '86400', 11:02:21 INFO - 'USER': 'cltbld', 11:02:21 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950', 11:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:21 INFO - '_': '/tools/buildbot/bin/python'} 11:02:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:21 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)) 11:02:21 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)) 11:02:21 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)) 11:02:21 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)) 11:02:21 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)) 11:02:21 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)) 11:02:21 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)) 11:02:21 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)) 11:02:21 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)) 11:02:21 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)) 11:02:21 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)) 11:02:21 INFO - Cleaning up... 11:02:21 INFO - Return code: 0 11:02:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:02:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:21 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 0x7f4391a7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeccca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec9f60>, '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 0xecad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950', '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 11:02:21 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 11:02:21 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 11:02:21 INFO - Using env: {'DISPLAY': ':0', 11:02:21 INFO - 'HOME': '/home/cltbld', 11:02:21 INFO - 'LANG': 'en_US.UTF-8', 11:02:21 INFO - 'LANGUAGE': 'en_US:en', 11:02:21 INFO - 'LOGNAME': 'cltbld', 11:02:21 INFO - 'MAIL': '/var/mail/cltbld', 11:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:21 INFO - 'MOZ_NO_REMOTE': '1', 11:02:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:21 INFO - 'NO_EM_RESTART': '1', 11:02:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:21 INFO - 'PWD': '/builds/slave/test', 11:02:21 INFO - 'SHELL': '/bin/bash', 11:02:21 INFO - 'SHLVL': '1', 11:02:21 INFO - 'TERM': 'linux', 11:02:21 INFO - 'TMOUT': '86400', 11:02:21 INFO - 'USER': 'cltbld', 11:02:21 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950', 11:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:21 INFO - '_': '/tools/buildbot/bin/python'} 11:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:02:22 INFO - Cleaning up... 11:02:22 INFO - Return code: 0 11:02:22 INFO - Running post-action listener: _resource_record_post_action 11:02:22 INFO - Running post-action listener: _start_resource_monitoring 11:02:22 INFO - Starting resource monitoring. 11:02:22 INFO - [mozharness: 2016-09-23 18:02:22.160899Z] Finished create-virtualenv step (success) 11:02:22 INFO - [mozharness: 2016-09-23 18:02:22.161343Z] Running install step. 11:02:22 INFO - Running pre-action listener: _resource_record_pre_action 11:02:22 INFO - Running main action method: install 11:02:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:02:22 INFO - Reading from file tmpfile_stdout 11:02:22 INFO - Detecting whether we're running mozinstall >=1.0... 11:02:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:02:22 INFO - Reading from file tmpfile_stdout 11:02:22 INFO - Output received: 11:02:22 INFO - Usage: mozinstall [options] installer 11:02:22 INFO - Options: 11:02:22 INFO - -h, --help show this help message and exit 11:02:22 INFO - -d DEST, --destination=DEST 11:02:22 INFO - Directory to install application into. [default: 11:02:22 INFO - "/builds/slave/test"] 11:02:22 INFO - --app=APP Application being installed. [default: firefox] 11:02:22 INFO - mkdir: /builds/slave/test/build/application 11:02:22 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'] 11:02:22 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 11:02:38 INFO - Reading from file tmpfile_stdout 11:02:38 INFO - Output received: 11:02:38 INFO - /builds/slave/test/build/application/firefox/firefox 11:02:38 INFO - Running post-action listener: _resource_record_post_action 11:02:38 INFO - [mozharness: 2016-09-23 18:02:38.578541Z] Finished install step (success) 11:02:38 INFO - [mozharness: 2016-09-23 18:02:38.578682Z] Running run-tests step. 11:02:38 INFO - Running pre-action listener: _resource_record_pre_action 11:02:38 INFO - Running main action method: run_tests 11:02:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:02:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:02:38 INFO - Python 2.7.3 11:02:38 INFO - Return code: 0 11:02:38 INFO - grabbing minidump binary from tooltool 11:02:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:38 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 0xec9f60>, '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 0xecad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xecb1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:02:38 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 11:02:38 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 11:02:38 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 11:02:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:02:38 INFO - Return code: 0 11:02:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:02:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:02:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:02:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:02:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:02:38 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/T8e0YgmgTJ-087zujTHWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 11:02:38 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/T8e0YgmgTJ-087zujTHWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 11:02:38 INFO - Using env: {'DISPLAY': ':0', 11:02:38 INFO - 'HOME': '/home/cltbld', 11:02:38 INFO - 'LANG': 'en_US.UTF-8', 11:02:38 INFO - 'LANGUAGE': 'en_US:en', 11:02:38 INFO - 'LOGNAME': 'cltbld', 11:02:38 INFO - 'MAIL': '/var/mail/cltbld', 11:02:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:02:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:02:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:38 INFO - 'MOZ_NO_REMOTE': '1', 11:02:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:02:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:38 INFO - 'NO_EM_RESTART': '1', 11:02:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:38 INFO - 'PWD': '/builds/slave/test', 11:02:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:02:38 INFO - 'SHELL': '/bin/bash', 11:02:38 INFO - 'SHLVL': '1', 11:02:38 INFO - 'TERM': 'linux', 11:02:38 INFO - 'TMOUT': '86400', 11:02:38 INFO - 'USER': 'cltbld', 11:02:38 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950', 11:02:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:38 INFO - '_': '/tools/buildbot/bin/python'} 11:02:38 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/T8e0YgmgTJ-087zujTHWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 11:02:38 INFO - mozversion application_buildid: 20160923101223 11:02:38 INFO - mozversion application_changeset: 5a9ce5f4d4d6b16aba8456635f664c2f87574e86 11:02:38 INFO - mozversion application_display_name: Nightly 11:02:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:02:38 INFO - mozversion application_name: Firefox 11:02:38 INFO - mozversion application_remotingname: firefox 11:02:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:02:38 INFO - mozversion application_vendor: Mozilla 11:02:38 INFO - mozversion application_version: 52.0a1 11:02:38 INFO - mozversion platform_buildid: 20160923101223 11:02:38 INFO - mozversion platform_changeset: 5a9ce5f4d4d6b16aba8456635f664c2f87574e86 11:02:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:02:38 INFO - mozversion platform_version: 52.0a1 11:02:38 INFO - using testdate: 1474653758 11:02:38 INFO - actual date: 1474653758 11:02:38 INFO - starting webserver on 'localhost:51078' 11:02:38 INFO - SUITE-START | Running 2 tests 11:02:38 INFO - TEST-START | dromaeo_css 11:02:38 INFO - operating with platform_type : linux_ 11:02:38 INFO - Initialising browser for dromaeo_css test... 11:02:38 INFO - TEST-INFO | started process 6355 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppq2Ce4/profile http://localhost:51078/getInfo.html) 11:02:43 INFO - PROCESS | 6355 | __metrics Screen width/height:1600/1200 11:02:43 INFO - PROCESS | 6355 | colorDepth:24 11:02:43 INFO - PROCESS | 6355 | Browser inner width/height: 1024/697 11:02:43 INFO - PROCESS | 6355 | __metrics 11:02:45 INFO - PROCESS | 6355 | 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" 11:02:45 INFO - PROCESS | 6355 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:02:46 INFO - PROCESS | 6355 | console.error: PushService: 11:02:46 INFO - PROCESS | 6355 | stateChangeProcessEnqueue: Error transitioning state 11:02:46 INFO - PROCESS | 6355 | UnknownError 11:02:46 INFO - TEST-INFO | 6355: exit 0 11:02:46 INFO - Browser initialized. 11:02:46 INFO - Running cycle 1/1 for dromaeo_css test... 11:02:46 INFO - TEST-INFO | started process 6439 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppq2Ce4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:02:59 INFO - PROCESS | 6439 | RSS: Main: 175112192 11:02:59 INFO - PROCESS | 6439 | 11:03:50 INFO - PROCESS | 6439 | 1474653830489 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] 11:06:03 INFO - PROCESS | 6439 | Cycle 1(1): loaded http://localhost:51078/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51078/tests/dromaeo/cssquery-ext.html) 11:06:05 INFO - PROCESS | 6439 | RSS: Main: 329330688 11:06:05 INFO - PROCESS | 6439 | 11:09:08 INFO - PROCESS | 6439 | Cycle 1(1): loaded http://localhost:51078/tests/dromaeo/cssquery-ext.html (next: http://localhost:51078/tests/dromaeo/cssquery-jquery.html) 11:09:08 INFO - PROCESS | 6439 | RSS: Main: 278364160 11:09:08 INFO - PROCESS | 6439 | 11:12:11 INFO - PROCESS | 6439 | Cycle 1(1): loaded http://localhost:51078/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51078/tests/dromaeo/cssquery-mootools.html) 11:12:11 INFO - PROCESS | 6439 | RSS: Main: 242348032 11:12:11 INFO - PROCESS | 6439 | 11:15:14 INFO - PROCESS | 6439 | Cycle 1(1): loaded http://localhost:51078/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51078/tests/dromaeo/cssquery-prototype.html) 11:15:14 INFO - PROCESS | 6439 | RSS: Main: 219852800 11:15:14 INFO - PROCESS | 6439 | 11:18:17 INFO - PROCESS | 6439 | Cycle 1(1): loaded http://localhost:51078/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51078/tests/dromaeo/cssquery-yui.html) 11:18:18 INFO - PROCESS | 6439 | RSS: Main: 222175232 11:18:18 INFO - PROCESS | 6439 | 11:21:21 INFO - PROCESS | 6439 | Cycle 1(1): loaded http://localhost:51078/tests/dromaeo/cssquery-yui.html (next: http://localhost:51078/tests/dromaeo/cssquery-dojo.html) 11:21:21 INFO - PROCESS | 6439 | RSS: Main: 309612544 11:21:21 INFO - PROCESS | 6439 | 11:21:22 INFO - PROCESS | 6439 | __start_tp_report 11:21:22 INFO - PROCESS | 6439 | _x_x_mozilla_page_load 11:21:22 INFO - PROCESS | 6439 | _x_x_mozilla_page_load_details 11:21:22 INFO - PROCESS | 6439 | |i|pagename|runs| 11:21:22 INFO - PROCESS | 6439 | |0;dojo.html;2628.1327162036523;2635.5519561674514;2674.598810178473;2681.7452342027514;2697.1773609049233;4697.201475749122;4699.647526435514;4763.90472190556;4793.209120495123;4813.229883218682;4831.082094402062;4831.492693267209;4838.34682317887;4842.8547143585665;4849.054434385296;4366.519682834885;4397.648188144956;4422.601965823083;4433.31283651033;4491.483479399862;4426.159029784347;4458.2866741321395;4497.775111244441;4515.977420112895;4518.480374756896;4443.733375997434;4480.439945006874;4556.384888040106;4579.954200457986;4580.496145424001;4513.526079761644;4536.523665015159;4579.633629309664;4593.678442509025;4594.1271158479785;4335.328024156261;4378.10248898975;4384.714993525411;4387.42963414754;4395.274779661352;4696.671233013691;4704.129735998851;4704.717716936961;4740.525947405266;4748.596369308613;5018.974905125451;5034.169362055257;5114.667546609458;5121.51345622169;5184.507471790174;5033.848984530433;5143.27994080829;5147.202183661539;5148.279240906276;5156.432792392834;4659.58063774262;4693.249080147229;4701.459332176775;4702.177119004161;4778.689385190021;5125.256837758504;5144.048351055067;5159.716215608102;5167.870803229949;5242.266082748418;4797.808087676523;4964.429090654621;4968.378952630921;4970.229614409773;5029.899402012013;4932.975335123301;5058.974705126451;5107.284980102789;5115.87210319745;5193.013327467769;5016.473270306638;5021.974890125599;5029.245613157982;5062.139436295838;5096.464871188546;5048.444671086178;5054.721990290569;5061.645684802103;5067.391912970467;5122.871928201825;4199.580041995776;4240.38514415408;4243.915121697549;4309.245881970643;4363.694541382073;3803.676687481595;3816.637419445148;3852.114013776847;3860.092878173627;3876.089119057019;4417.911641767147;4423.336499525032;4424.247877860771;4429.424174857248;4481.7535035573355;5028.421731500851;5076.796928122908;5093.439721630618;5095.235714642759;5149.2791009258735;4380.408644832971;4407.889802754957;4414.359917811899;4456.866294011184;4458.308962110878;4646.4191976003;4651.186042442627;4653.162430762428;4703.623710103184;4705.153072446924;4748.857534273978;4818.71087734737;4830.106430310404;4868.586170175504;4877.292792545132;5030.899382012412;5072.721000345016;5094.821681241138;5167.509086636764;5169.250458683545;4794.352762377034;4821.54195351441;4840.080384726891;4887.633427492881;4910.263460480956;4985.052839960396;4985.5762260208285;4993.026359859792;4993.400791904995;5022.070916880389;4999.200127979506;5017.54842064216;5044;5098.082345177755;5155.819546315861;4891.926621100615;4930.802767889244;4938.1358262304675;4973.328600638867;4995.8001679932395;4909.9018019640125;4936.481669424658;4942.233953737176;4943.20908654628;4998.2752500886445;4806.639502037291;4816.833061532887;4839.056384005085;4875.488073752205;4944.456109827845;4970.428400733962;5012.47369026247;5028.723420211923;5089.592832573311;5090.287359769562;4765.213739732905;4805;4878.438979517401;4887.169181239126;4944.184209605519 11:21:22 INFO - PROCESS | 6439 | |1;ext.html;577.6505214345322;579.2035950567969;579.5247896724685;590.7843637072469;593.0866465642912;27599.03403380882;36891.0777230569;38242.99999999996;38352.42471362932;43523.56476435235;40230.79884600573;40619;40633.18733625326;40652.39021414681;40688.59311406892;7667.7316293929725;7738.264864837832;7758.495697779626;7825.647845846951;7832.216778322179;7688.154303026663;7777.105632852238;7778.49439786412;7779.533228006309;7784.104827944802;7776.572288524129;7821.804454888645;7823.100343460518;7832.765017049498;7835.451518393715;7707.730229441942;7711.845763084707;7730.149683534834;7751.224877512232;7764.611769411506;7661.808454788619;7676.9616151919445;7679;7720.613969301568;7730.536167829948;39000.219995600215;39017.21965560673;39317.80341098305;39350.21299573992;39381.60618393837;2876.3240638449947;3022.8337441440713;3163.57291765611;3669.633036696309;3742.7567208131386;25718.87140564304;27898.721012790018;28312;28382.716172838213;28383.85808070967;3432.433648448003;3510.613832478425;3596.4245720684826;3648.872289469856;3673.94489082664;254797;257462;257598;258041.70979145172;259159;29868.40263194724;53329;53759.19361209507;53868.73065634725;53880.19179712307;30866.84566577153;33320;33395.332093357996;33402.331953360794;33435.83282083574;12924.870751292554;13046.869531304565;13057.28184949837;13184.670383240496;13189.670258243621;10592;10818.29681070728;10828.566857325777;10830.133589312836;10834.891651083546;7716.7684969451;7729.922700773032;7809.843803123906;7827.452078354574;7832.765017049498;3013.367192889518;3056.587360706321;3069.2787195009155;3080.4609193391066;3084.4602194615854;869.1265278395173;877.5699907045629;932.4498545857977;959.1301236433075;973.6154219083564;26278.943460908045;26962.730372696024;27655.446891062067;27743.167704968884;27958.3010424741;893.2942975049768;917.6467060181744;926.1109335038304;933.8132373525322;947.8199142162968;13604.251766152758;14659.633509162357;14682.486112985995;14777.704445911237;14780.556583302518;398021;406739;605638;613949;617764;48490.272645910336;49123;49263;49280.753596232506;49311.75344123256;1072.4155335342257;1119.1270808769173;1130.2653275371074;1158.461315488302;1159.5477763672175;25901.611475828253;28255.29361765972;28624.42751145007;28897.42205155927;28979.56530652;40154.1969160621;40453.1909361817;40476.79761601173;40784;40839;291199;293231;294333;294845.56698763545;296708;21454.356369308945;21501.46246343854;22372.552548948603;23904.88047559751;25294.1147059852;38537.229255415295;38931.610683892795;39055.2188956225;39199;39819.800900996466;34175.14562135967;34275;34318.656813431546;34359.14102147366;34571.48142777911;33506.497402538494;33793.83103084469;33922.3215535683;34221.31557368889;34404.48393274053;33709.15727106842;34096.31807363888;34470.13824654404;34487.65512344945;34697.306053878274;30140.547891781203;31581.8420907894;31820.840895795372;31872.36255274928;32072.5189122168;23709.52580948337;24109.276721698378;24336.269911902673;24565.263042108767;24785 11:21:22 INFO - PROCESS | 6439 | |2;jquery.html;346.6568097583393;364.3805530597984;378.1925588867767;379.87084391306956;403.398935585977;12170.513179472822;12262.386880655966;13146.868531314683;15892.364305427769;16680.33278668852;16378.918105409486;16570.337186512526;16668.33326666932;16723.66552668949;16728.581785455368;4902.289168070628;4991.850244492671;5085.23721441783;5097.515736005073;5102.107131252034;3712.8700495482663;5094.592432605383;5177.430482646906;5181.5077567631015;5184.11869982104;3885.5337359516757;5761.683107429089;6028.939710602882;6051.576389652726;6181.505479561647;5957.6127551709;6056.757729690851;6086.3609321021095;6140.7850725224625;6155.907661385083;5316.229146773696;5325.467453254682;5329.173978033411;5331.786728530854;5332.946670533283;18950;19312.517187070436;19383.127759250867;19408.805911940843;19456.22175112994;1968.22255209193;1999.3102379678987;2368.6802281691926;2398.988005059981;2463.4580392313665;8902.73291801247;12530.68673283166;12847;13199.274039927801;13681;1716.5451155443818;1736.765536652561;1754.8771585988986;1758.6570618729354;1815.4462888818905;61703.69148154275;63003;63095;67311;73626.63186684139;9531.332806703604;9654.11744709775;9704.175145112744;9878.753031174278;10049.899501005042;13485;13510.189388636712;13515.59453216405;13521.323933803467;13529.255890926093;6678.365555272241;6963.1644202696;7072.858542829217;7117.786466406016;7204.783856484209;6579.572327798678;6709.463242940553;6826.112605361272;6838.7264509420065;6870.3473170048765;4146.3365861462025;4189.455370801777;4212.410262563244;4244.214820258262;4256.446661933991;1777.4489908128521;1779.332750218668;1782.8306310900443;1803.666321730484;1828.8902665840092;806.8507326144683;842.5997651115794;877.2806298835021;886.4636894678755;892.7723430525175;15854.44509442164;16352.264148113363;16591.41930032443;16617.584560386087;17249;823.4853216739538;835.3734698975768;839.5969934431507;848.0628905059943;850.1073872433919;9007.324450666096;9565.139137477661;9566.56950437232;9588.137067663944;9696.563654635558;350793;361094;366518;366932;367857;77383.61308193424;77437.6128119367;79943.60028199822;80062;80503;875.2778957360331;895.167494230359;907.9682211122579;915.0254978448064;919.2645883293338;14494.202818845064;14547.927260363631;14937.477188298357;15154.16652084146;15561.68876622484;37320;37475.625243747214;37490;37658.43512347262;38360.2327953445;47419;48224.75887620539;48609;50101;51507.22739158841;10196.541155647865;10718.24972251935;10904.400257985886;11325.433728313386;11369.54521819151;7152.141742990874;9808.607655693691;12661.87338126607;12971.573126956217;13091.869081309065;10664.253502254767;10676.733081673021;10840.403777792297;10883.238173328107;11270.211085223955;11003.22977391607;11311.434428278717;11486.540538378371;11746.530138794353;11832.408379581158;6961.686724097529;10369.429681367597;11208.495617697386;11684.298942063504;11803.350815705218;10529.157667386438;10603.41681207541;10937.28907621034;11568.88431115678;11657.591984280509;10655.14758819277;10973.561057557929;11104.666859994213;11268.7746245073;11290.943545282222 11:21:22 INFO - PROCESS | 6439 | |3;mootools.html;1253.9310337931422;1373.745857016452;1409.69691516324;1494.86546210841;1709.914504274786;6923.757668481604;7465.9626701866555;7625.8474830503355;7875.8424831503335;7879.093904201019;7892.250236227564;7983.481073730218;8013.158618345077;8018.077921039082;8087.231712987272;2184.650455927052;2195.6267434536167;2208.63557513011;2215.2578886073184;2215.667649852519;2130.286354071388;2154.3213887625348;2194.4952660888007;2206.8124209442217;2210.7789221077924;2151.3008272311563;2178.3791619388476;2181.0730439563204;2181.727284089489;2184.7815218478186;2129.2654034358197;2134.893255337227;2136.487243061654;2140.090461553849;2143.2605751015954;2124.649432843579;2151.601953638582;2173.250228671106;2174.934751957444;2179.084784390544;7835.725749598737;7886.329661978739;7985.920140798576;8103.351731861437;8110.391720620977;4664.416947881515;4842.15262329091;4847.75761211938;4924.113659541281;4928.433230178503;2948.616679831608;3044.725974662291;3078.2458297717203;3079.92300192497;3103.487924492456;959.5298303831142;968.8110818390417;971.961121555137;972.7130496503478;977.9315447918649;10992.670219893416;11076.224664273504;11079.279846809932;11093.611723589716;11109.722256943642;4089.734167279117;4207.852725154605;4208.7685177314925;4219.493660760729;4240.78796060202;8450.704225352083;8476.152384761597;8479.95760021196;8482.194191551793;8491.320694344562;4734.55021772931;4745.098431298043;4748.572628463455;4749.4775574686755;4751.049790042005;3569.964300356963;3737.5328083989502;4046.676265898721;4398.868033958986;4418.756968366771;3413.180836599248;3452.4993875887853;3496.4755286707195;3559.6974257187912;3577.94633080504;1068.9251752377259;1084.322298563398;1090.4220762995626;1091.1380009792176;1093.7703082352637;676.0197713315712;714.0681410759009;772.6561680052323;808.3250485844268;849.3417601358873;4987.501249875056;5102.591792656653;5136.897262054738;5150.922736158961;5369.275147855068;403.3324847377595;408.79151632667555;410.419256751699;414.1551235479648;418.5960548071126;3376.4766461198556;3415.316936612687;3425.400554902882;3452.067941655739;3554.360215161296;9533.332666713264;10008.299419040597;10009.799804004026;10011.099001089937;10013.349132306377;9945.403275803475;9968.601255949681;9983.351082179635;9998.900010999942;10035.448050357154;7510.061242344707;7515.436342274351;7539.660715267826;7588.62056897153;7591.3926885849;5038.899222015612;5063.797448102035;5086.364204474441;5165.225216217597;5313.309269794902;9035.638574456949;9087.182153606207;9096.317776166681;9096.454212747256;9209.723708288762;7082.256363081802;9203.585838637411;9289.02465241167;9381.061893810564;9404.341696081483;5786.30564332266;6143.232095988002;6403.743850245938;6404.359564043559;6416.390442907917;6945.513814032969;7353.080864891888;7527.473076884566;7574.242575742382;7772.805679858049;6805.727770889109;6876.621785801829;6978.267281935324;7016.087908571853;7154.821129471805;6568.80293591193;6733.192016957801;6891.71442215838;7046.260142684944;7072.045273887959;6159.907601385893;6233.532485063729;6242.063690446288;6242.719077641426;6251.749930002749;4218.240716671029;4269.082147338338;4291.871243862689;4351.586599273064;4402.757848318373;4472.463304403493;4497.572730590588;4513.277875539898;4514.503404625423;4566.725996440225 11:21:22 INFO - PROCESS | 6439 | |4;prototype.html;277.7597378267799;279.13050846612794;279.17782131622374;281.445552262044;286.96412948381453;4636.397268355117;4777.235642297233;4789;4841.152798260308;4846.636502262331;4561.475430325513;4686.882827929304;4732.621390288778;4741.193997020506;4749.525047495249;3593.7843729376323;3768.491253680759;3768.679662228714;3777.452269420946;3786.7917264550438;3648.066524741878;3686.9307900708764;3738.2336620992633;3745.176061266517;3751.836930551524;3694.817658349329;3707.1844194277214;3718.6653201211884;3718.7396882218254;3726.217494326195;3664.047347689593;3711.32784395235;3724;3727.384981478053;3727.7949712765785;3211.550382946389;3284.8193349365774;3287.126337987348;3291.358185153896;3295.577750353488;4660.766961651904;4682.29765535169;4684.718916864999;4690.9530904690855;4692.686047906592;4214.85248016321;4240.745555266694;4248.511421186572;4251.383549385322;4252.55348188442;4791.089692958327;4983.302337672729;4988.376452943382;4996.175631020914;5025.1708468102715;3549.846299952526;3550.55618047744;3550.928981420383;3557.8576856925692;3560.9109772255642;5205.765740541685;5234.685918844882;5239.292695486137;5251.317328747238;5269.420363759983;3511.6839484446523;3584.7849129052343;3591.9281614367565;3614.566252049718;3617.963820361763;3641.289948460025;3651.1054791576234;3653.780773153619;3665.2119794244363;3668;4185.769782661922;4188.455500784939;4189.916201675949;4213.557576454489;4213.641840443596;4771.498992605726;4834.613230941586;4893;5006.874828129253;5016.172331565251;1232.950681972729;1257.5787111317627;1264.7723409786327;1266.7016308284083;1267.645059383374;770.2990278846335;807.1524898856295;811.667216441268;817.6484111831851;819.4509678515409;3976.6280633181505;3997.2804895119157;4000.179963107556;4008.5590585035625;4008.9198216035516;4558.042811009659;4591.79336929839;4594.208258779079;4599.171509521687;4600.378948841863;3955.307821131348;3973.642372186517;3993.3843332617184;3995.84016639337;4012.6990475713856;2303.550807592537;2418.7301666625162;2422.9030838766603;2429.769171928664;2443.5705112509027;4293.484781826201;4325.826966921288;4335.219660461147;4346.826126954949;4391.890202744893;4636.2581986882615;4638.350630911675;4666.2067448533835;4692.671512994126;4725.527447255247;4064.7561146331313;4328.329108988112;4329.740215587075;4337.501187363494;4343.261645520269;4531.365608814703;4535.614472769851;4546.40896683429;4550.954490455053;4554.840580579664;4447.421165486206;4460.910781784281;4474.731516109044;4490.730556166641;4492;4156.314208155621;4331.83408295852;4334.5882141196535;4391.7584532851;4410.6030457259;3271.2966712157;3283.7701360904507;3288.6875746804017;3294.6046474423224;3321.75086868481;4562.038323520918;4570.954290457053;4588.587027167571;4589.242774942097;4891.823138703385;4861.611071114232;4922.72924989129;4931.778069986787;4995.450500444876;4996.575291100297;5002;5022.020705962303;5022.447530771539;5025.6077147925735;5030.2957585937265;4801.207800712843;4946.975265123651;4951.737306986695;4967.776450059684;4970.900581988412;5004.199328107486;5025.522575355335;5033.521815427529;5042.344495215599;5045.048646541814;4908.582770464551;4914.631402644744;4917.164082105979;4933.358663373882;4938.308636790924 11:21:22 INFO - PROCESS | 6439 | |5;yui.html;647.5693663713631;651.781653146196;677;680.0445374249178;731.9524230924993;12329.383530823457;13581;13606.659833504154;13611.455541778329;13623.591292261222;13120.278384688838;13158.671033224151;13254.867451325485;13262.204267743919;13271.800922986164;618.576275251452;633.6293268437969;637.2830565613684;749.1983577571987;770.4144849914078;636.3159603426312;741.8182545276414;764.9770506884803;769.5844244108175;775.1008829757483;830.6013113705425;831.8336332733447;831.9001719793633;832.7501749475164;836.9246767790897;824.7072289337319;825.8554752918216;826.1862065865118;826.3224156191925;826.8842362069315;483.49233305029577;490.4237520912949;579.0619196901047;595.1519085303426;608.8447445901311;12191.695207619792;12206.145569810116;12228.082893782914;12231.449584768707;12235;11978.580749673807;12206.816897746541;12362.876371236352;13288.26914519701;13733.45066197351;12146.635600931986;12238.449269782881;12259.387030648431;12379.071569632313;12743;3950.920981580381;3979.5821438748803;3988.641022307977;4164.354525048622;4166.208420400145;58647.70676146635;59700.402995970355;68790.31209687889;69392.6530367345;69716;9606.759831004141;9655.758606034906;9892.950535247423;10042.899571004196;10126.848097278547;19361.612767744566;19938.401847944584;20008.89995550042;20014.399568012985;20111.798882011284;6860.451163906975;6927.3419025192525;7209.134903811576;7331.8900216496795;7631.122420921554;3652.926941461209;3917.4319723640483;3940.7438516496336;3953.5651078381356;3981.9845939285874;2958.6745457999605;3070.1250143708935;3078.3227689908185;3086.074177746667;3111.4243864884616;511.6418507045009;522.2551928783383;536.1048692870684;537.2666310486159;537.2773619481869;565.5899472882128;617.2685367839125;621.6191984698594;621.8662987457628;626.2203556572006;8222.83554328922;8288.627011784483;8692.869606955901;8725.301975841918;8914.197722205032;488.1457449463439;501.2581379558274;556.3073972903761;562.8255240875342;564.5906717629767;3972.860949866799;4132.421460995463;4136.565660605593;4143.958560414418;4254.510731265882;56481.71759141178;56842.14736778952;92090.07909920948;102014.48992754989;105161.47419262855;79507;87896.56051719701;88451.55774221088;89268;90812.5459372712;45800.770996144805;62862.685686572186;79555.60222198968;80538;81023.59488202521;7560.432967527568;8038.141691987762;8069.394795390486;8257.752267431986;8287.50274983503;40603.390949135195;44493.55506445024;46537.534624654676;46728;46938.357157499326;41512.79243603763;63522.682386587774;66327.33672663405;66554.66722666356;66757.33242667512;9843.163331116935;9863.753406164904;10076.445795481319;10400.843987340348;10409.063184313449;10730.980556847087;10800.783984320113;11534.250273732181;11570.742210083517;11573.768524629628;10408.791824163625;10431.947840261053;10455.634052808115;11411.885881141414;12089.81865272004;9539;11251.099912007183;11773.76452470963;11875.346855923008;11937.46281417321;11517.596884109016;12025.4588543514;12087.516499339928;12319.876801231872;12628.179168354027;9955.50222488887;10198.483297387265;10465.058144767008;10515.684529464128;10848.294860834021;10164.33931794431;10559.894401055892;10570.2600817942;10762.04043887937;10968.725781855517 11:21:22 INFO - PROCESS | 6439 | __end_tp_report 11:21:22 INFO - PROCESS | 6439 | __start_cc_report 11:21:22 INFO - PROCESS | 6439 | _x_x_mozilla_cycle_collect,1380 11:21:22 INFO - PROCESS | 6439 | __end_cc_report 11:21:22 INFO - PROCESS | 6439 | __startTimestamp1474654881999__endTimestamp 11:21:22 INFO - PROCESS | 6439 | 11:21:22 INFO - PROCESS | 6439 | ------- Summary: start ------- 11:21:22 INFO - PROCESS | 6439 | Number of tests: 6 11:21:22 INFO - PROCESS | 6439 | 11:21:22 INFO - PROCESS | 6439 | [#0] dojo.html Cycles:165 Average:4721.45 Median:4838.35 stddev:476.34 (9.8%) stddev-sans-first:448.60 11:21:22 INFO - PROCESS | 6439 | Values: 2628.1 2635.6 2674.6 2681.7 2697.2 4697.2 4699.6 4763.9 4793.2 4813.2 4831.1 4831.5 4838.3 4842.9 4849.1 4366.5 4397.6 4422.6 4433.3 4491.5 4426.2 4458.3 4497.8 4516.0 4518.5 4443.7 4480.4 4556.4 4580.0 4580.5 4513.5 4536.5 4579.6 4593.7 4594.1 4335.3 4378.1 4384.7 4387.4 4395.3 4696.7 4704.1 4704.7 4740.5 4748.6 5019.0 5034.2 5114.7 5121.5 5184.5 5033.8 5143.3 5147.2 5148.3 5156.4 4659.6 4693.2 4701.5 4702.2 4778.7 5125.3 5144.0 5159.7 5167.9 5242.3 4797.8 4964.4 4968.4 4970.2 5029.9 4933.0 5059.0 5107.3 5115.9 5193.0 5016.5 5022.0 5029.2 5062.1 5096.5 5048.4 5054.7 5061.6 5067.4 5122.9 4199.6 4240.4 4243.9 4309.2 4363.7 3803.7 3816.6 3852.1 3860.1 3876.1 4417.9 4423.3 4424.2 4429.4 4481.8 5028.4 5076.8 5093.4 5095.2 5149.3 4380.4 4407.9 4414.4 4456.9 4458.3 4646.4 4651.2 4653.2 4703.6 4705.2 4748.9 4818.7 4830.1 4868.6 4877.3 5030.9 5072.7 5094.8 5167.5 5169.3 4794.4 4821.5 4840.1 4887.6 4910.3 4985.1 4985.6 4993.0 4993.4 5022.1 4999.2 5017.5 5044.0 5098.1 5155.8 4891.9 4930.8 4938.1 4973.3 4995.8 4909.9 4936.5 4942.2 4943.2 4998.3 4806.6 4816.8 4839.1 4875.5 4944.5 4970.4 5012.5 5028.7 5089.6 5090.3 4765.2 4805.0 4878.4 4887.2 4944.2 11:21:22 INFO - PROCESS | 6439 | 11:21:22 INFO - PROCESS | 6439 | [#1] ext.html Cycles:180 Average:49168.48 Median:19103.96 stddev:102769.26 (537.9%) stddev-sans-first:102992.80 11:21:22 INFO - PROCESS | 6439 | Values: 577.7 579.2 579.5 590.8 593.1 27599.0 36891.1 38243.0 38352.4 43523.6 40230.8 40619.0 40633.2 40652.4 40688.6 7667.7 7738.3 7758.5 7825.6 7832.2 7688.2 7777.1 7778.5 7779.5 7784.1 7776.6 7821.8 7823.1 7832.8 7835.5 7707.7 7711.8 7730.1 7751.2 7764.6 7661.8 7677.0 7679.0 7720.6 7730.5 39000.2 39017.2 39317.8 39350.2 39381.6 2876.3 3022.8 3163.6 3669.6 3742.8 25718.9 27898.7 28312.0 28382.7 28383.9 3432.4 3510.6 3596.4 3648.9 3673.9 254797.0 257462.0 257598.0 258041.7 259159.0 29868.4 53329.0 53759.2 53868.7 53880.2 30866.8 33320.0 33395.3 33402.3 33435.8 12924.9 13046.9 13057.3 13184.7 13189.7 10592.0 10818.3 10828.6 10830.1 10834.9 7716.8 7729.9 7809.8 7827.5 7832.8 3013.4 3056.6 3069.3 3080.5 3084.5 869.1 877.6 932.4 959.1 973.6 26278.9 26962.7 27655.4 27743.2 27958.3 893.3 917.6 926.1 933.8 947.8 13604.3 14659.6 14682.5 14777.7 14780.6 398021.0 406739.0 605638.0 613949.0 617764.0 48490.3 49123.0 49263.0 49280.8 49311.8 1072.4 1119.1 1130.3 1158.5 1159.5 25901.6 28255.3 28624.4 28897.4 28979.6 40154.2 40453.2 40476.8 40784.0 40839.0 291199.0 293231.0 294333.0 294845.6 296708.0 21454.4 21501.5 22372.6 23904.9 25294.1 38537.2 38931.6 39055.2 39199.0 39819.8 34175.1 34275.0 34318.7 34359.1 34571.5 33506.5 33793.8 33922.3 34221.3 34404.5 33709.2 34096.3 34470.1 34487.7 34697.3 30140.5 31581.8 31820.8 31872.4 32072.5 23709.5 24109.3 24336.3 24565.3 24785.0 11:21:22 INFO - PROCESS | 6439 | 11:21:22 INFO - PROCESS | 6439 | [#2] jquery.html Cycles:180 Average:23645.78 Median:37397.81 stddev:59992.36 (160.4%) stddev-sans-first:60135.14 11:21:22 INFO - PROCESS | 6439 | Values: 346.7 364.4 378.2 379.9 403.4 12170.5 12262.4 13146.9 15892.4 16680.3 16378.9 16570.3 16668.3 16723.7 16728.6 4902.3 4991.9 5085.2 5097.5 5102.1 3712.9 5094.6 5177.4 5181.5 5184.1 3885.5 5761.7 6028.9 6051.6 6181.5 5957.6 6056.8 6086.4 6140.8 6155.9 5316.2 5325.5 5329.2 5331.8 5332.9 18950.0 19312.5 19383.1 19408.8 19456.2 1968.2 1999.3 2368.7 2399.0 2463.5 8902.7 12530.7 12847.0 13199.3 13681.0 1716.5 1736.8 1754.9 1758.7 1815.4 61703.7 63003.0 63095.0 67311.0 73626.6 9531.3 9654.1 9704.2 9878.8 10049.9 13485.0 13510.2 13515.6 13521.3 13529.3 6678.4 6963.2 7072.9 7117.8 7204.8 6579.6 6709.5 6826.1 6838.7 6870.3 4146.3 4189.5 4212.4 4244.2 4256.4 1777.4 1779.3 1782.8 1803.7 1828.9 806.9 842.6 877.3 886.5 892.8 15854.4 16352.3 16591.4 16617.6 17249.0 823.5 835.4 839.6 848.1 850.1 9007.3 9565.1 9566.6 9588.1 9696.6 350793.0 361094.0 366518.0 366932.0 367857.0 77383.6 77437.6 79943.6 80062.0 80503.0 875.3 895.2 908.0 915.0 919.3 14494.2 14547.9 14937.5 15154.2 15561.7 37320.0 37475.6 37490.0 37658.4 38360.2 47419.0 48224.8 48609.0 50101.0 51507.2 10196.5 10718.2 10904.4 11325.4 11369.5 7152.1 9808.6 12661.9 12971.6 13091.9 10664.3 10676.7 10840.4 10883.2 11270.2 11003.2 11311.4 11486.5 11746.5 11832.4 6961.7 10369.4 11208.5 11684.3 11803.4 10529.2 10603.4 10937.3 11568.9 11657.6 10655.1 10973.6 11104.7 11268.8 11290.9 11:21:22 INFO - PROCESS | 6439 | 11:21:22 INFO - PROCESS | 6439 | [#3] mootools.html Cycles:180 Average:5130.01 Median:4796.60 stddev:2951.44 (61.5%) stddev-sans-first:2945.35 11:21:22 INFO - PROCESS | 6439 | Values: 1253.9 1373.7 1409.7 1494.9 1709.9 6923.8 7466.0 7625.8 7875.8 7879.1 7892.3 7983.5 8013.2 8018.1 8087.2 2184.7 2195.6 2208.6 2215.3 2215.7 2130.3 2154.3 2194.5 2206.8 2210.8 2151.3 2178.4 2181.1 2181.7 2184.8 2129.3 2134.9 2136.5 2140.1 2143.3 2124.6 2151.6 2173.3 2174.9 2179.1 7835.7 7886.3 7985.9 8103.4 8110.4 4664.4 4842.2 4847.8 4924.1 4928.4 2948.6 3044.7 3078.2 3079.9 3103.5 959.5 968.8 972.0 972.7 977.9 10992.7 11076.2 11079.3 11093.6 11109.7 4089.7 4207.9 4208.8 4219.5 4240.8 8450.7 8476.2 8480.0 8482.2 8491.3 4734.6 4745.1 4748.6 4749.5 4751.0 3570.0 3737.5 4046.7 4398.9 4418.8 3413.2 3452.5 3496.5 3559.7 3577.9 1068.9 1084.3 1090.4 1091.1 1093.8 676.0 714.1 772.7 808.3 849.3 4987.5 5102.6 5136.9 5150.9 5369.3 403.3 408.8 410.4 414.2 418.6 3376.5 3415.3 3425.4 3452.1 3554.4 9533.3 10008.3 10009.8 10011.1 10013.3 9945.4 9968.6 9983.4 9998.9 10035.4 7510.1 7515.4 7539.7 7588.6 7591.4 5038.9 5063.8 5086.4 5165.2 5313.3 9035.6 9087.2 9096.3 9096.5 9209.7 7082.3 9203.6 9289.0 9381.1 9404.3 5786.3 6143.2 6403.7 6404.4 6416.4 6945.5 7353.1 7527.5 7574.2 7772.8 6805.7 6876.6 6978.3 7016.1 7154.8 6568.8 6733.2 6891.7 7046.3 7072.0 6159.9 6233.5 6242.1 6242.7 6251.7 4218.2 4269.1 4291.9 4351.6 4402.8 4472.5 4497.6 4513.3 4514.5 4566.7 11:21:22 INFO - PROCESS | 6439 | 11:21:22 INFO - PROCESS | 6439 | [#4] prototype.html Cycles:180 Average:3982.51 Median:4345.04 stddev:1153.88 (26.6%) stddev-sans-first:1123.12 11:21:22 INFO - PROCESS | 6439 | Values: 277.8 279.1 279.2 281.4 287.0 4636.4 4777.2 4789.0 4841.2 4846.6 4561.5 4686.9 4732.6 4741.2 4749.5 3593.8 3768.5 3768.7 3777.5 3786.8 3648.1 3686.9 3738.2 3745.2 3751.8 3694.8 3707.2 3718.7 3718.7 3726.2 3664.0 3711.3 3724.0 3727.4 3727.8 3211.6 3284.8 3287.1 3291.4 3295.6 4660.8 4682.3 4684.7 4691.0 4692.7 4214.9 4240.7 4248.5 4251.4 4252.6 4791.1 4983.3 4988.4 4996.2 5025.2 3549.8 3550.6 3550.9 3557.9 3560.9 5205.8 5234.7 5239.3 5251.3 5269.4 3511.7 3584.8 3591.9 3614.6 3618.0 3641.3 3651.1 3653.8 3665.2 3668.0 4185.8 4188.5 4189.9 4213.6 4213.6 4771.5 4834.6 4893.0 5006.9 5016.2 1233.0 1257.6 1264.8 1266.7 1267.6 770.3 807.2 811.7 817.6 819.5 3976.6 3997.3 4000.2 4008.6 4008.9 4558.0 4591.8 4594.2 4599.2 4600.4 3955.3 3973.6 3993.4 3995.8 4012.7 2303.6 2418.7 2422.9 2429.8 2443.6 4293.5 4325.8 4335.2 4346.8 4391.9 4636.3 4638.4 4666.2 4692.7 4725.5 4064.8 4328.3 4329.7 4337.5 4343.3 4531.4 4535.6 4546.4 4551.0 4554.8 4447.4 4460.9 4474.7 4490.7 4492.0 4156.3 4331.8 4334.6 4391.8 4410.6 3271.3 3283.8 3288.7 3294.6 3321.8 4562.0 4571.0 4588.6 4589.2 4891.8 4861.6 4922.7 4931.8 4995.5 4996.6 5002.0 5022.0 5022.4 5025.6 5030.3 4801.2 4947.0 4951.7 4967.8 4970.9 5004.2 5025.5 5033.5 5042.3 5045.0 4908.6 4914.6 4917.2 4933.4 4938.3 11:21:22 INFO - PROCESS | 6439 | 11:21:22 INFO - PROCESS | 6439 | [#5] yui.html Cycles:180 Average:17392.60 Median:46833.18 stddev:24575.30 (52.5%) stddev-sans-first:24612.08 11:21:22 INFO - PROCESS | 6439 | Values: 647.6 651.8 677.0 680.0 732.0 12329.4 13581.0 13606.7 13611.5 13623.6 13120.3 13158.7 13254.9 13262.2 13271.8 618.6 633.6 637.3 749.2 770.4 636.3 741.8 765.0 769.6 775.1 830.6 831.8 831.9 832.8 836.9 824.7 825.9 826.2 826.3 826.9 483.5 490.4 579.1 595.2 608.8 12191.7 12206.1 12228.1 12231.4 12235.0 11978.6 12206.8 12362.9 13288.3 13733.5 12146.6 12238.4 12259.4 12379.1 12743.0 3950.9 3979.6 3988.6 4164.4 4166.2 58647.7 59700.4 68790.3 69392.7 69716.0 9606.8 9655.8 9893.0 10042.9 10126.8 19361.6 19938.4 20008.9 20014.4 20111.8 6860.5 6927.3 7209.1 7331.9 7631.1 3652.9 3917.4 3940.7 3953.6 3982.0 2958.7 3070.1 3078.3 3086.1 3111.4 511.6 522.3 536.1 537.3 537.3 565.6 617.3 621.6 621.9 626.2 8222.8 8288.6 8692.9 8725.3 8914.2 488.1 501.3 556.3 562.8 564.6 3972.9 4132.4 4136.6 4144.0 4254.5 56481.7 56842.1 92090.1 102014.5 105161.5 79507.0 87896.6 88451.6 89268.0 90812.5 45800.8 62862.7 79555.6 80538.0 81023.6 7560.4 8038.1 8069.4 8257.8 8287.5 40603.4 44493.6 46537.5 46728.0 46938.4 41512.8 63522.7 66327.3 66554.7 66757.3 9843.2 9863.8 10076.4 10400.8 10409.1 10731.0 10800.8 11534.3 11570.7 11573.8 10408.8 10431.9 10455.6 11411.9 12089.8 9539.0 11251.1 11773.8 11875.3 11937.5 11517.6 12025.5 12087.5 12319.9 12628.2 9955.5 10198.5 10465.1 10515.7 10848.3 10164.3 10559.9 10570.3 10762.0 10968.7 11:21:22 INFO - PROCESS | 6439 | -------- Summary: end -------- 11:21:22 INFO - PROCESS | 6439 | 11:21:22 INFO - TEST-INFO | 6439: exit 0 11:21:22 INFO - TEST-OK | dromaeo_css | took 1124048ms 11:21:22 INFO - TEST-START | kraken 11:21:22 INFO - operating with platform_type : linux_ 11:21:22 INFO - Initialising browser for kraken test... 11:21:22 INFO - TEST-INFO | started process 6749 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplNsZJe/profile http://localhost:51078/getInfo.html) 11:21:27 INFO - PROCESS | 6749 | __metrics Screen width/height:1600/1200 11:21:27 INFO - PROCESS | 6749 | colorDepth:24 11:21:27 INFO - PROCESS | 6749 | Browser inner width/height: 1024/697 11:21:27 INFO - PROCESS | 6749 | __metrics 11:21:27 INFO - PROCESS | 6749 | 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" 11:21:27 INFO - PROCESS | 6749 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:21:28 INFO - TEST-INFO | 6749: exit 0 11:21:28 INFO - Browser initialized. 11:21:28 INFO - Running cycle 1/1 for kraken test... 11:21:28 INFO - TEST-INFO | started process 6830 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplNsZJe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:41 INFO - PROCESS | 6830 | RSS: Main: 175390720 11:21:41 INFO - PROCESS | 6830 | 11:21:43 INFO - PROCESS | 6830 | Cycle 1(1): loaded http://localhost:51078/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51078/tests/kraken/driver.html?testName=audio-beat-detection) 11:21:44 INFO - PROCESS | 6830 | RSS: Main: 242069504 11:21:44 INFO - PROCESS | 6830 | 11:21:47 INFO - PROCESS | 6830 | Cycle 1(1): loaded http://localhost:51078/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51078/tests/kraken/driver.html?testName=audio-dft) 11:21:48 INFO - PROCESS | 6830 | RSS: Main: 217833472 11:21:48 INFO - PROCESS | 6830 | 11:21:51 INFO - PROCESS | 6830 | Cycle 1(1): loaded http://localhost:51078/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51078/tests/kraken/driver.html?testName=audio-fft) 11:21:52 INFO - PROCESS | 6830 | RSS: Main: 300380160 11:21:52 INFO - PROCESS | 6830 | 11:21:54 INFO - PROCESS | 6830 | Cycle 1(1): loaded http://localhost:51078/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51078/tests/kraken/driver.html?testName=audio-oscillator) 11:21:54 INFO - PROCESS | 6830 | RSS: Main: 208707584 11:21:54 INFO - PROCESS | 6830 | 11:21:57 INFO - PROCESS | 6830 | Cycle 1(1): loaded http://localhost:51078/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51078/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:21:57 INFO - PROCESS | 6830 | RSS: Main: 213430272 11:21:57 INFO - PROCESS | 6830 | 11:22:01 INFO - PROCESS | 6830 | Cycle 1(1): loaded http://localhost:51078/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51078/tests/kraken/driver.html?testName=imaging-darkroom) 11:22:01 INFO - PROCESS | 6830 | RSS: Main: 249704448 11:22:01 INFO - PROCESS | 6830 | 11:22:05 INFO - PROCESS | 6830 | Cycle 1(1): loaded http://localhost:51078/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51078/tests/kraken/driver.html?testName=imaging-desaturate) 11:22:05 INFO - PROCESS | 6830 | RSS: Main: 249778176 11:22:05 INFO - PROCESS | 6830 | 11:22:08 INFO - PROCESS | 6830 | Cycle 1(1): loaded http://localhost:51078/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51078/tests/kraken/driver.html?testName=json-parse-financial) 11:22:09 INFO - PROCESS | 6830 | RSS: Main: 249413632 11:22:09 INFO - PROCESS | 6830 | 11:22:10 INFO - PROCESS | 6830 | Cycle 1(1): loaded http://localhost:51078/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51078/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:22:11 INFO - PROCESS | 6830 | RSS: Main: 212017152 11:22:11 INFO - PROCESS | 6830 | 11:22:13 INFO - PROCESS | 6830 | Cycle 1(1): loaded http://localhost:51078/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51078/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:22:14 INFO - PROCESS | 6830 | RSS: Main: 218484736 11:22:14 INFO - PROCESS | 6830 | 11:22:16 INFO - PROCESS | 6830 | Cycle 1(1): loaded http://localhost:51078/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51078/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:22:16 INFO - PROCESS | 6830 | RSS: Main: 223449088 11:22:16 INFO - PROCESS | 6830 | 11:22:19 INFO - PROCESS | 6830 | Cycle 1(1): loaded http://localhost:51078/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51078/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:22:20 INFO - PROCESS | 6830 | RSS: Main: 224501760 11:22:20 INFO - PROCESS | 6830 | 11:22:23 INFO - PROCESS | 6830 | Cycle 1(1): loaded http://localhost:51078/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51078/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:22:23 INFO - PROCESS | 6830 | RSS: Main: 222306304 11:22:23 INFO - PROCESS | 6830 | 11:22:25 INFO - PROCESS | 6830 | Cycle 1(1): loaded http://localhost:51078/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51078/tests/kraken/driver.html?testName=ai-astar) 11:22:25 INFO - PROCESS | 6830 | RSS: Main: 273690624 11:22:25 INFO - PROCESS | 6830 | 11:22:25 INFO - PROCESS | 6830 | __start_tp_report 11:22:25 INFO - PROCESS | 6830 | _x_x_mozilla_page_load 11:22:25 INFO - PROCESS | 6830 | _x_x_mozilla_page_load_details 11:22:25 INFO - PROCESS | 6830 | |i|pagename|runs| 11:22:25 INFO - PROCESS | 6830 | |0;ai-astar;111;115;115;114;113;114;114;114;113;113 11:22:25 INFO - PROCESS | 6830 | |1;audio-beat-detection;161;125;132;161;124;124;128;126;171;127 11:22:25 INFO - PROCESS | 6830 | |2;audio-dft;161;160;160;160;161;161;162;161;160;161 11:22:25 INFO - PROCESS | 6830 | |3;audio-fft;75;78;76;109;77;77;76;76;108;75 11:22:25 INFO - PROCESS | 6830 | |4;audio-oscillator;85;83;115;84;84;83;120;83;84;118 11:22:25 INFO - PROCESS | 6830 | |5;imaging-gaussian-blur;117;117;117;117;117;118;118;117;118;117 11:22:25 INFO - PROCESS | 6830 | |6;imaging-darkroom;149;146;147;147;145;146;146;147;146;146 11:22:25 INFO - PROCESS | 6830 | |7;imaging-desaturate;94;95;95;96;95;95;95;95;95;96 11:22:25 INFO - PROCESS | 6830 | |8;json-parse-financial;63;63;63;63;71;63;65;62;64;64 11:22:25 INFO - PROCESS | 6830 | |9;json-stringify-tinderbox;66;66;67;66;68;66;67;67;66;67 11:22:26 INFO - PROCESS | 6830 | |10;stanford-crypto-aes;82;82;83;83;89;82;82;82;82;82 11:22:26 INFO - PROCESS | 6830 | |11;stanford-crypto-ccm;134;134;133;154;136;132;135;134;174;144 11:22:26 INFO - PROCESS | 6830 | |12;stanford-crypto-pbkdf2;173;175;179;176;176;175;176;172;176;179 11:22:26 INFO - PROCESS | 6830 | |13;stanford-crypto-sha256-iterative;69;70;69;69;73;69;69;70;70;69 11:22:26 INFO - PROCESS | 6830 | __end_tp_report 11:22:26 INFO - PROCESS | 6830 | __start_cc_report 11:22:26 INFO - PROCESS | 6830 | _x_x_mozilla_cycle_collect,1923 11:22:26 INFO - PROCESS | 6830 | __end_cc_report 11:22:26 INFO - PROCESS | 6830 | __startTimestamp1474654945993__endTimestamp 11:22:26 INFO - PROCESS | 6830 | 11:22:26 INFO - PROCESS | 6830 | ------- Summary: start ------- 11:22:26 INFO - PROCESS | 6830 | Number of tests: 14 11:22:26 INFO - PROCESS | 6830 | 11:22:26 INFO - PROCESS | 6830 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:1.17 (1.0%) stddev-sans-first:0.78 11:22:26 INFO - PROCESS | 6830 | Values: 111.0 115.0 115.0 114.0 113.0 114.0 114.0 114.0 113.0 113.0 11:22:26 INFO - PROCESS | 6830 | 11:22:26 INFO - PROCESS | 6830 | [#1] audio-beat-detection Cycles:10 Average:137.90 Median:130.00 stddev:18.59 (14.3%) stddev-sans-first:17.73 11:22:26 INFO - PROCESS | 6830 | Values: 161.0 125.0 132.0 161.0 124.0 124.0 128.0 126.0 171.0 127.0 11:22:26 INFO - PROCESS | 6830 | 11:22:26 INFO - PROCESS | 6830 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 11:22:26 INFO - PROCESS | 6830 | Values: 161.0 160.0 160.0 160.0 161.0 161.0 162.0 161.0 160.0 161.0 11:22:26 INFO - PROCESS | 6830 | 11:22:26 INFO - PROCESS | 6830 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.00 stddev:13.63 (17.9%) stddev-sans-first:14.17 11:22:26 INFO - PROCESS | 6830 | Values: 75.0 78.0 76.0 109.0 77.0 77.0 76.0 76.0 108.0 75.0 11:22:26 INFO - PROCESS | 6830 | 11:22:26 INFO - PROCESS | 6830 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:83.50 stddev:16.45 (19.7%) stddev-sans-first:17.14 11:22:26 INFO - PROCESS | 6830 | Values: 85.0 83.0 115.0 84.0 84.0 83.0 120.0 83.0 84.0 118.0 11:22:26 INFO - PROCESS | 6830 | 11:22:26 INFO - PROCESS | 6830 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 11:22:26 INFO - PROCESS | 6830 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 118.0 117.0 11:22:26 INFO - PROCESS | 6830 | 11:22:26 INFO - PROCESS | 6830 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:1.08 (0.7%) stddev-sans-first:0.67 11:22:26 INFO - PROCESS | 6830 | Values: 149.0 146.0 147.0 147.0 145.0 146.0 146.0 147.0 146.0 146.0 11:22:26 INFO - PROCESS | 6830 | 11:22:26 INFO - PROCESS | 6830 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 11:22:26 INFO - PROCESS | 6830 | Values: 94.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 11:22:26 INFO - PROCESS | 6830 | 11:22:26 INFO - PROCESS | 6830 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:63.50 stddev:2.56 (4.0%) stddev-sans-first:2.68 11:22:26 INFO - PROCESS | 6830 | Values: 63.0 63.0 63.0 63.0 71.0 63.0 65.0 62.0 64.0 64.0 11:22:26 INFO - PROCESS | 6830 | 11:22:26 INFO - PROCESS | 6830 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 11:22:26 INFO - PROCESS | 6830 | Values: 66.0 66.0 67.0 66.0 68.0 66.0 67.0 67.0 66.0 67.0 11:22:26 INFO - PROCESS | 6830 | 11:22:26 INFO - PROCESS | 6830 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:82.00 stddev:2.18 (2.7%) stddev-sans-first:2.29 11:22:26 INFO - PROCESS | 6830 | Values: 82.0 82.0 83.0 83.0 89.0 82.0 82.0 82.0 82.0 82.0 11:22:26 INFO - PROCESS | 6830 | 11:22:26 INFO - PROCESS | 6830 | [#11] stanford-crypto-ccm Cycles:10 Average:141.00 Median:135.50 stddev:13.42 (9.9%) stddev-sans-first:13.99 11:22:26 INFO - PROCESS | 6830 | Values: 134.0 134.0 133.0 154.0 136.0 132.0 135.0 134.0 174.0 144.0 11:22:26 INFO - PROCESS | 6830 | 11:22:26 INFO - PROCESS | 6830 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.70 Median:176.00 stddev:2.21 (1.3%) stddev-sans-first:2.12 11:22:26 INFO - PROCESS | 6830 | Values: 173.0 175.0 179.0 176.0 176.0 175.0 176.0 172.0 176.0 179.0 11:22:26 INFO - PROCESS | 6830 | 11:22:26 INFO - PROCESS | 6830 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:69.50 stddev:1.25 (1.8%) stddev-sans-first:1.30 11:22:26 INFO - PROCESS | 6830 | Values: 69.0 70.0 69.0 69.0 73.0 69.0 69.0 70.0 70.0 69.0 11:22:26 INFO - PROCESS | 6830 | -------- Summary: end -------- 11:22:26 INFO - PROCESS | 6830 | 11:22:27 INFO - TEST-INFO | 6830: exit 0 11:22:27 INFO - TEST-OK | kraken | took 64476ms 11:22:27 INFO - SUITE-END | took 1188s 11:22:27 INFO - Completed test suite (00:19:48) 11:22:27 INFO - javascript benchmark 11:22:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2628.1327162036523, 2635.5519561674514, 2674.598810178473, 2681.7452342027514, 2697.1773609049233, 4697.201475749122, 4699.647526435514, 4763.90472190556, 4793.209120495123, 4813.229883218682, 4831.082094402062, 4831.492693267209, 4838.34682317887, 4842.8547143585665, 4849.054434385296, 4366.519682834885, 4397.648188144956, 4422.601965823083, 4433.31283651033, 4491.483479399862, 4426.159029784347, 4458.2866741321395, 4497.775111244441, 4515.977420112895, 4518.480374756896, 4443.733375997434, 4480.439945006874, 4556.384888040106, 4579.954200457986, 4580.496145424001, 4513.526079761644, 4536.523665015159, 4579.633629309664, 4593.678442509025, 4594.1271158479785, 4335.328024156261, 4378.10248898975, 4384.714993525411, 4387.42963414754, 4395.274779661352, 4696.671233013691, 4704.129735998851, 4704.717716936961, 4740.525947405266, 4748.596369308613, 5018.974905125451, 5034.169362055257, 5114.667546609458, 5121.51345622169, 5184.507471790174, 5033.848984530433, 5143.27994080829, 5147.202183661539, 5148.279240906276, 5156.432792392834, 4659.58063774262, 4693.249080147229, 4701.459332176775, 4702.177119004161, 4778.689385190021, 5125.256837758504, 5144.048351055067, 5159.716215608102, 5167.870803229949, 5242.266082748418, 4797.808087676523, 4964.429090654621, 4968.378952630921, 4970.229614409773, 5029.899402012013, 4932.975335123301, 5058.974705126451, 5107.284980102789, 5115.87210319745, 5193.013327467769, 5016.473270306638, 5021.974890125599, 5029.245613157982, 5062.139436295838, 5096.464871188546, 5048.444671086178, 5054.721990290569, 5061.645684802103, 5067.391912970467, 5122.871928201825, 4199.580041995776, 4240.38514415408, 4243.915121697549, 4309.245881970643, 4363.694541382073, 3803.676687481595, 3816.637419445148, 3852.114013776847, 3860.092878173627, 3876.089119057019, 4417.911641767147, 4423.336499525032, 4424.247877860771, 4429.424174857248, 4481.7535035573355, 5028.421731500851, 5076.796928122908, 5093.439721630618, 5095.235714642759, 5149.2791009258735, 4380.408644832971, 4407.889802754957, 4414.359917811899, 4456.866294011184, 4458.308962110878, 4646.4191976003, 4651.186042442627, 4653.162430762428, 4703.623710103184, 4705.153072446924, 4748.857534273978, 4818.71087734737, 4830.106430310404, 4868.586170175504, 4877.292792545132, 5030.899382012412, 5072.721000345016, 5094.821681241138, 5167.509086636764, 5169.250458683545, 4794.352762377034, 4821.54195351441, 4840.080384726891, 4887.633427492881, 4910.263460480956, 4985.052839960396, 4985.5762260208285, 4993.026359859792, 4993.400791904995, 5022.070916880389, 4999.200127979506, 5017.54842064216, 5044.0, 5098.082345177755, 5155.819546315861, 4891.926621100615, 4930.802767889244, 4938.1358262304675, 4973.328600638867, 4995.8001679932395, 4909.9018019640125, 4936.481669424658, 4942.233953737176, 4943.20908654628, 4998.2752500886445, 4806.639502037291, 4816.833061532887, 4839.056384005085, 4875.488073752205, 4944.456109827845, 4970.428400733962, 5012.47369026247, 5028.723420211923, 5089.592832573311, 5090.287359769562, 4765.213739732905, 4805.0, 4878.438979517401, 4887.169181239126, 4944.184209605519], "value": 4691.700306010313, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.6505214345322, 579.2035950567969, 579.5247896724685, 590.7843637072469, 593.0866465642912, 27599.03403380882, 36891.0777230569, 38242.99999999996, 38352.42471362932, 43523.56476435235, 40230.79884600573, 40619.0, 40633.18733625326, 40652.39021414681, 40688.59311406892, 7667.7316293929725, 7738.264864837832, 7758.495697779626, 7825.647845846951, 7832.216778322179, 7688.154303026663, 7777.105632852238, 7778.49439786412, 7779.533228006309, 7784.104827944802, 7776.572288524129, 7821.804454888645, 7823.100343460518, 7832.765017049498, 7835.451518393715, 7707.730229441942, 7711.845763084707, 7730.149683534834, 7751.224877512232, 7764.611769411506, 7661.808454788619, 7676.9616151919445, 7679.0, 7720.613969301568, 7730.536167829948, 39000.219995600215, 39017.21965560673, 39317.80341098305, 39350.21299573992, 39381.60618393837, 2876.3240638449947, 3022.8337441440713, 3163.57291765611, 3669.633036696309, 3742.7567208131386, 25718.87140564304, 27898.721012790018, 28312.0, 28382.716172838213, 28383.85808070967, 3432.433648448003, 3510.613832478425, 3596.4245720684826, 3648.872289469856, 3673.94489082664, 254797.0, 257462.0, 257598.0, 258041.70979145172, 259159.0, 29868.40263194724, 53329.0, 53759.19361209507, 53868.73065634725, 53880.19179712307, 30866.84566577153, 33320.0, 33395.332093357996, 33402.331953360794, 33435.83282083574, 12924.870751292554, 13046.869531304565, 13057.28184949837, 13184.670383240496, 13189.670258243621, 10592.0, 10818.29681070728, 10828.566857325777, 10830.133589312836, 10834.891651083546, 7716.7684969451, 7729.922700773032, 7809.843803123906, 7827.452078354574, 7832.765017049498, 3013.367192889518, 3056.587360706321, 3069.2787195009155, 3080.4609193391066, 3084.4602194615854, 869.1265278395173, 877.5699907045629, 932.4498545857977, 959.1301236433075, 973.6154219083564, 26278.943460908045, 26962.730372696024, 27655.446891062067, 27743.167704968884, 27958.3010424741, 893.2942975049768, 917.6467060181744, 926.1109335038304, 933.8132373525322, 947.8199142162968, 13604.251766152758, 14659.633509162357, 14682.486112985995, 14777.704445911237, 14780.556583302518, 398021.0, 406739.0, 605638.0, 613949.0, 617764.0, 48490.272645910336, 49123.0, 49263.0, 49280.753596232506, 49311.75344123256, 1072.4155335342257, 1119.1270808769173, 1130.2653275371074, 1158.461315488302, 1159.5477763672175, 25901.611475828253, 28255.29361765972, 28624.42751145007, 28897.42205155927, 28979.56530652, 40154.1969160621, 40453.1909361817, 40476.79761601173, 40784.0, 40839.0, 291199.0, 293231.0, 294333.0, 294845.56698763545, 296708.0, 21454.356369308945, 21501.46246343854, 22372.552548948603, 23904.88047559751, 25294.1147059852, 38537.229255415295, 38931.610683892795, 39055.2188956225, 39199.0, 39819.800900996466, 34175.14562135967, 34275.0, 34318.656813431546, 34359.14102147366, 34571.48142777911, 33506.497402538494, 33793.83103084469, 33922.3215535683, 34221.31557368889, 34404.48393274053, 33709.15727106842, 34096.31807363888, 34470.13824654404, 34487.65512344945, 34697.306053878274, 30140.547891781203, 31581.8420907894, 31820.840895795372, 31872.36255274928, 32072.5189122168, 23709.52580948337, 24109.276721698378, 24336.269911902673, 24565.263042108767, 24785.0], "value": 16260.673405124984, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.6568097583393, 364.3805530597984, 378.1925588867767, 379.87084391306956, 403.398935585977, 12170.513179472822, 12262.386880655966, 13146.868531314683, 15892.364305427769, 16680.33278668852, 16378.918105409486, 16570.337186512526, 16668.33326666932, 16723.66552668949, 16728.581785455368, 4902.289168070628, 4991.850244492671, 5085.23721441783, 5097.515736005073, 5102.107131252034, 3712.8700495482663, 5094.592432605383, 5177.430482646906, 5181.5077567631015, 5184.11869982104, 3885.5337359516757, 5761.683107429089, 6028.939710602882, 6051.576389652726, 6181.505479561647, 5957.6127551709, 6056.757729690851, 6086.3609321021095, 6140.7850725224625, 6155.907661385083, 5316.229146773696, 5325.467453254682, 5329.173978033411, 5331.786728530854, 5332.946670533283, 18950.0, 19312.517187070436, 19383.127759250867, 19408.805911940843, 19456.22175112994, 1968.22255209193, 1999.3102379678987, 2368.6802281691926, 2398.988005059981, 2463.4580392313665, 8902.73291801247, 12530.68673283166, 12847.0, 13199.274039927801, 13681.0, 1716.5451155443818, 1736.765536652561, 1754.8771585988986, 1758.6570618729354, 1815.4462888818905, 61703.69148154275, 63003.0, 63095.0, 67311.0, 73626.63186684139, 9531.332806703604, 9654.11744709775, 9704.175145112744, 9878.753031174278, 10049.899501005042, 13485.0, 13510.189388636712, 13515.59453216405, 13521.323933803467, 13529.255890926093, 6678.365555272241, 6963.1644202696, 7072.858542829217, 7117.786466406016, 7204.783856484209, 6579.572327798678, 6709.463242940553, 6826.112605361272, 6838.7264509420065, 6870.3473170048765, 4146.3365861462025, 4189.455370801777, 4212.410262563244, 4244.214820258262, 4256.446661933991, 1777.4489908128521, 1779.332750218668, 1782.8306310900443, 1803.666321730484, 1828.8902665840092, 806.8507326144683, 842.5997651115794, 877.2806298835021, 886.4636894678755, 892.7723430525175, 15854.44509442164, 16352.264148113363, 16591.41930032443, 16617.584560386087, 17249.0, 823.4853216739538, 835.3734698975768, 839.5969934431507, 848.0628905059943, 850.1073872433919, 9007.324450666096, 9565.139137477661, 9566.56950437232, 9588.137067663944, 9696.563654635558, 350793.0, 361094.0, 366518.0, 366932.0, 367857.0, 77383.61308193424, 77437.6128119367, 79943.60028199822, 80062.0, 80503.0, 875.2778957360331, 895.167494230359, 907.9682211122579, 915.0254978448064, 919.2645883293338, 14494.202818845064, 14547.927260363631, 14937.477188298357, 15154.16652084146, 15561.68876622484, 37320.0, 37475.625243747214, 37490.0, 37658.43512347262, 38360.2327953445, 47419.0, 48224.75887620539, 48609.0, 50101.0, 51507.22739158841, 10196.541155647865, 10718.24972251935, 10904.400257985886, 11325.433728313386, 11369.54521819151, 7152.141742990874, 9808.607655693691, 12661.87338126607, 12971.573126956217, 13091.869081309065, 10664.253502254767, 10676.733081673021, 10840.403777792297, 10883.238173328107, 11270.211085223955, 11003.22977391607, 11311.434428278717, 11486.540538378371, 11746.530138794353, 11832.408379581158, 6961.686724097529, 10369.429681367597, 11208.495617697386, 11684.298942063504, 11803.350815705218, 10529.157667386438, 10603.41681207541, 10937.28907621034, 11568.88431115678, 11657.591984280509, 10655.14758819277, 10973.561057557929, 11104.666859994213, 11268.7746245073, 11290.943545282222], "value": 8384.29701239827, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1253.9310337931422, 1373.745857016452, 1409.69691516324, 1494.86546210841, 1709.914504274786, 6923.757668481604, 7465.9626701866555, 7625.8474830503355, 7875.8424831503335, 7879.093904201019, 7892.250236227564, 7983.481073730218, 8013.158618345077, 8018.077921039082, 8087.231712987272, 2184.650455927052, 2195.6267434536167, 2208.63557513011, 2215.2578886073184, 2215.667649852519, 2130.286354071388, 2154.3213887625348, 2194.4952660888007, 2206.8124209442217, 2210.7789221077924, 2151.3008272311563, 2178.3791619388476, 2181.0730439563204, 2181.727284089489, 2184.7815218478186, 2129.2654034358197, 2134.893255337227, 2136.487243061654, 2140.090461553849, 2143.2605751015954, 2124.649432843579, 2151.601953638582, 2173.250228671106, 2174.934751957444, 2179.084784390544, 7835.725749598737, 7886.329661978739, 7985.920140798576, 8103.351731861437, 8110.391720620977, 4664.416947881515, 4842.15262329091, 4847.75761211938, 4924.113659541281, 4928.433230178503, 2948.616679831608, 3044.725974662291, 3078.2458297717203, 3079.92300192497, 3103.487924492456, 959.5298303831142, 968.8110818390417, 971.961121555137, 972.7130496503478, 977.9315447918649, 10992.670219893416, 11076.224664273504, 11079.279846809932, 11093.611723589716, 11109.722256943642, 4089.734167279117, 4207.852725154605, 4208.7685177314925, 4219.493660760729, 4240.78796060202, 8450.704225352083, 8476.152384761597, 8479.95760021196, 8482.194191551793, 8491.320694344562, 4734.55021772931, 4745.098431298043, 4748.572628463455, 4749.4775574686755, 4751.049790042005, 3569.964300356963, 3737.5328083989502, 4046.676265898721, 4398.868033958986, 4418.756968366771, 3413.180836599248, 3452.4993875887853, 3496.4755286707195, 3559.6974257187912, 3577.94633080504, 1068.9251752377259, 1084.322298563398, 1090.4220762995626, 1091.1380009792176, 1093.7703082352637, 676.0197713315712, 714.0681410759009, 772.6561680052323, 808.3250485844268, 849.3417601358873, 4987.501249875056, 5102.591792656653, 5136.897262054738, 5150.922736158961, 5369.275147855068, 403.3324847377595, 408.79151632667555, 410.419256751699, 414.1551235479648, 418.5960548071126, 3376.4766461198556, 3415.316936612687, 3425.400554902882, 3452.067941655739, 3554.360215161296, 9533.332666713264, 10008.299419040597, 10009.799804004026, 10011.099001089937, 10013.349132306377, 9945.403275803475, 9968.601255949681, 9983.351082179635, 9998.900010999942, 10035.448050357154, 7510.061242344707, 7515.436342274351, 7539.660715267826, 7588.62056897153, 7591.3926885849, 5038.899222015612, 5063.797448102035, 5086.364204474441, 5165.225216217597, 5313.309269794902, 9035.638574456949, 9087.182153606207, 9096.317776166681, 9096.454212747256, 9209.723708288762, 7082.256363081802, 9203.585838637411, 9289.02465241167, 9381.061893810564, 9404.341696081483, 5786.30564332266, 6143.232095988002, 6403.743850245938, 6404.359564043559, 6416.390442907917, 6945.513814032969, 7353.080864891888, 7527.473076884566, 7574.242575742382, 7772.805679858049, 6805.727770889109, 6876.621785801829, 6978.267281935324, 7016.087908571853, 7154.821129471805, 6568.80293591193, 6733.192016957801, 6891.71442215838, 7046.260142684944, 7072.045273887959, 6159.907601385893, 6233.532485063729, 6242.063690446288, 6242.719077641426, 6251.749930002749, 4218.240716671029, 4269.082147338338, 4291.871243862689, 4351.586599273064, 4402.757848318373, 4472.463304403493, 4497.572730590588, 4513.277875539898, 4514.503404625423, 4566.725996440225], "value": 4034.4053678258647, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [277.7597378267799, 279.13050846612794, 279.17782131622374, 281.445552262044, 286.96412948381453, 4636.397268355117, 4777.235642297233, 4789.0, 4841.152798260308, 4846.636502262331, 4561.475430325513, 4686.882827929304, 4732.621390288778, 4741.193997020506, 4749.525047495249, 3593.7843729376323, 3768.491253680759, 3768.679662228714, 3777.452269420946, 3786.7917264550438, 3648.066524741878, 3686.9307900708764, 3738.2336620992633, 3745.176061266517, 3751.836930551524, 3694.817658349329, 3707.1844194277214, 3718.6653201211884, 3718.7396882218254, 3726.217494326195, 3664.047347689593, 3711.32784395235, 3724.0, 3727.384981478053, 3727.7949712765785, 3211.550382946389, 3284.8193349365774, 3287.126337987348, 3291.358185153896, 3295.577750353488, 4660.766961651904, 4682.29765535169, 4684.718916864999, 4690.9530904690855, 4692.686047906592, 4214.85248016321, 4240.745555266694, 4248.511421186572, 4251.383549385322, 4252.55348188442, 4791.089692958327, 4983.302337672729, 4988.376452943382, 4996.175631020914, 5025.1708468102715, 3549.846299952526, 3550.55618047744, 3550.928981420383, 3557.8576856925692, 3560.9109772255642, 5205.765740541685, 5234.685918844882, 5239.292695486137, 5251.317328747238, 5269.420363759983, 3511.6839484446523, 3584.7849129052343, 3591.9281614367565, 3614.566252049718, 3617.963820361763, 3641.289948460025, 3651.1054791576234, 3653.780773153619, 3665.2119794244363, 3668.0, 4185.769782661922, 4188.455500784939, 4189.916201675949, 4213.557576454489, 4213.641840443596, 4771.498992605726, 4834.613230941586, 4893.0, 5006.874828129253, 5016.172331565251, 1232.950681972729, 1257.5787111317627, 1264.7723409786327, 1266.7016308284083, 1267.645059383374, 770.2990278846335, 807.1524898856295, 811.667216441268, 817.6484111831851, 819.4509678515409, 3976.6280633181505, 3997.2804895119157, 4000.179963107556, 4008.5590585035625, 4008.9198216035516, 4558.042811009659, 4591.79336929839, 4594.208258779079, 4599.171509521687, 4600.378948841863, 3955.307821131348, 3973.642372186517, 3993.3843332617184, 3995.84016639337, 4012.6990475713856, 2303.550807592537, 2418.7301666625162, 2422.9030838766603, 2429.769171928664, 2443.5705112509027, 4293.484781826201, 4325.826966921288, 4335.219660461147, 4346.826126954949, 4391.890202744893, 4636.2581986882615, 4638.350630911675, 4666.2067448533835, 4692.671512994126, 4725.527447255247, 4064.7561146331313, 4328.329108988112, 4329.740215587075, 4337.501187363494, 4343.261645520269, 4531.365608814703, 4535.614472769851, 4546.40896683429, 4550.954490455053, 4554.840580579664, 4447.421165486206, 4460.910781784281, 4474.731516109044, 4490.730556166641, 4492.0, 4156.314208155621, 4331.83408295852, 4334.5882141196535, 4391.7584532851, 4410.6030457259, 3271.2966712157, 3283.7701360904507, 3288.6875746804017, 3294.6046474423224, 3321.75086868481, 4562.038323520918, 4570.954290457053, 4588.587027167571, 4589.242774942097, 4891.823138703385, 4861.611071114232, 4922.72924989129, 4931.778069986787, 4995.450500444876, 4996.575291100297, 5002.0, 5022.020705962303, 5022.447530771539, 5025.6077147925735, 5030.2957585937265, 4801.207800712843, 4946.975265123651, 4951.737306986695, 4967.776450059684, 4970.900581988412, 5004.199328107486, 5025.522575355335, 5033.521815427529, 5042.344495215599, 5045.048646541814, 4908.582770464551, 4914.631402644744, 4917.164082105979, 4933.358663373882, 4938.308636790924], "value": 3614.595511428142, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.5693663713631, 651.781653146196, 677.0, 680.0445374249178, 731.9524230924993, 12329.383530823457, 13581.0, 13606.659833504154, 13611.455541778329, 13623.591292261222, 13120.278384688838, 13158.671033224151, 13254.867451325485, 13262.204267743919, 13271.800922986164, 618.576275251452, 633.6293268437969, 637.2830565613684, 749.1983577571987, 770.4144849914078, 636.3159603426312, 741.8182545276414, 764.9770506884803, 769.5844244108175, 775.1008829757483, 830.6013113705425, 831.8336332733447, 831.9001719793633, 832.7501749475164, 836.9246767790897, 824.7072289337319, 825.8554752918216, 826.1862065865118, 826.3224156191925, 826.8842362069315, 483.49233305029577, 490.4237520912949, 579.0619196901047, 595.1519085303426, 608.8447445901311, 12191.695207619792, 12206.145569810116, 12228.082893782914, 12231.449584768707, 12235.0, 11978.580749673807, 12206.816897746541, 12362.876371236352, 13288.26914519701, 13733.45066197351, 12146.635600931986, 12238.449269782881, 12259.387030648431, 12379.071569632313, 12743.0, 3950.920981580381, 3979.5821438748803, 3988.641022307977, 4164.354525048622, 4166.208420400145, 58647.70676146635, 59700.402995970355, 68790.31209687889, 69392.6530367345, 69716.0, 9606.759831004141, 9655.758606034906, 9892.950535247423, 10042.899571004196, 10126.848097278547, 19361.612767744566, 19938.401847944584, 20008.89995550042, 20014.399568012985, 20111.798882011284, 6860.451163906975, 6927.3419025192525, 7209.134903811576, 7331.8900216496795, 7631.122420921554, 3652.926941461209, 3917.4319723640483, 3940.7438516496336, 3953.5651078381356, 3981.9845939285874, 2958.6745457999605, 3070.1250143708935, 3078.3227689908185, 3086.074177746667, 3111.4243864884616, 511.6418507045009, 522.2551928783383, 536.1048692870684, 537.2666310486159, 537.2773619481869, 565.5899472882128, 617.2685367839125, 621.6191984698594, 621.8662987457628, 626.2203556572006, 8222.83554328922, 8288.627011784483, 8692.869606955901, 8725.301975841918, 8914.197722205032, 488.1457449463439, 501.2581379558274, 556.3073972903761, 562.8255240875342, 564.5906717629767, 3972.860949866799, 4132.421460995463, 4136.565660605593, 4143.958560414418, 4254.510731265882, 56481.71759141178, 56842.14736778952, 92090.07909920948, 102014.48992754989, 105161.47419262855, 79507.0, 87896.56051719701, 88451.55774221088, 89268.0, 90812.5459372712, 45800.770996144805, 62862.685686572186, 79555.60222198968, 80538.0, 81023.59488202521, 7560.432967527568, 8038.141691987762, 8069.394795390486, 8257.752267431986, 8287.50274983503, 40603.390949135195, 44493.55506445024, 46537.534624654676, 46728.0, 46938.357157499326, 41512.79243603763, 63522.682386587774, 66327.33672663405, 66554.66722666356, 66757.33242667512, 9843.163331116935, 9863.753406164904, 10076.445795481319, 10400.843987340348, 10409.063184313449, 10730.980556847087, 10800.783984320113, 11534.250273732181, 11570.742210083517, 11573.768524629628, 10408.791824163625, 10431.947840261053, 10455.634052808115, 11411.885881141414, 12089.81865272004, 9539.0, 11251.099912007183, 11773.76452470963, 11875.346855923008, 11937.46281417321, 11517.596884109016, 12025.4588543514, 12087.516499339928, 12319.876801231872, 12628.179168354027, 9955.50222488887, 10198.483297387265, 10465.058144767008, 10515.684529464128, 10848.294860834021, 10164.33931794431, 10559.894401055892, 10570.2600817942, 10762.04043887937, 10968.725781855517], "value": 6555.7890302135265, "unit": "score"}], "name": "dromaeo_css", "value": 6276.84786116071, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 115.0, 114.0, 113.0, 114.0, 114.0, 114.0, 113.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 125.0, 132.0, 161.0, 124.0, 124.0, 128.0, 126.0, 171.0, 127.0], "value": 137.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 160.0, 161.0, 161.0, 162.0, 161.0, 160.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 76.0, 109.0, 77.0, 77.0, 76.0, 76.0, 108.0, 75.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 115.0, 84.0, 84.0, 83.0, 120.0, 83.0, 84.0, 118.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 146.0, 147.0, 147.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 71.0, 63.0, 65.0, 62.0, 64.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 68.0, 66.0, 67.0, 67.0, 66.0, 67.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 83.0, 83.0, 89.0, 82.0, 82.0, 82.0, 82.0, 82.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 134.0, 133.0, 154.0, 136.0, 132.0, 135.0, 134.0, 174.0, 144.0], "value": 141.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 175.0, 179.0, 176.0, 176.0, 175.0, 176.0, 172.0, 176.0, 179.0], "value": 175.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 69.0, 73.0, 69.0, 69.0, 70.0, 70.0, 69.0], "value": 69.7, "unit": "score"}], "name": "kraken", "value": 1547.7, "alertThreshold": 2.0}]} 11:22:27 INFO - Return code: 0 11:22:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:22:27 INFO - # TBPL SUCCESS # 11:22:27 INFO - Running post-action listener: _resource_record_post_action 11:22:27 INFO - [mozharness: 2016-09-23 18:22:27.816061Z] Finished run-tests step (success) 11:22:27 INFO - Running post-run listener: _resource_record_post_run 11:22:27 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 622592; Write bytes: 397045760; Read time: 476; Write time: 338056 11:22:27 INFO - TinderboxPrint: CPU usage
13.1% 11:22:27 INFO - TinderboxPrint: I/O read bytes / time
622,592 / 476 11:22:27 INFO - TinderboxPrint: I/O write bytes / time
397,045,760 / 338,056 11:22:27 INFO - TinderboxPrint: CPU idle
8,351.1 (86.8%) 11:22:27 INFO - TinderboxPrint: CPU user
1,211.0 (12.6%) 11:22:27 INFO - TinderboxPrint: Swap in / out
0 / 0 11:22:27 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 86016; Write bytes: 102060032; Read time: 248; Write time: 94408 11:22:27 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 532480; Write bytes: 249946112; Read time: 72; Write time: 230964 11:22:28 INFO - Running post-run listener: _upload_blobber_files 11:22:28 INFO - Blob upload gear active. 11:22:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:22:28 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 11:22:28 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'] 11:22:28 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 11:22:28 INFO - (blobuploader) - INFO - Open directory for files ... 11:22:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:22:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:22:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:22:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:22:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:22:29 INFO - (blobuploader) - INFO - Done attempting. 11:22:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:22:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:22:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:22:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:22:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:22:30 INFO - (blobuploader) - INFO - Done attempting. 11:22:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:22:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:22:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:22:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:22:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:22:37 INFO - (blobuploader) - INFO - Done attempting. 11:22:37 INFO - (blobuploader) - INFO - Iteration through files over. 11:22:37 INFO - Return code: 0 11:22:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:22:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:22:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f96b0aae54ec6a2cec78b15509c07c77d81f3a88b205f0b3125b7d30b47a0ef8b8b9d1b49b4a5f7c256bf43c2134a218c05b91e75d5c2bc89e196a1d51ed65cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8b9d9dd0113d8d73010da6a83be12c5595cafb6167a56e286e8e36bef306ee5f21cbd317930fca3a43f89c16f6e50a74fea2ebd237f0d01bfe9ab32d4a857f96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1b89f0fe5c763f65b8ab539482590a29e59fc50488253266e63e748f43d8f9024d4c295681b74ef2ac05ef50d088650d43eaccb82b0e3e0dd62e748e875b6607"} 11:22:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:22:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:22:37 INFO - Contents: 11:22:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f96b0aae54ec6a2cec78b15509c07c77d81f3a88b205f0b3125b7d30b47a0ef8b8b9d1b49b4a5f7c256bf43c2134a218c05b91e75d5c2bc89e196a1d51ed65cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8b9d9dd0113d8d73010da6a83be12c5595cafb6167a56e286e8e36bef306ee5f21cbd317930fca3a43f89c16f6e50a74fea2ebd237f0d01bfe9ab32d4a857f96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1b89f0fe5c763f65b8ab539482590a29e59fc50488253266e63e748f43d8f9024d4c295681b74ef2ac05ef50d088650d43eaccb82b0e3e0dd62e748e875b6607"} 11:22:37 INFO - Running post-run listener: copy_logs_to_upload_dir 11:22:37 INFO - Copying logs to upload dir... 11:22:37 INFO - mkdir: /builds/slave/test/build/upload/logs 11:22:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.618957 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-09-23 11:22:37.341424) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 11:22:37.345199) ========= 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=62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950 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/f96b0aae54ec6a2cec78b15509c07c77d81f3a88b205f0b3125b7d30b47a0ef8b8b9d1b49b4a5f7c256bf43c2134a218c05b91e75d5c2bc89e196a1d51ed65cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8b9d9dd0113d8d73010da6a83be12c5595cafb6167a56e286e8e36bef306ee5f21cbd317930fca3a43f89c16f6e50a74fea2ebd237f0d01bfe9ab32d4a857f96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1b89f0fe5c763f65b8ab539482590a29e59fc50488253266e63e748f43d8f9024d4c295681b74ef2ac05ef50d088650d43eaccb82b0e3e0dd62e748e875b6607"} build_url:https://queue.taskcluster.net/v1/task/T8e0YgmgTJ-087zujTHWHQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011429 build_url: 'https://queue.taskcluster.net/v1/task/T8e0YgmgTJ-087zujTHWHQ/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/f96b0aae54ec6a2cec78b15509c07c77d81f3a88b205f0b3125b7d30b47a0ef8b8b9d1b49b4a5f7c256bf43c2134a218c05b91e75d5c2bc89e196a1d51ed65cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8b9d9dd0113d8d73010da6a83be12c5595cafb6167a56e286e8e36bef306ee5f21cbd317930fca3a43f89c16f6e50a74fea2ebd237f0d01bfe9ab32d4a857f96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1b89f0fe5c763f65b8ab539482590a29e59fc50488253266e63e748f43d8f9024d4c295681b74ef2ac05ef50d088650d43eaccb82b0e3e0dd62e748e875b6607"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 11:22:37.370764) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 11:22:37.371143) ========= 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=62c568580acbfdaac3eec7be000001dc-1474653701.562737-1829203950 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 11:22:37.455055) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 11:22:37.455370) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 11:22:37.455686) ========= ========= Total master_lag: 0.17 =========