builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-046 starttime: 1474961930.79 results: success (0) buildid: 20160926233117 builduid: b84b9620f44b4c6b82a9168e022eaed6 revision: df63260c1c90ea8ff0a5a314fbcae9365854abb0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 00:38:50.791527) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 00:38:50.791969) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 00:38:50.792265) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 00:38:50.812808) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 00:38:50.813112) ========= 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=652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-27 00:38:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 30.6M=0s 2016-09-27 00:38:51 (30.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115591 ========= master_lag: 1.15 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 00:38:52.080244) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 00:38:52.080613) ========= 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=652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016772 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 00:38:52.158489) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 00:38:52.163926) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev df63260c1c90ea8ff0a5a314fbcae9365854abb0 --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 df63260c1c90ea8ff0a5a314fbcae9365854abb0 --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=652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-27 00:38:53,155 truncating revision to first 12 chars 2016-09-27 00:38:53,155 Setting DEBUG logging. 2016-09-27 00:38:53,155 attempt 1/10 2016-09-27 00:38:53,155 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/df63260c1c90?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 00:38:53,471 unpacking tar archive at: fx-team-df63260c1c90/testing/mozharness/ program finished with exit code 0 elapsedTime=0.647809 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 00:38:52.835394) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 00:38:52.835740) ========= script_repo_revision: df63260c1c90ea8ff0a5a314fbcae9365854abb0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 00:38:52.836116) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 00:38:52.836382) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 00:38:52.852182) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-09-27 00:38:52.852441) ========= /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=652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:38:53 INFO - MultiFileLogger online at 20160927 00:38:53 in /builds/slave/test 00:38:53 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 00:38:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:38:53 INFO - {'append_to_log': False, 00:38:53 INFO - 'base_work_dir': '/builds/slave/test', 00:38:53 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 00:38:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:38:53 INFO - 'branch': 'Fx-Team-Non-PGO', 00:38:53 INFO - 'buildbot_json_path': 'buildprops.json', 00:38:53 INFO - 'config_files': ('talos/linux_config.py',), 00:38:53 INFO - 'default_actions': ('clobber', 00:38:53 INFO - 'read-buildbot-config', 00:38:53 INFO - 'download-and-extract', 00:38:53 INFO - 'populate-webroot', 00:38:53 INFO - 'create-virtualenv', 00:38:53 INFO - 'install', 00:38:53 INFO - 'run-tests'), 00:38:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:38:53 INFO - 'download_minidump_stackwalk': True, 00:38:53 INFO - 'download_symbols': 'ondemand', 00:38:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:38:53 INFO - 'tooltool.py': '/tools/tooltool.py', 00:38:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:38:53 INFO - '/tools/misc-python/virtualenv.py')}, 00:38:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:38:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:38:53 INFO - 'installer_path': 'installer.exe', 00:38:53 INFO - 'log_level': 'info', 00:38:53 INFO - 'log_name': 'talos', 00:38:53 INFO - 'log_to_console': True, 00:38:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:38:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:38:53 INFO - 'opt_config_files': (), 00:38:53 INFO - 'pip_index': False, 00:38:53 INFO - 'sps_profile': False, 00:38:53 INFO - 'sps_profile_interval': 0, 00:38:53 INFO - 'suite': 'dromaeojs', 00:38:53 INFO - 'system_bits': '32', 00:38:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:38:53 INFO - 'title': 'talos-linux64-ix-046', 00:38:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:38:53 INFO - 'use_talos_json': True, 00:38:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:38:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:38:53 INFO - 'work_dir': 'build'} 00:38:53 INFO - [mozharness: 2016-09-27 07:38:53.943351Z] Running clobber step. 00:38:53 INFO - Running pre-action listener: _resource_record_pre_action 00:38:53 INFO - Running main action method: clobber 00:38:53 INFO - rmtree: /builds/slave/test/build 00:38:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:38:54 INFO - Running post-action listener: _resource_record_post_action 00:38:54 INFO - [mozharness: 2016-09-27 07:38:54.411833Z] Finished clobber step (success) 00:38:54 INFO - [mozharness: 2016-09-27 07:38:54.411933Z] Running read-buildbot-config step. 00:38:54 INFO - Running pre-action listener: _resource_record_pre_action 00:38:54 INFO - Running main action method: read_buildbot_config 00:38:54 INFO - Using buildbot properties: 00:38:54 INFO - { 00:38:54 INFO - "project": "", 00:38:54 INFO - "product": "firefox", 00:38:54 INFO - "script_repo_revision": "production", 00:38:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:38:54 INFO - "repository": "", 00:38:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 00:38:54 INFO - "buildid": "20160926233117", 00:38:54 INFO - "pgo_build": "False", 00:38:54 INFO - "basedir": "/builds/slave/test", 00:38:54 INFO - "buildnumber": 1954, 00:38:54 INFO - "slavename": "talos-linux64-ix-046", 00:38:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:38:54 INFO - "platform": "ubuntu64_hw", 00:38:54 INFO - "scheduler": "tests-fx-team-linux64-talos", 00:38:54 INFO - "branch": "fx-team", 00:38:54 INFO - "repo_path": "integration/fx-team", 00:38:54 INFO - "revision": "df63260c1c90ea8ff0a5a314fbcae9365854abb0", 00:38:54 INFO - "stage_platform": "linux64", 00:38:54 INFO - "builduid": "b84b9620f44b4c6b82a9168e022eaed6", 00:38:54 INFO - "slavebuilddir": "test" 00:38:54 INFO - } 00:38:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 00:38:54 INFO - Running post-action listener: _resource_record_post_action 00:38:54 INFO - [mozharness: 2016-09-27 07:38:54.414457Z] Finished read-buildbot-config step (success) 00:38:54 INFO - [mozharness: 2016-09-27 07:38:54.414545Z] Running download-and-extract step. 00:38:54 INFO - Running pre-action listener: _resource_record_pre_action 00:38:54 INFO - Running main action method: download_and_extract 00:38:54 INFO - mkdir: /builds/slave/test/build/tests 00:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:38:54 INFO - trying https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:38:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/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 00:38:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/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 00:38:54 INFO - Downloaded 1361 bytes. 00:38:54 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:38:54 INFO - Using the following test package requirements: 00:38:54 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:38:54 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:38:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:38:54 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:38:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:38:54 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:38:54 INFO - u'jsshell-linux-x86_64.zip'], 00:38:54 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:38:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:38:54 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:38:54 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:38:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:38:54 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:38:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:38:54 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:38:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:38:54 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:38:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:38:54 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:38:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:38:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:38:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:38:55 INFO - Expected file size: 20410620 00:39:00 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 00:39:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:39:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:39:00 INFO - Fetch https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:39:01 INFO - Expected file size: 20410620 00:39:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 00:39:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:39:05 INFO - Fetch https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 00:39:06 INFO - Expected file size: 14414057 00:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:39:07 INFO - trying https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:39:07 INFO - Downloading https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/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 00:39:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/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 00:39:09 INFO - Downloaded 55744932 bytes. 00:39:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:39:09 INFO - mkdir: /builds/slave/test/properties 00:39:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:39:09 INFO - Writing to file /builds/slave/test/properties/build_url 00:39:09 INFO - Contents: 00:39:09 INFO - build_url:https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:39:10 INFO - Running post-action listener: _resource_record_post_action 00:39:10 INFO - Running post-action listener: set_extra_try_arguments 00:39:10 INFO - [mozharness: 2016-09-27 07:39:10.199253Z] Finished download-and-extract step (success) 00:39:10 INFO - [mozharness: 2016-09-27 07:39:10.199480Z] Running populate-webroot step. 00:39:10 INFO - Running pre-action listener: _resource_record_pre_action 00:39:10 INFO - Running main action method: populate_webroot 00:39:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:39:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:39:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:39:10 INFO - '--tppagecycles', 00:39:10 INFO - '7'], 00:39:10 INFO - 'tests': ['tsvgm']}}, 00:39:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:39:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:39:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:39:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:39:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:39:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:39:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:39:10 INFO - 'talos_options': ['--disable-e10s'], 00:39:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:39:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:39:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:39:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:39:10 INFO - 'talos_options': ['--disable-e10s'], 00:39:10 INFO - 'tests': ['damp', 'tps']}, 00:39:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:39:10 INFO - 'tests': ['damp', 'tps']}, 00:39:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:39:10 INFO - 'tests': ['dromaeo_dom']}, 00:39:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:39:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:39:10 INFO - 'tests': ['basic_compositor_video']}, 00:39:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:39:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:39:10 INFO - 'tests': ['a11yr', 00:39:10 INFO - 'ts_paint', 00:39:10 INFO - 'tpaint', 00:39:10 INFO - 'sessionrestore', 00:39:10 INFO - 'sessionrestore_no_auto_restore', 00:39:10 INFO - 'tabpaint']}, 00:39:10 INFO - 'other-e10s': {'tests': ['a11yr', 00:39:10 INFO - 'ts_paint', 00:39:10 INFO - 'tpaint', 00:39:10 INFO - 'sessionrestore', 00:39:10 INFO - 'sessionrestore_no_auto_restore', 00:39:10 INFO - 'tabpaint']}, 00:39:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:39:10 INFO - 'ts_paint', 00:39:10 INFO - 'tpaint', 00:39:10 INFO - 'sessionrestore', 00:39:10 INFO - 'sessionrestore_no_auto_restore', 00:39:10 INFO - 'tabpaint']}, 00:39:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:39:10 INFO - 'ts_paint', 00:39:10 INFO - 'tpaint', 00:39:10 INFO - 'sessionrestore', 00:39:10 INFO - 'sessionrestore_no_auto_restore', 00:39:10 INFO - 'tabpaint']}, 00:39:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:39:10 INFO - 'tests': ['a11yr', 00:39:10 INFO - 'ts_paint', 00:39:10 INFO - 'tpaint', 00:39:10 INFO - 'sessionrestore', 00:39:10 INFO - 'sessionrestore_no_auto_restore', 00:39:10 INFO - 'tabpaint']}, 00:39:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:39:10 INFO - 'tests': ['a11yr', 00:39:10 INFO - 'ts_paint', 00:39:10 INFO - 'tpaint', 00:39:10 INFO - 'sessionrestore', 00:39:10 INFO - 'sessionrestore_no_auto_restore', 00:39:10 INFO - 'tabpaint']}, 00:39:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:39:10 INFO - 'tests': ['tsvgx', 00:39:10 INFO - 'tsvgr_opacity', 00:39:10 INFO - 'tart', 00:39:10 INFO - 'tscrollx', 00:39:10 INFO - 'cart']}, 00:39:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:39:10 INFO - 'tsvgr_opacity', 00:39:10 INFO - 'tart', 00:39:10 INFO - 'tscrollx', 00:39:10 INFO - 'cart']}, 00:39:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:39:10 INFO - 'talos_options': ['--disable-e10s'], 00:39:10 INFO - 'tests': ['tp5o']}, 00:39:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:39:10 INFO - 'tests': ['tp5o']}, 00:39:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:39:10 INFO - 'talos_options': ['--disable-e10s', 00:39:10 INFO - '--xperf_path', 00:39:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:39:10 INFO - 'tests': ['tp5n']}, 00:39:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:39:10 INFO - 'talos_options': ['--xperf_path', 00:39:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:39:10 INFO - 'tests': ['tp5n']}}, 00:39:10 INFO - 'talos.zip': {'path': '', 00:39:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:39:10 INFO - Running post-action listener: _resource_record_post_action 00:39:10 INFO - [mozharness: 2016-09-27 07:39:10.219091Z] Finished populate-webroot step (success) 00:39:10 INFO - [mozharness: 2016-09-27 07:39:10.219181Z] Running create-virtualenv step. 00:39:10 INFO - Running pre-action listener: _resource_record_pre_action 00:39:10 INFO - Running main action method: create_virtualenv 00:39:10 INFO - Creating virtualenv /builds/slave/test/build/venv 00:39:10 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 00:39:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:39:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:39:10 INFO - Using real prefix '/usr' 00:39:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:39:10 INFO - Installing distribute.............................................................................................................................................................................................done. 00:39:12 INFO - Installing pip.................done. 00:39:12 INFO - Return code: 0 00:39:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:39:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:39:13 INFO - Reading from file tmpfile_stdout 00:39:13 INFO - Output received: 00:39:13 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 00:39:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:39:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:39:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:39:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:13 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 0x7f795d4f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219ef60>, '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 0x219fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a01d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871', '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 00:39:13 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 00:39:13 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 00:39:13 INFO - Using env: {'DISPLAY': ':0', 00:39:13 INFO - 'HOME': '/home/cltbld', 00:39:13 INFO - 'LANG': 'en_US.UTF-8', 00:39:13 INFO - 'LANGUAGE': 'en_US:en', 00:39:13 INFO - 'LOGNAME': 'cltbld', 00:39:13 INFO - 'MAIL': '/var/mail/cltbld', 00:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:39:13 INFO - 'MOZ_NO_REMOTE': '1', 00:39:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:39:13 INFO - 'NO_EM_RESTART': '1', 00:39:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:39:13 INFO - 'PWD': '/builds/slave/test', 00:39:13 INFO - 'SHELL': '/bin/bash', 00:39:13 INFO - 'SHLVL': '1', 00:39:13 INFO - 'TERM': 'linux', 00:39:13 INFO - 'TMOUT': '86400', 00:39:13 INFO - 'USER': 'cltbld', 00:39:13 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871', 00:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:39:13 INFO - '_': '/tools/buildbot/bin/python'} 00:39:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:39:13 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 00:39:13 INFO - Cleaning up... 00:39:13 INFO - Return code: 0 00:39:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:39:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:39:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:39:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:13 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 0x7f795d4f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219ef60>, '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 0x219fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a01d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871', '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 00:39:13 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 00:39:13 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 00:39:13 INFO - Using env: {'DISPLAY': ':0', 00:39:13 INFO - 'HOME': '/home/cltbld', 00:39:13 INFO - 'LANG': 'en_US.UTF-8', 00:39:13 INFO - 'LANGUAGE': 'en_US:en', 00:39:13 INFO - 'LOGNAME': 'cltbld', 00:39:13 INFO - 'MAIL': '/var/mail/cltbld', 00:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:39:13 INFO - 'MOZ_NO_REMOTE': '1', 00:39:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:39:13 INFO - 'NO_EM_RESTART': '1', 00:39:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:39:13 INFO - 'PWD': '/builds/slave/test', 00:39:13 INFO - 'SHELL': '/bin/bash', 00:39:13 INFO - 'SHLVL': '1', 00:39:13 INFO - 'TERM': 'linux', 00:39:13 INFO - 'TMOUT': '86400', 00:39:13 INFO - 'USER': 'cltbld', 00:39:13 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871', 00:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:39:13 INFO - '_': '/tools/buildbot/bin/python'} 00:39:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:39:13 INFO - Downloading/unpacking psutil>=3.1.1 00:39: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 00:39: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 00:39: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 00:39: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 00:39: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 00:39: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 00:39:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:39:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:39:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:39:15 INFO - Installing collected packages: psutil 00:39:15 INFO - Running setup.py install for psutil 00:39:15 INFO - building 'psutil._psutil_linux' extension 00:39:15 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 00:39:15 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 00:39:15 INFO - building 'psutil._psutil_posix' extension 00:39:15 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 00:39:15 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 00:39:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:39:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:39:15 INFO - Successfully installed psutil 00:39:15 INFO - Cleaning up... 00:39:15 INFO - Return code: 0 00:39:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:39:15 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')]} 00:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:39:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:15 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')]} 00:39:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:39:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:15 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 0x7f795d4f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219ef60>, '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 0x219fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a01d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871', '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 00:39:16 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 00:39:16 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 00:39:16 INFO - Using env: {'DISPLAY': ':0', 00:39:16 INFO - 'HOME': '/home/cltbld', 00:39:16 INFO - 'LANG': 'en_US.UTF-8', 00:39:16 INFO - 'LANGUAGE': 'en_US:en', 00:39:16 INFO - 'LOGNAME': 'cltbld', 00:39:16 INFO - 'MAIL': '/var/mail/cltbld', 00:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:39:16 INFO - 'MOZ_NO_REMOTE': '1', 00:39:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:39:16 INFO - 'NO_EM_RESTART': '1', 00:39:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:39:16 INFO - 'PWD': '/builds/slave/test', 00:39:16 INFO - 'SHELL': '/bin/bash', 00:39:16 INFO - 'SHLVL': '1', 00:39:16 INFO - 'TERM': 'linux', 00:39:16 INFO - 'TMOUT': '86400', 00:39:16 INFO - 'USER': 'cltbld', 00:39:16 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871', 00:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:39:16 INFO - '_': '/tools/buildbot/bin/python'} 00:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:39:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:39:16 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 00:39:16 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 00:39:16 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 00:39:16 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 00:39:16 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 00:39:16 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 00:39:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:39:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:39:18 INFO - Installing collected packages: mozsystemmonitor 00:39:18 INFO - Running setup.py install for mozsystemmonitor 00:39:18 INFO - Successfully installed mozsystemmonitor 00:39:18 INFO - Cleaning up... 00:39:18 INFO - Return code: 0 00:39:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:39:18 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')]} 00:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:39:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:18 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')]} 00:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:39:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:18 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 0x7f795d4f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219ef60>, '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 0x219fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a01d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871', '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 00:39:18 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 00:39:18 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 00:39:18 INFO - Using env: {'DISPLAY': ':0', 00:39:18 INFO - 'HOME': '/home/cltbld', 00:39:18 INFO - 'LANG': 'en_US.UTF-8', 00:39:18 INFO - 'LANGUAGE': 'en_US:en', 00:39:18 INFO - 'LOGNAME': 'cltbld', 00:39:18 INFO - 'MAIL': '/var/mail/cltbld', 00:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:39:18 INFO - 'MOZ_NO_REMOTE': '1', 00:39:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:39:18 INFO - 'NO_EM_RESTART': '1', 00:39:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:39:18 INFO - 'PWD': '/builds/slave/test', 00:39:18 INFO - 'SHELL': '/bin/bash', 00:39:18 INFO - 'SHLVL': '1', 00:39:18 INFO - 'TERM': 'linux', 00:39:18 INFO - 'TMOUT': '86400', 00:39:18 INFO - 'USER': 'cltbld', 00:39:18 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871', 00:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:39:18 INFO - '_': '/tools/buildbot/bin/python'} 00:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:39:18 INFO - Downloading/unpacking jsonschema==2.5.1 00:39:18 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 00:39:18 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 00:39:18 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 00:39:18 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 00:39:18 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 00:39:18 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 00:39:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:39:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:39:20 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 00:39:20 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 00:39:20 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 00:39:20 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 00:39:20 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 00:39:20 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 00:39:20 INFO - Downloading functools32-3.2.3-2.tar.gz 00:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:39:20 INFO - warning: no files found matching '*.txt' 00:39:20 INFO - no previously-included directories found matching 'build' 00:39:20 INFO - no previously-included directories found matching 'dist' 00:39:20 INFO - no previously-included directories found matching '.git*' 00:39:20 INFO - Installing collected packages: jsonschema, functools32 00:39:20 INFO - Running setup.py install for functools32 00:39:20 INFO - warning: no files found matching '*.txt' 00:39:20 INFO - no previously-included directories found matching 'build' 00:39:20 INFO - no previously-included directories found matching 'dist' 00:39:20 INFO - no previously-included directories found matching '.git*' 00:39:20 INFO - Successfully installed jsonschema functools32 00:39:20 INFO - Cleaning up... 00:39:20 INFO - Return code: 0 00:39:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:39:20 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')]} 00:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:39:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:20 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')]} 00:39:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:39:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:20 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 0x7f795d4f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219ef60>, '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 0x219fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a01d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871', '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 00:39:20 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 00:39:20 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 00:39:20 INFO - Using env: {'DISPLAY': ':0', 00:39:20 INFO - 'HOME': '/home/cltbld', 00:39:20 INFO - 'LANG': 'en_US.UTF-8', 00:39:20 INFO - 'LANGUAGE': 'en_US:en', 00:39:20 INFO - 'LOGNAME': 'cltbld', 00:39:20 INFO - 'MAIL': '/var/mail/cltbld', 00:39:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:39:20 INFO - 'MOZ_NO_REMOTE': '1', 00:39:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:39:20 INFO - 'NO_EM_RESTART': '1', 00:39:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:39:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:39:20 INFO - 'PWD': '/builds/slave/test', 00:39:20 INFO - 'SHELL': '/bin/bash', 00:39:20 INFO - 'SHLVL': '1', 00:39:20 INFO - 'TERM': 'linux', 00:39:20 INFO - 'TMOUT': '86400', 00:39:20 INFO - 'USER': 'cltbld', 00:39:20 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871', 00:39:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:39:20 INFO - '_': '/tools/buildbot/bin/python'} 00:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:39:21 INFO - Cleaning up... 00:39:21 INFO - Return code: 0 00:39:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:39: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')]} 00:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:39:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39: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')]} 00:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:39:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39: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', '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 0x7f795d4f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219ef60>, '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 0x219fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a01d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871', '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 00:39: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:39: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 blobuploader==1.2.4 00:39:21 INFO - Using env: {'DISPLAY': ':0', 00:39:21 INFO - 'HOME': '/home/cltbld', 00:39:21 INFO - 'LANG': 'en_US.UTF-8', 00:39:21 INFO - 'LANGUAGE': 'en_US:en', 00:39:21 INFO - 'LOGNAME': 'cltbld', 00:39:21 INFO - 'MAIL': '/var/mail/cltbld', 00:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:39:21 INFO - 'MOZ_NO_REMOTE': '1', 00:39:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:39:21 INFO - 'NO_EM_RESTART': '1', 00:39:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:39:21 INFO - 'PWD': '/builds/slave/test', 00:39:21 INFO - 'SHELL': '/bin/bash', 00:39:21 INFO - 'SHLVL': '1', 00:39:21 INFO - 'TERM': 'linux', 00:39:21 INFO - 'TMOUT': '86400', 00:39:21 INFO - 'USER': 'cltbld', 00:39:21 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871', 00:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:39:21 INFO - '_': '/tools/buildbot/bin/python'} 00:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:39:21 INFO - Downloading/unpacking blobuploader==1.2.4 00:39:21 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 00:39:21 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 00:39:21 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 00:39:21 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 00:39:21 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 00:39:21 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 00:39:23 INFO - Downloading blobuploader-1.2.4.tar.gz 00:39:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:39:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:39:23 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 00:39:23 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 00:39:23 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 00:39:23 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 00:39:23 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 00:39:23 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 00:39:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:39:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:39:23 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 00:39:23 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 00:39:23 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 00:39:23 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 00:39:23 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 00:39:23 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 00:39:23 INFO - Downloading docopt-0.6.1.tar.gz 00:39:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:39:23 INFO - Installing collected packages: blobuploader, requests, docopt 00:39:23 INFO - Running setup.py install for blobuploader 00:39:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:39:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:39:24 INFO - Running setup.py install for requests 00:39:24 INFO - Running setup.py install for docopt 00:39:24 INFO - Successfully installed blobuploader requests docopt 00:39:24 INFO - Cleaning up... 00:39:24 INFO - Return code: 0 00:39:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:24 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 0x7f795d4f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219ef60>, '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 0x219fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a01d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871', '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 00:39:24 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 00:39:24 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 00:39:24 INFO - Using env: {'DISPLAY': ':0', 00:39:24 INFO - 'HOME': '/home/cltbld', 00:39:24 INFO - 'LANG': 'en_US.UTF-8', 00:39:24 INFO - 'LANGUAGE': 'en_US:en', 00:39:24 INFO - 'LOGNAME': 'cltbld', 00:39:24 INFO - 'MAIL': '/var/mail/cltbld', 00:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:39:24 INFO - 'MOZ_NO_REMOTE': '1', 00:39:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:39:24 INFO - 'NO_EM_RESTART': '1', 00:39:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:39:24 INFO - 'PWD': '/builds/slave/test', 00:39:24 INFO - 'SHELL': '/bin/bash', 00:39:24 INFO - 'SHLVL': '1', 00:39:24 INFO - 'TERM': 'linux', 00:39:24 INFO - 'TMOUT': '86400', 00:39:24 INFO - 'USER': 'cltbld', 00:39:24 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871', 00:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:39:24 INFO - '_': '/tools/buildbot/bin/python'} 00:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:39:24 INFO - Running setup.py (path:/tmp/pip-gAGRso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:39:24 INFO - Running setup.py (path:/tmp/pip-YErGqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:39:24 INFO - Running setup.py (path:/tmp/pip-G_sBX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:39:25 INFO - Running setup.py (path:/tmp/pip-8lWwP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:39:25 INFO - Running setup.py (path:/tmp/pip-kZ2pj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:39:25 INFO - Running setup.py (path:/tmp/pip-5zVrwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:39:25 INFO - Running setup.py (path:/tmp/pip-2Rlp_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:39:25 INFO - Running setup.py (path:/tmp/pip-QbrROZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:39:25 INFO - Running setup.py (path:/tmp/pip-uQ3r_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:39:25 INFO - Running setup.py (path:/tmp/pip-H6Iz1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:39:25 INFO - Running setup.py (path:/tmp/pip-57_zOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:39:25 INFO - Running setup.py (path:/tmp/pip-5eULF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:39:25 INFO - Running setup.py (path:/tmp/pip-WEhKUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:39:25 INFO - Running setup.py (path:/tmp/pip-nQ0g6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:39:25 INFO - Running setup.py (path:/tmp/pip-e7m8Ki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:39:25 INFO - Running setup.py (path:/tmp/pip-cqLyUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:39:25 INFO - Running setup.py (path:/tmp/pip-LwOeDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:39:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:39:26 INFO - Running setup.py install for manifestparser 00:39:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:39:26 INFO - Running setup.py install for mozcrash 00:39:26 INFO - Running setup.py install for mozdebug 00:39:26 INFO - Running setup.py install for mozdevice 00:39:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:39:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:39:26 INFO - Running setup.py install for mozfile 00:39:26 INFO - Running setup.py install for mozhttpd 00:39:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:39:26 INFO - Running setup.py install for mozinfo 00:39:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:39:26 INFO - Running setup.py install for mozInstall 00:39:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:39:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:39:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:39:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:39:26 INFO - Running setup.py install for mozleak 00:39:26 INFO - Running setup.py install for mozlog 00:39:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:39:27 INFO - Running setup.py install for moznetwork 00:39:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:39:27 INFO - Running setup.py install for mozprocess 00:39:27 INFO - Running setup.py install for mozprofile 00:39:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:39:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:39:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:39:27 INFO - Running setup.py install for mozrunner 00:39:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:39:27 INFO - Running setup.py install for mozscreenshot 00:39:27 INFO - Running setup.py install for moztest 00:39:27 INFO - Running setup.py install for mozversion 00:39:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:39:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:39:27 INFO - Cleaning up... 00:39:27 INFO - Return code: 0 00:39:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:39:27 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')]} 00:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:39:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:27 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')]} 00:39:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:39:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:27 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 0x7f795d4f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219ef60>, '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 0x219fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a01d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871', '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 00:39:27 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 00:39:27 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 00:39:27 INFO - Using env: {'DISPLAY': ':0', 00:39:27 INFO - 'HOME': '/home/cltbld', 00:39:27 INFO - 'LANG': 'en_US.UTF-8', 00:39:27 INFO - 'LANGUAGE': 'en_US:en', 00:39:27 INFO - 'LOGNAME': 'cltbld', 00:39:27 INFO - 'MAIL': '/var/mail/cltbld', 00:39:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:39:27 INFO - 'MOZ_NO_REMOTE': '1', 00:39:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:39:27 INFO - 'NO_EM_RESTART': '1', 00:39:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:39:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:39:27 INFO - 'PWD': '/builds/slave/test', 00:39:27 INFO - 'SHELL': '/bin/bash', 00:39:27 INFO - 'SHLVL': '1', 00:39:27 INFO - 'TERM': 'linux', 00:39:27 INFO - 'TMOUT': '86400', 00:39:27 INFO - 'USER': 'cltbld', 00:39:27 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871', 00:39:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:39:27 INFO - '_': '/tools/buildbot/bin/python'} 00:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:39:28 INFO - Running setup.py (path:/tmp/pip-jAFeHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:39:28 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)) 00:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:39:28 INFO - Running setup.py (path:/tmp/pip-0yujFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:39:28 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)) 00:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:39:28 INFO - Running setup.py (path:/tmp/pip-zFJW8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:39:28 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)) 00:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:39:28 INFO - Running setup.py (path:/tmp/pip-hR6rWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:39:28 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)) 00:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:39:28 INFO - Running setup.py (path:/tmp/pip-a_5kbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:39:28 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)) 00:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:39:28 INFO - Running setup.py (path:/tmp/pip-k4Ll3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:39:28 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)) 00:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:39:28 INFO - Running setup.py (path:/tmp/pip-MaaFYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:39:28 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)) 00:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:39:28 INFO - Running setup.py (path:/tmp/pip-NFvAQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:39:28 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)) 00:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:39:28 INFO - Running setup.py (path:/tmp/pip-93CDye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:39:28 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)) 00:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:39:28 INFO - Running setup.py (path:/tmp/pip-BKq8ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:39:28 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)) 00:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:39:28 INFO - Running setup.py (path:/tmp/pip-ng4G8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:39:28 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)) 00:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:39:28 INFO - Running setup.py (path:/tmp/pip-RcC_dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:39:28 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)) 00:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:39:28 INFO - Running setup.py (path:/tmp/pip-AoelAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:39:29 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)) 00:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:39:29 INFO - Running setup.py (path:/tmp/pip-gRCR8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:39:29 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)) 00:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:39:29 INFO - Running setup.py (path:/tmp/pip-XZ1BYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:39:29 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)) 00:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:39:29 INFO - Running setup.py (path:/tmp/pip-xi8pq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:39:29 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)) 00:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:39:29 INFO - Running setup.py (path:/tmp/pip-oWT65h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:39:29 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)) 00:39:29 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)) 00:39:29 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)) 00:39:29 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)) 00:39:29 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)) 00:39:29 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)) 00:39:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:39:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:39:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:39:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:39:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:39:31 INFO - Downloading blessings-1.6.tar.gz 00:39:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:39:31 INFO - Installing collected packages: blessings 00:39:31 INFO - Running setup.py install for blessings 00:39:31 INFO - Successfully installed blessings 00:39:31 INFO - Cleaning up... 00:39:31 INFO - Return code: 0 00:39:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:39:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:39:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:39:31 INFO - Reading from file tmpfile_stdout 00:39:31 INFO - Current package versions: 00:39:31 INFO - argparse == 1.2.1 00:39:31 INFO - blessings == 1.6 00:39:31 INFO - blobuploader == 1.2.4 00:39:31 INFO - docopt == 0.6.1 00:39:31 INFO - functools32 == 3.2.3-2 00:39:31 INFO - jsonschema == 2.5.1 00:39:31 INFO - manifestparser == 1.1 00:39:31 INFO - mozInstall == 1.12 00:39:31 INFO - mozcrash == 0.17 00:39:31 INFO - mozdebug == 0.1 00:39:31 INFO - mozdevice == 0.48 00:39:31 INFO - mozfile == 1.2 00:39:31 INFO - mozhttpd == 0.7 00:39:31 INFO - mozinfo == 0.9 00:39:31 INFO - mozleak == 0.1 00:39:31 INFO - mozlog == 3.4 00:39:31 INFO - moznetwork == 0.27 00:39:31 INFO - mozprocess == 0.23 00:39:31 INFO - mozprofile == 0.28 00:39:31 INFO - mozrunner == 6.12 00:39:31 INFO - mozscreenshot == 0.1 00:39:31 INFO - mozsystemmonitor == 0.3 00:39:31 INFO - moztest == 0.7 00:39:31 INFO - mozversion == 1.4 00:39:31 INFO - psutil == 3.1.1 00:39:31 INFO - requests == 1.2.3 00:39:31 INFO - wsgiref == 0.1.2 00:39:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:39:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:39:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:39:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:39:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:31 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 0x7f795d4f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219ef60>, '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 0x219fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a01d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871', '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 00:39:31 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 00:39:31 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 00:39:31 INFO - Using env: {'DISPLAY': ':0', 00:39:31 INFO - 'HOME': '/home/cltbld', 00:39:31 INFO - 'LANG': 'en_US.UTF-8', 00:39:31 INFO - 'LANGUAGE': 'en_US:en', 00:39:31 INFO - 'LOGNAME': 'cltbld', 00:39:31 INFO - 'MAIL': '/var/mail/cltbld', 00:39:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:39:31 INFO - 'MOZ_NO_REMOTE': '1', 00:39:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:39:31 INFO - 'NO_EM_RESTART': '1', 00:39:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:39:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:39:31 INFO - 'PWD': '/builds/slave/test', 00:39:31 INFO - 'SHELL': '/bin/bash', 00:39:31 INFO - 'SHLVL': '1', 00:39:31 INFO - 'TERM': 'linux', 00:39:31 INFO - 'TMOUT': '86400', 00:39:31 INFO - 'USER': 'cltbld', 00:39:31 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871', 00:39:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:39:31 INFO - '_': '/tools/buildbot/bin/python'} 00:39:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:39:31 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)) 00:39:31 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)) 00:39:31 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)) 00:39:31 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)) 00:39:31 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)) 00:39:31 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)) 00:39:31 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)) 00:39:31 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)) 00:39:31 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)) 00:39:31 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)) 00:39:31 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)) 00:39:31 INFO - Cleaning up... 00:39:31 INFO - Return code: 0 00:39:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:39:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:39:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:39:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:39:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f795d4f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219ef60>, '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 0x219fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a01d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871', '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 00:39:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:39:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:39:31 INFO - Using env: {'DISPLAY': ':0', 00:39:31 INFO - 'HOME': '/home/cltbld', 00:39:31 INFO - 'LANG': 'en_US.UTF-8', 00:39:31 INFO - 'LANGUAGE': 'en_US:en', 00:39:31 INFO - 'LOGNAME': 'cltbld', 00:39:31 INFO - 'MAIL': '/var/mail/cltbld', 00:39:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:39:31 INFO - 'MOZ_NO_REMOTE': '1', 00:39:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:39:31 INFO - 'NO_EM_RESTART': '1', 00:39:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:39:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:39:31 INFO - 'PWD': '/builds/slave/test', 00:39:31 INFO - 'SHELL': '/bin/bash', 00:39:31 INFO - 'SHLVL': '1', 00:39:31 INFO - 'TERM': 'linux', 00:39:31 INFO - 'TMOUT': '86400', 00:39:31 INFO - 'USER': 'cltbld', 00:39:31 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871', 00:39:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:39:31 INFO - '_': '/tools/buildbot/bin/python'} 00:39:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:39:32 INFO - Cleaning up... 00:39:32 INFO - Return code: 0 00:39:32 INFO - Running post-action listener: _resource_record_post_action 00:39:32 INFO - Running post-action listener: _start_resource_monitoring 00:39:32 INFO - Starting resource monitoring. 00:39:32 INFO - [mozharness: 2016-09-27 07:39:32.129323Z] Finished create-virtualenv step (success) 00:39:32 INFO - [mozharness: 2016-09-27 07:39:32.129852Z] Running install step. 00:39:32 INFO - Running pre-action listener: _resource_record_pre_action 00:39:32 INFO - Running main action method: install 00:39:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:39:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:39:32 INFO - Reading from file tmpfile_stdout 00:39:32 INFO - Detecting whether we're running mozinstall >=1.0... 00:39:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:39:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:39:32 INFO - Reading from file tmpfile_stdout 00:39:32 INFO - Output received: 00:39:32 INFO - Usage: mozinstall [options] installer 00:39:32 INFO - Options: 00:39:32 INFO - -h, --help show this help message and exit 00:39:32 INFO - -d DEST, --destination=DEST 00:39:32 INFO - Directory to install application into. [default: 00:39:32 INFO - "/builds/slave/test"] 00:39:32 INFO - --app=APP Application being installed. [default: firefox] 00:39:32 INFO - mkdir: /builds/slave/test/build/application 00:39:32 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'] 00:39:32 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 00:39:48 INFO - Reading from file tmpfile_stdout 00:39:48 INFO - Output received: 00:39:48 INFO - /builds/slave/test/build/application/firefox/firefox 00:39:48 INFO - Running post-action listener: _resource_record_post_action 00:39:48 INFO - [mozharness: 2016-09-27 07:39:48.521235Z] Finished install step (success) 00:39:48 INFO - [mozharness: 2016-09-27 07:39:48.521544Z] Running run-tests step. 00:39:48 INFO - Running pre-action listener: _resource_record_pre_action 00:39:48 INFO - Running main action method: run_tests 00:39:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:39:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:39:48 INFO - Python 2.7.3 00:39:48 INFO - Return code: 0 00:39:48 INFO - grabbing minidump binary from tooltool 00:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:39:48 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 0x219ef60>, '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 0x219fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a01d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:39:48 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 00:39:48 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 00:39:48 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 00:39:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:39:48 INFO - Return code: 0 00:39:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:39:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:39:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:39:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:39:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:39:48 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/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 00:39:48 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/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 00:39:48 INFO - Using env: {'DISPLAY': ':0', 00:39:48 INFO - 'HOME': '/home/cltbld', 00:39:48 INFO - 'LANG': 'en_US.UTF-8', 00:39:48 INFO - 'LANGUAGE': 'en_US:en', 00:39:48 INFO - 'LOGNAME': 'cltbld', 00:39:48 INFO - 'MAIL': '/var/mail/cltbld', 00:39:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:39:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:39:48 INFO - 'MOZ_NO_REMOTE': '1', 00:39:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:39:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:39:48 INFO - 'NO_EM_RESTART': '1', 00:39:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:39:48 INFO - 'PWD': '/builds/slave/test', 00:39:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:39:48 INFO - 'SHELL': '/bin/bash', 00:39:48 INFO - 'SHLVL': '1', 00:39:48 INFO - 'TERM': 'linux', 00:39:48 INFO - 'TMOUT': '86400', 00:39:48 INFO - 'USER': 'cltbld', 00:39:48 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871', 00:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:39:48 INFO - '_': '/tools/buildbot/bin/python'} 00:39:48 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/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 00:39:48 INFO - mozversion application_buildid: 20160926233117 00:39:48 INFO - mozversion application_changeset: df63260c1c90ea8ff0a5a314fbcae9365854abb0 00:39:48 INFO - mozversion application_display_name: Nightly 00:39:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:39:48 INFO - mozversion application_name: Firefox 00:39:48 INFO - mozversion application_remotingname: firefox 00:39:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:39:48 INFO - mozversion application_vendor: Mozilla 00:39:48 INFO - mozversion application_version: 52.0a1 00:39:48 INFO - mozversion platform_buildid: 20160926233117 00:39:48 INFO - mozversion platform_changeset: df63260c1c90ea8ff0a5a314fbcae9365854abb0 00:39:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:39:48 INFO - mozversion platform_version: 52.0a1 00:39:48 INFO - using testdate: 1474961988 00:39:48 INFO - actual date: 1474961988 00:39:48 INFO - starting webserver on 'localhost:38868' 00:39:48 INFO - SUITE-START | Running 2 tests 00:39:48 INFO - TEST-START | dromaeo_css 00:39:48 INFO - operating with platform_type : linux_ 00:39:48 INFO - Initialising browser for dromaeo_css test... 00:39:48 INFO - TEST-INFO | started process 16133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmXVj4G/profile http://localhost:38868/getInfo.html) 00:39:53 INFO - PROCESS | 16133 | __metrics Screen width/height:1600/1200 00:39:53 INFO - PROCESS | 16133 | colorDepth:24 00:39:53 INFO - PROCESS | 16133 | Browser inner width/height: 1024/697 00:39:53 INFO - PROCESS | 16133 | __metrics 00:39:53 INFO - PROCESS | 16133 | 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" 00:39:53 INFO - PROCESS | 16133 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:39:54 INFO - PROCESS | 16133 | console.error: PushService: 00:39:54 INFO - PROCESS | 16133 | stateChangeProcessEnqueue: Error transitioning state 00:39:54 INFO - PROCESS | 16133 | UnknownError 00:39:55 INFO - TEST-INFO | 16133: exit 0 00:39:55 INFO - Browser initialized. 00:39:55 INFO - Running cycle 1/1 for dromaeo_css test... 00:39:55 INFO - TEST-INFO | started process 16215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmXVj4G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:40:07 INFO - PROCESS | 16215 | RSS: Main: 174338048 00:40:07 INFO - PROCESS | 16215 | 00:40:58 INFO - PROCESS | 16215 | 1474962058952 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] 00:43:11 INFO - PROCESS | 16215 | Cycle 1(1): loaded http://localhost:38868/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38868/tests/dromaeo/cssquery-ext.html) 00:43:12 INFO - PROCESS | 16215 | RSS: Main: 296628224 00:43:12 INFO - PROCESS | 16215 | 00:46:15 INFO - PROCESS | 16215 | Cycle 1(1): loaded http://localhost:38868/tests/dromaeo/cssquery-ext.html (next: http://localhost:38868/tests/dromaeo/cssquery-jquery.html) 00:46:15 INFO - PROCESS | 16215 | RSS: Main: 271372288 00:46:15 INFO - PROCESS | 16215 | 00:49:18 INFO - PROCESS | 16215 | Cycle 1(1): loaded http://localhost:38868/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38868/tests/dromaeo/cssquery-mootools.html) 00:49:18 INFO - PROCESS | 16215 | RSS: Main: 253358080 00:49:18 INFO - PROCESS | 16215 | 00:52:21 INFO - PROCESS | 16215 | Cycle 1(1): loaded http://localhost:38868/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38868/tests/dromaeo/cssquery-prototype.html) 00:52:21 INFO - PROCESS | 16215 | RSS: Main: 219619328 00:52:21 INFO - PROCESS | 16215 | 00:55:24 INFO - PROCESS | 16215 | Cycle 1(1): loaded http://localhost:38868/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38868/tests/dromaeo/cssquery-yui.html) 00:55:25 INFO - PROCESS | 16215 | RSS: Main: 219590656 00:55:25 INFO - PROCESS | 16215 | 00:58:28 INFO - PROCESS | 16215 | Cycle 1(1): loaded http://localhost:38868/tests/dromaeo/cssquery-yui.html (next: http://localhost:38868/tests/dromaeo/cssquery-dojo.html) 00:58:28 INFO - PROCESS | 16215 | RSS: Main: 310923264 00:58:28 INFO - PROCESS | 16215 | 00:58:28 INFO - PROCESS | 16215 | __start_tp_report 00:58:28 INFO - PROCESS | 16215 | _x_x_mozilla_page_load 00:58:28 INFO - PROCESS | 16215 | _x_x_mozilla_page_load_details 00:58:28 INFO - PROCESS | 16215 | |i|pagename|runs| 00:58:28 INFO - PROCESS | 16215 | |0;dojo.html;2568.987155064224;2595.9870200649016;2623.737626237376;2634.380920483686;2648.205538338498;4505.9861531155475;4564.201264778659;4679.087577922302;4682.836100736475;4697.506761790014;4602.493725690179;4612.40038794957;4627.028324051945;4671.112488627158;4711.128441238365;4260.446142001551;4295.591918767727;4341.45731783527;4351.021020270446;4357.433533640622;4296.312589985588;4385.2106620808245;4423.336499525081;4430.379746835446;4472.865814025585;4184;4318.762468064255;4324.589164029444;4333.285007973681;4429.202743506167;4221.577842215785;4262.041040765834;4262.957370426287;4272.423222864935;4310.892227694301;4275.166342563201;4286.357046443028;4336.956630433687;4345.956540434587;4352.477702675699;4622.352870598119;4665.673402861801;4668.066386722635;4715.316279139505;4732.858014259577;4742.620590352763;4814.157522433595;4976.601871850244;4983.750812459399;4983.825566105169;4908.779104940286;4933.950660493385;4975.154223781966;4975.875603109951;5046.394432668067;4617.630589552828;4630.305454181832;4630.930536041962;4636.582707556337;4687.929681054787;4924.975375123173;5044.142495775727;5065.6200784941275;5076.771545280398;5138.614603904722;4784.234522476457;4788.329633851264;4790.041991601694;4828.927566086511;4846.3699719037;4825.927611085836;4836.733979631154;4864.586510146677;4919.385076865392;4987.202047672427;4916.508349165055;4917.58200552957;4919.458859525449;4922.720092775904;4993.7503124843615;4749.548792864673;4783.904321913612;4785.545373189541;4827.372441582642;4868.488808675109;4181.059261666162;4184.225918205142;4209.284421648327;4232.30167022444;4233.238017156941;3652.196516766307;3667.5598928128798;3671.100580357776;3717.126475278307;3721.739478236552;4123.36087906375;4187.7696726679715;4229.767362795014;4248.808803603845;4253.957460425418;4925.655204135748;4926.310316555685;4926.605871530269;4963;4964.379452568429;4233.428487154257;4264.850730224427;4270.935935960901;4318.460192475941;4322.1139666368945;4333.913321733611;4372.213001659732;4466;4466.196084704784;4473.753943533137;4682.695624784378;4729.55069268419;4731.219348807408;4751.976240118777;4767.570918617341;4966.056449274626;4979.029089327546;4979.800807967641;4986.576141028053;5049.545540901337;4552.954470455253;4728.0780247851335;4742.549457801503;4742.881427964328;4800.35195248637;4813.7352445615825;4863.294822250825;4918.016396720599;4935.383077115361;4994.250862370528;4960.50394960501;4982.62630302736;4986.077575648516;4987.376577927759;5055.014272216882;4848.612111031039;4870.537298956593;4903.485134060872;4905;4956.925646115239;4713.67004309695;4776.641751868554;4845.370101886732;4871.634627402888;4898.069366820293;4825.396825396825;4827.879303017453;4835.057163853015;4882.121218180761;4887.853364399074;4696.694714843524;4712.128256272601;4868.610511159028;4892.730899800546;4893.363862697826;4706.623470122314;4767.523247675204;4813.590844778233;4827;4884.584810291165 00:58:28 INFO - PROCESS | 16215 | |1;ext.html;553.6124712701109;568.2186992884783;570.9921987691724;573.1288441568815;577.0737965565265;28279.575806362896;37836.24327513448;39336.80331598345;39388.212235755265;42923.570764292344;39964.80017599915;40438.39342409859;40453;40487;40528.79735601325;7534.171241163468;7685.923140768605;7687.538747675129;7688.654010569509;7690.038745156856;7659.080910290745;7747.573883436408;7751.147373788879;7751.418643601753;7754.0695116586085;7750.5349679019155;7797.532148071105;7803.29770320671;7804.336631386311;7806.921930780676;7730.033745781778;7760.922390776076;7770.067591888953;7770.883436748453;7779.961100194491;7625.580593067379;7698.03774528184;7700.383969282444;7703.499272547267;7706.576138312391;37805.62194378048;38183.427248591295;38248.80875595632;38262.23475530501;38278.80860595707;2980.76153907689;2992.62592175978;3030.2878823476467;3082.9383412331626;3258.527513510551;28602;28788.568171477236;28802.279943001384;28990.565141522893;29519.85240073786;3423.178437175085;3425.0581090200144;3434.708049815769;3467.5665541807275;3480.077779388464;243198;243691;243811;243915;243948;30876;32125;32154;51621.22568161481;52068.739656302234;33547.83226083903;33588.801399825024;33687.83156084204;33757;33768.32463350719;12126.151169418055;12249.510019599116;12257.203281786655;12259.896609305206;12272.263664180178;9723.9027609723;9757.073078057572;9758.414495130315;9759.170470510086;9765.902340976641;7683.846323073507;7811.804704882424;7811.843763124706;7822.530648161129;7875.566843823644;2970.12381347503;3019.4715924713087;3028.6668466468673;3035.3929214157256;3083.938321233563;880.1418616848522;892.3664198419195;913.2100732866156;921.6589861751195;933.6918816790443;27109.72890271072;27360.903006692875;27446.313842153708;27962.72037279601;27990.72009279922;948.3266880514911;950.1875896108866;954.8042651256476;970.3207754571828;990.0594435286363;14263.330655797865;14763.483278085216;14801.925990369979;14874.181919994504;14953.551393458214;363216;435144;442362;442634;645855.6243312708;49412.75293623509;49975.75012124916;50060.249096263586;50100.49899501031;50101.49898500968;1079.1420820447763;1117.765269293425;1179.5930404010603;1197.9940100299616;1200.7598480303975;24611;30531.694683053774;31050.223744406572;31311.53032704557;31621;46135.53864461447;46956.7652161737;46995.53004469912;47056.52943470521;47169.528304716514;337310;339778;340431;340552;340686;24665.87667061725;25491.617625736;25506.362340941625;25514.744852551237;25517.23448296554;40907;41384.172316554104;41399.58600413957;41706.16587668169;41890.58109418989;34595.4810677835;35235.47146792852;35373.82313088418;35416.29167416689;35511.28977420489;34775.65224347825;34911.301773964886;34930;35044.29911401809;35478.29043419169;34254.82872585721;34324.313513730085;34966.215372629464;35004.299914001065;35009.61802693027;29937.401251974403;31884.36231275315;32023.359532808747;32033.67966320307;32382.514262285615;25168.37079073038;25271;25339.366515837253;25369;25586.744132558437 00:58:28 INFO - PROCESS | 16215 | |2;jquery.html;340.7223113162774;354.88821021378266;361.3549813582755;364.89782860798977;386.7157639135235;12560.560380386676;15721.76417353739;15724.29240684169;16732.58168545784;17634.647307053885;16583.253753581088;17039.74440383392;17272.56818579536;17345.306187752474;17478.825211747877;4841.1285968525735;4891.25277798587;5005.2492126181;5052.974735126338;5070.873228169288;3664.340418724642;3852.4028775539696;5032.924506132411;5126.615503837208;5576.386597474275;5782.797602083928;5919.112133180036;5920.703964801743;5931.940680593182;5933.465988061073;5726.7422965966425;5880.852978675524;5915.378885217055;5922.674252916088;5928.584999050068;5221.164613661834;5221.556167725748;5221.582273418117;5227;5227.869303267411;20170.495737606532;20581.176752929863;20634.896825515927;20823.479413014644;20839.270625528185;1751.6440387678551;1877.2584828992472;1942.2522328903474;2343.27358518858;2419.334682962182;12486.625401237978;13169.736605267937;13409.46362145513;13759;13759.656008599764;1657.734762438004;1755.7717496725345;1773.9822601774076;1781;1797.7123660214434;67439;68716.65641671809;70905;72569.63715181443;72617.63691181563;8136.308413784776;8687.956560217159;8750.431221970552;9173.724788256362;9412.67055653049;11213.495392707347;11246.325220486797;11281.26671766349;11283.984441400313;11294.04000659953;6636.369544893324;6740.157480314961;6803.4557235422035;6832.487563432763;6890.2076261229595;6747.426468750113;6774.119364482585;6934.895976560255;6961.82595435108;6965.442764578822;3550.2721942002345;3685.4103343464917;3743.6069212732273;3924.156306394139;4090.202410529918;1603.7594360845967;1693.4580934101216;1743.6599863026588;1748.4579780268157;1753.798313193999;789.9802504937422;829.701307529289;839.7061028639927;866.7443104284251;879.8416285068621;15628.2185890705;16675.79872284054;16801.57996050084;17103.14484275781;17297.827021729874;827.5324441690426;841.7516832534417;863.5595846118525;894.0567701075298;909.2226146644656;7215.819604509929;9244.168024877794;9571.952140239255;9626.566804493814;9681.70954871355;336775;346011;347831;352625;354925;45959.54040459619;46151;77828.93916340372;78521.60739196381;79875;814.5886327404622;827.23480780278;828.9917100829035;831.5301854452337;836.610975896199;14814.48149314812;15012.324445399765;15024.474143405365;15501.84498155004;15759;36430.635693642726;37701.81149094237;37976.620233798414;38119.61880381161;39511.20977580375;50031.49968500414;50580.49419505758;50831.237531436316;51332.48667513426;51733;7398.445116616383;7522.924770752441;7583.620818959141;7657.234276572298;7739.458237923516;9023.684171053981;11149.275297105987;11400.543978240778;11433.1996760226;11926.642200733992;10395.428251446243;10402.115820155372;10496.68509944703;10544.789104218025;10874.510647021061;9791.65729199503;10034.397936123856;10072.194224461879;10120.797584048425;10243.436610986468;9804.803903922024;9827.606895724091;10275.126614237874;10478.952104789765;10649.627263045757;7321.74373896911;7356.742514011984;7547.396208303432;7566.394688424803;7937.563434011185;9711.708648740549;10066.647667331608;10068.848967265643;10532.789344213226;10752.83870741955 00:58:28 INFO - PROCESS | 16215 | |3;mootools.html;1313.6124843171267;1357.2670757790788;1366.7949807528873;1606.9196540172989;1641.9261133248995;6571.3757193066585;7043.50695451318;7568.508046976949;7571.772846814591;7579.507332023421;6661.333866613336;6813.7955861324235;6999.545029573074;6999.545029573074;7170.677319520634;2050.374635736096;2079.8440116991287;2088.8955552222405;2091.717618121557;2093.6231478333893;1793.2737241417246;1853;2071.7513898332145;2072.6580114281123;2081.240347273242;2013.1041686449537;2086.321945367754;2091.3203208957075;2111.313823007521;2116.6824976253533;2080.843936704746;2084.4476213803355;2090.6550419180817;2096.465401322668;2122.395117391536;2098.26560703754;2115.894205289729;2118.406846083099;2118.4492032071616;2119.3853782403085;7305.086864141982;7320.084989376328;7372.594507302097;7379.151397589292;7384.2246564111065;4459.732416055047;4518.254488009475;4608.101420223024;4608.193566125915;4609.055143695535;2784.665840099201;2929.2383980165096;2956.9852150739107;2971.3463038131576;2984.3882004189304;900.5497251374313;931.6133804471204;943.2925306020485;947.6114792934864;963.3834346018554;10041.748956276078;10043.54804033813;10044;10054.447005414699;10109.797804043952;4009.218202450494;4028.738132021409;4185.246655602021;4193.666035501783;4209.5790420957655;7656.157822639505;7677.347425468898;7712.113106992768;7713.344365728976;7729.227077292338;4501.459824821042;4523.140603285366;4524.773761311922;4531.252343363374;4532;4086.203190377848;4168.6039826216465;4212.220739163265;4218.177455396169;4218.957810421918;3047.6952304769347;3055.4194703006356;3129.8591563379246;3150.2754366495833;3164.256399746058;888.7244954064261;929.8655640119044;948.4641177734558;953.2374100719396;964.9855252171224;769.5036701327613;780.4380845791021;793.3415265329762;817.7178873288706;869.8431086654734;4818.373611430492;5080.237964305384;5080.568151707146;5091.287219789232;5187.766550505236;448.45736658642755;452.9456465224128;456.9543045695404;459.35231323833233;603.646866583045;3485.8431370588382;3498.8600455981987;3702.074481379655;3763.190913953458;3764.153065560282;8632.309415246766;8963.193312601898;9032.36773425854;9170.541472926327;9182.403143795633;9047.773805654911;9133.725988220363;9136.223421009288;9145.176934075966;9151.267898568098;6457.225132983978;6975.79072627822;7080.504364694525;7081.964590177016;7088.468364872552;4927.975360123177;5113.846584602468;5216.452272511484;5241.135212690016;5322.308099946982;8259.380546458919;8274.338052955869;8395.790105247417;8418.410711250399;8441.15588441151;8479.703210387606;8489.617967191614;8533.74398768038;8566.871496927426;8608.870866936875;6268.091126786681;6412.807615771534;6416.967915160394;6443.259025212161;6449.355064493513;6906.758263460755;6958.234594194736;6958.965205173941;6963.199232088375;6971.5468494547695;6317.778877739257;6428.19647544057;6446.09754634361;6478.935210647834;6516.543841931019;6243.7814676486105;6255.343188965275;6307;6360.427561519486;6447.806565803034;6084.39156084388;6190.442860142609;6192.752289908353;6194.256689197326;6195.504359651307;4101.302778527598;4202.348635961431;4295.4201182839915;4315.11540134278;4328.069465065026;4370.278903980935;4446.710963787473;4459.219636563654;4461.687681862239;4465.5311192325635 00:58:28 INFO - PROCESS | 16215 | |4;prototype.html;290.0732160746415;290.1599868381037;300.7368552516548;302.1871166561947;303.25097010384343;4799.136155492014;4820.975895120519;4829.44461386941;4852.85441436757;4855.863420095156;4769.713817170972;4788.80844766209;4790.928136077961;4806.5193480651915;4806.870385459423;3568.8750893718725;3675.9448608270895;3678.356287649664;3681.3005528949416;3714.1457464783116;3623.6773577644235;3713.9814300928456;3764;3769.227308401771;3783.186614877801;3719.888403347904;3733.1413774831803;3739.626037396266;3748.9437658435145;3752.4558938953837;3606.090197094396;3741.9812900935594;3743.8128093595346;3748.6438788315068;3754.943675844851;3284.1953721338186;3306.570145881044;3309.7683162178655;3311.420501412267;3316.585426821647;4523.683342166017;4524.298733696282;4571.337156112345;4592.885177870547;4604.58558729716;4220.240356735786;4225.598568136023;4231.767252801125;4235.91528169438;4248.171606536726;4704.529547045302;4870.366852309177;4908.361912951329;4926.802927882881;4930.704157750546;3608.8376023078763;3615.9096022599383;3617.3307938031285;3617.7105831533413;3618.1135621772833;5136.64043516954;5139.614528910347;5142.717150556718;5150.587952963791;5205.843824685227;3605.351036813346;3697.8520859165333;3734.7012239020814;3736.5889752127246;3737.551493820759;3761.8119094045187;3780.319542482325;3781.4516895050065;3781.9432708509394;3789.3368660484307;4259.488861336659;4261.595148460891;4276.935845962313;4291.914161716748;4304.225239456928;4861.152761950436;4892.877678058077;4907.3620429343955;4930.408350997904;4981.879077207599;1241.9875801242054;1292.8965682745359;1302.2251760202664;1302.908796384244;1303.687115092371;822.2394285286206;833.741540122564;846.7417437681443;847.1782371100023;849.1466076592984;3971.781552014609;4196.706230563831;4292.871213863589;4331.155424692155;4423.270160423494;5114.897702045938;5118.820841270612;5121.924395876833;5124.718140502308;5131.255373173064;4428.357888106271;4429.933550996738;4445.777711114431;4445.844395446144;4452.107854161968;2583.522048421048;2684.7583717465523;2688.206978941217;2702.662167229096;2707.160780158157;4829.782659780319;4833.782479788418;4840.733759643183;4852.816232695231;4863.635227357962;5218.165093585008;5234.502722241381;5242.9213561796605;5263.499967503081;5296.682199068068;4766.712987493357;4813.326134341195;4912.1649319615035;4922.778474968635;4923.950760492349;5150.845474635767;5163.580015495769;5167.870803229949;5170.250313704567;5170.482951704799;5122.513361230677;5126.820561280487;5133.332666753298;5135.409427915837;5135.845924622267;4694.413198350207;4827.155247831545;4880.80476780939;4883.169861123689;4890.242012487928;3624.1120925373452;3633.5094762207823;3645.54430696163;3652.817359132086;3680.521532200904;5190.766415511386;5215.4002289735645;5215.843524694265;5227.660202086852;5231.790728370975;4963;4981.135846887982;5020.447750747488;5028.823991160438;5036.521530454601;5021.6735912165595;5023.748812559431;5028.245763135559;5035.295058691713;5054.2923990642075;4957.677750946177;4974.7512624369365;4978.1288274552535;4991.425986011655;5001.699898006132;4773.71357718538;4840.709557426566;4981.8007279709855;5026.623003274696;5045.268436076822;4791.179351846276;4805.37530121082;4905.190643543775;4914.459409465027;4919.877003074952 00:58:28 INFO - PROCESS | 16215 | |5;yui.html;669.176912397751;674.554793836068;714.9847216951928;729.9671514781834;746.8730315846306;12386.504539818408;13198.53805116821;13203.207807531555;13245.536406225783;13269.933650331746;13681.3159342033;13910.582682519514;13966.30168491574;14004.64988375291;14026.789598156036;762.8931949527084;778.9610519474032;779.3842864137325;779.5556532776292;779.6179871862774;763.7326935572561;764.2433990349542;765.2844590308052;766.4290103872595;767.386091127096;815.213319147023;816.4203415574949;816.5549775372407;816.930560902324;817.358373676664;812.7764864662206;813.0203105258208;813.3086876155221;813.5769399912042;813.6379311206515;598.5181928547518;599.143225187981;599.2240049136379;600.432591201315;600.6996501749126;11669.591564295293;11899.702507437296;12015.339156346397;12054.457549410297;13052.21686698801;11279.266847654877;11442;11478.311301321948;11516.193866429354;11749.236299640495;9916.752081197956;10154;10200.79598408035;10496.632617858415;10849.78300433987;4101.323281658552;4141.254574176647;4174.165166966619;4261.296886013804;4400.889977750549;60087.69956150235;64312;64398.678006610135;64446.35553644497;64466.67766661184;10085.949570252102;10139.7465063374;10237;10310.123639490577;10319.226058045677;17584.208710608054;18989.145488453054;18999.05004749757;19000.714989275173;19001.42995710131;5566.359868615161;5857.6862139455525;6077.969610151921;6451.967740161269;6962.825929351706;3586.659267369596;3792.6776224020714;3829.483019792348;3853.2871418787613;3889.2610404023144;2970.7326340629015;3095.597572315585;3104.2239440139965;3108.8290144042294;3113.2995076107695;529.1295818378823;529.5313647421982;532.3877540828001;533.4105813076573;543.4538289019589;471.43663322329485;499.48552990419927;501.9272205530178;546.8906218756265;557.3395526301346;6982.33667801558;7219.422446204291;7467.215942326086;7591.4685971981435;7602;494.451159213273;520.3443660987183;533.6904595334696;544.6731960823554;550.0813641219173;4085.264652362603;4131.194417088639;4210.136921930997;4222.577742225752;4229.915401691949;96652.51673741586;100223;103173.48413257886;105386;105713.47143264388;85276;85499.57250213834;90212;91769.54115229515;92832.53583732038;45747.908339333546;46091.539084609394;46680.299795503095;79825.60087199527;81226.59386703146;7955.761327160194;8307.335413167053;8325.125861784425;8328.708495202638;8363.581820909052;42898.35652465153;43728.56271437245;43974;45128;45233.77383113063;60564.69717651384;67147;67217.32782672111;67520.3247967514;71101;10781.62264320745;11188.87411391833;11426.885731142582;11789.705257368634;11814.468348924147;12050.337231452355;12309.79417675657;13162.341882905625;13717.657058573217;14159.716805664035;10112;10375.377477351383;11616.825747613624;11644.941775291069;11930.463129159381;11006.449677515931;11544;12138.393080346124;12341.444634991267;12810.952693431978;10721.946390267998;11323.547058117583;11391.54433822671;11398.829017564578;11464.770704586028;8744.868826967473;9899.703008909744;9902.405855648683;9951.253655975686;10251.646681304059;8836.779080523038;8847.029683192923;9372.60998445392;9427.717168484956;9435.905640943503 00:58:28 INFO - PROCESS | 16215 | __end_tp_report 00:58:28 INFO - PROCESS | 16215 | __start_cc_report 00:58:28 INFO - PROCESS | 16215 | _x_x_mozilla_cycle_collect,981 00:58:28 INFO - PROCESS | 16215 | __end_cc_report 00:58:28 INFO - PROCESS | 16215 | __startTimestamp1474963108849__endTimestamp 00:58:28 INFO - PROCESS | 16215 | 00:58:28 INFO - PROCESS | 16215 | ------- Summary: start ------- 00:58:28 INFO - PROCESS | 16215 | Number of tests: 6 00:58:28 INFO - PROCESS | 16215 | 00:58:28 INFO - PROCESS | 16215 | [#0] dojo.html Cycles:165 Average:4589.40 Median:4731.22 stddev:469.85 (9.9%) stddev-sans-first:443.75 00:58:28 INFO - PROCESS | 16215 | Values: 2569.0 2596.0 2623.7 2634.4 2648.2 4506.0 4564.2 4679.1 4682.8 4697.5 4602.5 4612.4 4627.0 4671.1 4711.1 4260.4 4295.6 4341.5 4351.0 4357.4 4296.3 4385.2 4423.3 4430.4 4472.9 4184.0 4318.8 4324.6 4333.3 4429.2 4221.6 4262.0 4263.0 4272.4 4310.9 4275.2 4286.4 4337.0 4346.0 4352.5 4622.4 4665.7 4668.1 4715.3 4732.9 4742.6 4814.2 4976.6 4983.8 4983.8 4908.8 4934.0 4975.2 4975.9 5046.4 4617.6 4630.3 4630.9 4636.6 4687.9 4925.0 5044.1 5065.6 5076.8 5138.6 4784.2 4788.3 4790.0 4828.9 4846.4 4825.9 4836.7 4864.6 4919.4 4987.2 4916.5 4917.6 4919.5 4922.7 4993.8 4749.5 4783.9 4785.5 4827.4 4868.5 4181.1 4184.2 4209.3 4232.3 4233.2 3652.2 3667.6 3671.1 3717.1 3721.7 4123.4 4187.8 4229.8 4248.8 4254.0 4925.7 4926.3 4926.6 4963.0 4964.4 4233.4 4264.9 4270.9 4318.5 4322.1 4333.9 4372.2 4466.0 4466.2 4473.8 4682.7 4729.6 4731.2 4752.0 4767.6 4966.1 4979.0 4979.8 4986.6 5049.5 4553.0 4728.1 4742.5 4742.9 4800.4 4813.7 4863.3 4918.0 4935.4 4994.3 4960.5 4982.6 4986.1 4987.4 5055.0 4848.6 4870.5 4903.5 4905.0 4956.9 4713.7 4776.6 4845.4 4871.6 4898.1 4825.4 4827.9 4835.1 4882.1 4887.9 4696.7 4712.1 4868.6 4892.7 4893.4 4706.6 4767.5 4813.6 4827.0 4884.6 00:58:28 INFO - PROCESS | 16215 | 00:58:28 INFO - PROCESS | 16215 | [#1] ext.html Cycles:180 Average:48528.07 Median:35395.06 stddev:97325.10 (275.0%) stddev-sans-first:97531.46 00:58:28 INFO - PROCESS | 16215 | Values: 553.6 568.2 571.0 573.1 577.1 28279.6 37836.2 39336.8 39388.2 42923.6 39964.8 40438.4 40453.0 40487.0 40528.8 7534.2 7685.9 7687.5 7688.7 7690.0 7659.1 7747.6 7751.1 7751.4 7754.1 7750.5 7797.5 7803.3 7804.3 7806.9 7730.0 7760.9 7770.1 7770.9 7780.0 7625.6 7698.0 7700.4 7703.5 7706.6 37805.6 38183.4 38248.8 38262.2 38278.8 2980.8 2992.6 3030.3 3082.9 3258.5 28602.0 28788.6 28802.3 28990.6 29519.9 3423.2 3425.1 3434.7 3467.6 3480.1 243198.0 243691.0 243811.0 243915.0 243948.0 30876.0 32125.0 32154.0 51621.2 52068.7 33547.8 33588.8 33687.8 33757.0 33768.3 12126.2 12249.5 12257.2 12259.9 12272.3 9723.9 9757.1 9758.4 9759.2 9765.9 7683.8 7811.8 7811.8 7822.5 7875.6 2970.1 3019.5 3028.7 3035.4 3083.9 880.1 892.4 913.2 921.7 933.7 27109.7 27360.9 27446.3 27962.7 27990.7 948.3 950.2 954.8 970.3 990.1 14263.3 14763.5 14801.9 14874.2 14953.6 363216.0 435144.0 442362.0 442634.0 645855.6 49412.8 49975.8 50060.2 50100.5 50101.5 1079.1 1117.8 1179.6 1198.0 1200.8 24611.0 30531.7 31050.2 31311.5 31621.0 46135.5 46956.8 46995.5 47056.5 47169.5 337310.0 339778.0 340431.0 340552.0 340686.0 24665.9 25491.6 25506.4 25514.7 25517.2 40907.0 41384.2 41399.6 41706.2 41890.6 34595.5 35235.5 35373.8 35416.3 35511.3 34775.7 34911.3 34930.0 35044.3 35478.3 34254.8 34324.3 34966.2 35004.3 35009.6 29937.4 31884.4 32023.4 32033.7 32382.5 25168.4 25271.0 25339.4 25369.0 25586.7 00:58:28 INFO - PROCESS | 16215 | 00:58:28 INFO - PROCESS | 16215 | [#2] jquery.html Cycles:180 Average:22779.91 Median:21800.71 stddev:57567.54 (264.1%) stddev-sans-first:57704.37 00:58:28 INFO - PROCESS | 16215 | Values: 340.7 354.9 361.4 364.9 386.7 12560.6 15721.8 15724.3 16732.6 17634.6 16583.3 17039.7 17272.6 17345.3 17478.8 4841.1 4891.3 5005.2 5053.0 5070.9 3664.3 3852.4 5032.9 5126.6 5576.4 5782.8 5919.1 5920.7 5931.9 5933.5 5726.7 5880.9 5915.4 5922.7 5928.6 5221.2 5221.6 5221.6 5227.0 5227.9 20170.5 20581.2 20634.9 20823.5 20839.3 1751.6 1877.3 1942.3 2343.3 2419.3 12486.6 13169.7 13409.5 13759.0 13759.7 1657.7 1755.8 1774.0 1781.0 1797.7 67439.0 68716.7 70905.0 72569.6 72617.6 8136.3 8688.0 8750.4 9173.7 9412.7 11213.5 11246.3 11281.3 11284.0 11294.0 6636.4 6740.2 6803.5 6832.5 6890.2 6747.4 6774.1 6934.9 6961.8 6965.4 3550.3 3685.4 3743.6 3924.2 4090.2 1603.8 1693.5 1743.7 1748.5 1753.8 790.0 829.7 839.7 866.7 879.8 15628.2 16675.8 16801.6 17103.1 17297.8 827.5 841.8 863.6 894.1 909.2 7215.8 9244.2 9572.0 9626.6 9681.7 336775.0 346011.0 347831.0 352625.0 354925.0 45959.5 46151.0 77828.9 78521.6 79875.0 814.6 827.2 829.0 831.5 836.6 14814.5 15012.3 15024.5 15501.8 15759.0 36430.6 37701.8 37976.6 38119.6 39511.2 50031.5 50580.5 50831.2 51332.5 51733.0 7398.4 7522.9 7583.6 7657.2 7739.5 9023.7 11149.3 11400.5 11433.2 11926.6 10395.4 10402.1 10496.7 10544.8 10874.5 9791.7 10034.4 10072.2 10120.8 10243.4 9804.8 9827.6 10275.1 10479.0 10649.6 7321.7 7356.7 7547.4 7566.4 7937.6 9711.7 10066.6 10068.8 10532.8 10752.8 00:58:28 INFO - PROCESS | 16215 | 00:58:28 INFO - PROCESS | 16215 | [#3] mootools.html Cycles:180 Average:4846.61 Median:5202.11 stddev:2680.79 (51.5%) stddev-sans-first:2675.16 00:58:28 INFO - PROCESS | 16215 | Values: 1313.6 1357.3 1366.8 1606.9 1641.9 6571.4 7043.5 7568.5 7571.8 7579.5 6661.3 6813.8 6999.5 6999.5 7170.7 2050.4 2079.8 2088.9 2091.7 2093.6 1793.3 1853.0 2071.8 2072.7 2081.2 2013.1 2086.3 2091.3 2111.3 2116.7 2080.8 2084.4 2090.7 2096.5 2122.4 2098.3 2115.9 2118.4 2118.4 2119.4 7305.1 7320.1 7372.6 7379.2 7384.2 4459.7 4518.3 4608.1 4608.2 4609.1 2784.7 2929.2 2957.0 2971.3 2984.4 900.5 931.6 943.3 947.6 963.4 10041.7 10043.5 10044.0 10054.4 10109.8 4009.2 4028.7 4185.2 4193.7 4209.6 7656.2 7677.3 7712.1 7713.3 7729.2 4501.5 4523.1 4524.8 4531.3 4532.0 4086.2 4168.6 4212.2 4218.2 4219.0 3047.7 3055.4 3129.9 3150.3 3164.3 888.7 929.9 948.5 953.2 965.0 769.5 780.4 793.3 817.7 869.8 4818.4 5080.2 5080.6 5091.3 5187.8 448.5 452.9 457.0 459.4 603.6 3485.8 3498.9 3702.1 3763.2 3764.2 8632.3 8963.2 9032.4 9170.5 9182.4 9047.8 9133.7 9136.2 9145.2 9151.3 6457.2 6975.8 7080.5 7082.0 7088.5 4928.0 5113.8 5216.5 5241.1 5322.3 8259.4 8274.3 8395.8 8418.4 8441.2 8479.7 8489.6 8533.7 8566.9 8608.9 6268.1 6412.8 6417.0 6443.3 6449.4 6906.8 6958.2 6959.0 6963.2 6971.5 6317.8 6428.2 6446.1 6478.9 6516.5 6243.8 6255.3 6307.0 6360.4 6447.8 6084.4 6190.4 6192.8 6194.3 6195.5 4101.3 4202.3 4295.4 4315.1 4328.1 4370.3 4446.7 4459.2 4461.7 4465.5 00:58:28 INFO - PROCESS | 16215 | 00:58:28 INFO - PROCESS | 16215 | [#4] prototype.html Cycles:180 Average:4154.84 Median:4789.87 stddev:1204.74 (25.2%) stddev-sans-first:1172.67 00:58:28 INFO - PROCESS | 16215 | Values: 290.1 290.2 300.7 302.2 303.3 4799.1 4821.0 4829.4 4852.9 4855.9 4769.7 4788.8 4790.9 4806.5 4806.9 3568.9 3675.9 3678.4 3681.3 3714.1 3623.7 3714.0 3764.0 3769.2 3783.2 3719.9 3733.1 3739.6 3748.9 3752.5 3606.1 3742.0 3743.8 3748.6 3754.9 3284.2 3306.6 3309.8 3311.4 3316.6 4523.7 4524.3 4571.3 4592.9 4604.6 4220.2 4225.6 4231.8 4235.9 4248.2 4704.5 4870.4 4908.4 4926.8 4930.7 3608.8 3615.9 3617.3 3617.7 3618.1 5136.6 5139.6 5142.7 5150.6 5205.8 3605.4 3697.9 3734.7 3736.6 3737.6 3761.8 3780.3 3781.5 3781.9 3789.3 4259.5 4261.6 4276.9 4291.9 4304.2 4861.2 4892.9 4907.4 4930.4 4981.9 1242.0 1292.9 1302.2 1302.9 1303.7 822.2 833.7 846.7 847.2 849.1 3971.8 4196.7 4292.9 4331.2 4423.3 5114.9 5118.8 5121.9 5124.7 5131.3 4428.4 4429.9 4445.8 4445.8 4452.1 2583.5 2684.8 2688.2 2702.7 2707.2 4829.8 4833.8 4840.7 4852.8 4863.6 5218.2 5234.5 5242.9 5263.5 5296.7 4766.7 4813.3 4912.2 4922.8 4924.0 5150.8 5163.6 5167.9 5170.3 5170.5 5122.5 5126.8 5133.3 5135.4 5135.8 4694.4 4827.2 4880.8 4883.2 4890.2 3624.1 3633.5 3645.5 3652.8 3680.5 5190.8 5215.4 5215.8 5227.7 5231.8 4963.0 4981.1 5020.4 5028.8 5036.5 5021.7 5023.7 5028.2 5035.3 5054.3 4957.7 4974.8 4978.1 4991.4 5001.7 4773.7 4840.7 4981.8 5026.6 5045.3 4791.2 4805.4 4905.2 4914.5 4919.9 00:58:28 INFO - PROCESS | 16215 | 00:58:28 INFO - PROCESS | 16215 | [#5] yui.html Cycles:180 Average:17680.01 Median:46385.92 stddev:25782.62 (55.6%) stddev-sans-first:25823.30 00:58:28 INFO - PROCESS | 16215 | Values: 669.2 674.6 715.0 730.0 746.9 12386.5 13198.5 13203.2 13245.5 13269.9 13681.3 13910.6 13966.3 14004.6 14026.8 762.9 779.0 779.4 779.6 779.6 763.7 764.2 765.3 766.4 767.4 815.2 816.4 816.6 816.9 817.4 812.8 813.0 813.3 813.6 813.6 598.5 599.1 599.2 600.4 600.7 11669.6 11899.7 12015.3 12054.5 13052.2 11279.3 11442.0 11478.3 11516.2 11749.2 9916.8 10154.0 10200.8 10496.6 10849.8 4101.3 4141.3 4174.2 4261.3 4400.9 60087.7 64312.0 64398.7 64446.4 64466.7 10085.9 10139.7 10237.0 10310.1 10319.2 17584.2 18989.1 18999.1 19000.7 19001.4 5566.4 5857.7 6078.0 6452.0 6962.8 3586.7 3792.7 3829.5 3853.3 3889.3 2970.7 3095.6 3104.2 3108.8 3113.3 529.1 529.5 532.4 533.4 543.5 471.4 499.5 501.9 546.9 557.3 6982.3 7219.4 7467.2 7591.5 7602.0 494.5 520.3 533.7 544.7 550.1 4085.3 4131.2 4210.1 4222.6 4229.9 96652.5 100223.0 103173.5 105386.0 105713.5 85276.0 85499.6 90212.0 91769.5 92832.5 45747.9 46091.5 46680.3 79825.6 81226.6 7955.8 8307.3 8325.1 8328.7 8363.6 42898.4 43728.6 43974.0 45128.0 45233.8 60564.7 67147.0 67217.3 67520.3 71101.0 10781.6 11188.9 11426.9 11789.7 11814.5 12050.3 12309.8 13162.3 13717.7 14159.7 10112.0 10375.4 11616.8 11644.9 11930.5 11006.4 11544.0 12138.4 12341.4 12811.0 10721.9 11323.5 11391.5 11398.8 11464.8 8744.9 9899.7 9902.4 9951.3 10251.6 8836.8 8847.0 9372.6 9427.7 9435.9 00:58:28 INFO - PROCESS | 16215 | -------- Summary: end -------- 00:58:28 INFO - PROCESS | 16215 | 00:58:29 INFO - TEST-INFO | 16215: exit 0 00:58:29 INFO - TEST-OK | dromaeo_css | took 1120999ms 00:58:29 INFO - TEST-START | kraken 00:58:29 INFO - operating with platform_type : linux_ 00:58:29 INFO - Initialising browser for kraken test... 00:58:29 INFO - TEST-INFO | started process 16517 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHtc30S/profile http://localhost:38868/getInfo.html) 00:58:34 INFO - PROCESS | 16517 | __metrics Screen width/height:1600/1200 00:58:34 INFO - PROCESS | 16517 | colorDepth:24 00:58:34 INFO - PROCESS | 16517 | Browser inner width/height: 1024/697 00:58:34 INFO - PROCESS | 16517 | __metrics 00:58:34 INFO - PROCESS | 16517 | 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" 00:58:34 INFO - PROCESS | 16517 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:58:35 INFO - PROCESS | 16517 | console.error: PushService: 00:58:35 INFO - PROCESS | 16517 | stateChangeProcessEnqueue: Error transitioning state 00:58:35 INFO - PROCESS | 16517 | UnknownError 00:58:36 INFO - TEST-INFO | 16517: exit 0 00:58:36 INFO - Browser initialized. 00:58:36 INFO - Running cycle 1/1 for kraken test... 00:58:36 INFO - TEST-INFO | started process 16599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHtc30S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:58:48 INFO - PROCESS | 16599 | RSS: Main: 175325184 00:58:48 INFO - PROCESS | 16599 | 00:58:51 INFO - PROCESS | 16599 | Cycle 1(1): loaded http://localhost:38868/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38868/tests/kraken/driver.html?testName=audio-beat-detection) 00:58:52 INFO - PROCESS | 16599 | RSS: Main: 233447424 00:58:52 INFO - PROCESS | 16599 | 00:58:54 INFO - PROCESS | 16599 | Cycle 1(1): loaded http://localhost:38868/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38868/tests/kraken/driver.html?testName=audio-dft) 00:58:55 INFO - PROCESS | 16599 | RSS: Main: 218611712 00:58:55 INFO - PROCESS | 16599 | 00:58:58 INFO - PROCESS | 16599 | Cycle 1(1): loaded http://localhost:38868/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38868/tests/kraken/driver.html?testName=audio-fft) 00:58:59 INFO - PROCESS | 16599 | RSS: Main: 300871680 00:58:59 INFO - PROCESS | 16599 | 00:59:01 INFO - PROCESS | 16599 | Cycle 1(1): loaded http://localhost:38868/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38868/tests/kraken/driver.html?testName=audio-oscillator) 00:59:02 INFO - PROCESS | 16599 | RSS: Main: 209633280 00:59:02 INFO - PROCESS | 16599 | 00:59:04 INFO - PROCESS | 16599 | Cycle 1(1): loaded http://localhost:38868/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38868/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:59:05 INFO - PROCESS | 16599 | RSS: Main: 213553152 00:59:05 INFO - PROCESS | 16599 | 00:59:08 INFO - PROCESS | 16599 | Cycle 1(1): loaded http://localhost:38868/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38868/tests/kraken/driver.html?testName=imaging-darkroom) 00:59:08 INFO - PROCESS | 16599 | RSS: Main: 250089472 00:59:08 INFO - PROCESS | 16599 | 00:59:12 INFO - PROCESS | 16599 | Cycle 1(1): loaded http://localhost:38868/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38868/tests/kraken/driver.html?testName=imaging-desaturate) 00:59:13 INFO - PROCESS | 16599 | RSS: Main: 244711424 00:59:13 INFO - PROCESS | 16599 | 00:59:15 INFO - PROCESS | 16599 | Cycle 1(1): loaded http://localhost:38868/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38868/tests/kraken/driver.html?testName=json-parse-financial) 00:59:16 INFO - PROCESS | 16599 | RSS: Main: 248315904 00:59:16 INFO - PROCESS | 16599 | 00:59:18 INFO - PROCESS | 16599 | Cycle 1(1): loaded http://localhost:38868/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38868/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:59:18 INFO - PROCESS | 16599 | RSS: Main: 211308544 00:59:18 INFO - PROCESS | 16599 | 00:59:20 INFO - PROCESS | 16599 | Cycle 1(1): loaded http://localhost:38868/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38868/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:59:21 INFO - PROCESS | 16599 | RSS: Main: 219029504 00:59:21 INFO - PROCESS | 16599 | 00:59:23 INFO - PROCESS | 16599 | Cycle 1(1): loaded http://localhost:38868/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38868/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:59:24 INFO - PROCESS | 16599 | RSS: Main: 221949952 00:59:24 INFO - PROCESS | 16599 | 00:59:27 INFO - PROCESS | 16599 | Cycle 1(1): loaded http://localhost:38868/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38868/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:59:27 INFO - PROCESS | 16599 | RSS: Main: 223891456 00:59:27 INFO - PROCESS | 16599 | 00:59:30 INFO - PROCESS | 16599 | Cycle 1(1): loaded http://localhost:38868/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38868/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:59:31 INFO - PROCESS | 16599 | RSS: Main: 221884416 00:59:31 INFO - PROCESS | 16599 | 00:59:33 INFO - PROCESS | 16599 | Cycle 1(1): loaded http://localhost:38868/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38868/tests/kraken/driver.html?testName=ai-astar) 00:59:33 INFO - PROCESS | 16599 | RSS: Main: 272519168 00:59:33 INFO - PROCESS | 16599 | 00:59:33 INFO - PROCESS | 16599 | __start_tp_report 00:59:33 INFO - PROCESS | 16599 | _x_x_mozilla_page_load 00:59:33 INFO - PROCESS | 16599 | _x_x_mozilla_page_load_details 00:59:33 INFO - PROCESS | 16599 | |i|pagename|runs| 00:59:33 INFO - PROCESS | 16599 | |0;ai-astar;112;115;115;114;114;116;115;114;113;114 00:59:33 INFO - PROCESS | 16599 | |1;audio-beat-detection;153;128;124;176;137;125;128;128;157;125 00:59:33 INFO - PROCESS | 16599 | |2;audio-dft;162;168;162;164;163;162;163;162;163;161 00:59:33 INFO - PROCESS | 16599 | |3;audio-fft;76;78;78;110;76;78;78;76;103;76 00:59:33 INFO - PROCESS | 16599 | |4;audio-oscillator;83;83;118;84;84;84;112;83;83;127 00:59:33 INFO - PROCESS | 16599 | |5;imaging-gaussian-blur;118;118;117;118;118;117;118;118;118;118 00:59:33 INFO - PROCESS | 16599 | |6;imaging-darkroom;146;146;145;145;146;146;145;146;146;146 00:59:33 INFO - PROCESS | 16599 | |7;imaging-desaturate;95;95;95;96;94;96;95;95;95;102 00:59:33 INFO - PROCESS | 16599 | |8;json-parse-financial;64;63;63;64;64;66;64;64;64;64 00:59:33 INFO - PROCESS | 16599 | |9;json-stringify-tinderbox;66;66;67;66;68;67;67;67;67;67 00:59:33 INFO - PROCESS | 16599 | |10;stanford-crypto-aes;83;92;84;82;82;85;88;83;83;90 00:59:33 INFO - PROCESS | 16599 | |11;stanford-crypto-ccm;135;138;144;132;132;131;141;136;174;135 00:59:33 INFO - PROCESS | 16599 | |12;stanford-crypto-pbkdf2;182;179;178;177;173;178;171;173;177;173 00:59:33 INFO - PROCESS | 16599 | |13;stanford-crypto-sha256-iterative;69;71;71;72;72;81;70;69;70;69 00:59:33 INFO - PROCESS | 16599 | __end_tp_report 00:59:33 INFO - PROCESS | 16599 | __start_cc_report 00:59:33 INFO - PROCESS | 16599 | _x_x_mozilla_cycle_collect,1899 00:59:33 INFO - PROCESS | 16599 | __end_cc_report 00:59:33 INFO - PROCESS | 16599 | __startTimestamp1474963173435__endTimestamp 00:59:33 INFO - PROCESS | 16599 | 00:59:33 INFO - PROCESS | 16599 | ------- Summary: start ------- 00:59:33 INFO - PROCESS | 16599 | Number of tests: 14 00:59:33 INFO - PROCESS | 16599 | 00:59:33 INFO - PROCESS | 16599 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.50 stddev:1.14 (1.0%) stddev-sans-first:0.88 00:59:33 INFO - PROCESS | 16599 | Values: 112.0 115.0 115.0 114.0 114.0 116.0 115.0 114.0 113.0 114.0 00:59:33 INFO - PROCESS | 16599 | 00:59:33 INFO - PROCESS | 16599 | [#1] audio-beat-detection Cycles:10 Average:138.10 Median:132.50 stddev:17.84 (13.5%) stddev-sans-first:18.09 00:59:33 INFO - PROCESS | 16599 | Values: 153.0 128.0 124.0 176.0 137.0 125.0 128.0 128.0 157.0 125.0 00:59:33 INFO - PROCESS | 16599 | 00:59:33 INFO - PROCESS | 16599 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.94 (1.2%) stddev-sans-first:2.03 00:59:33 INFO - PROCESS | 16599 | Values: 162.0 168.0 162.0 164.0 163.0 162.0 163.0 162.0 163.0 161.0 00:59:33 INFO - PROCESS | 16599 | 00:59:33 INFO - PROCESS | 16599 | [#3] audio-fft Cycles:10 Average:82.90 Median:77.00 stddev:12.58 (16.3%) stddev-sans-first:13.10 00:59:33 INFO - PROCESS | 16599 | Values: 76.0 78.0 78.0 110.0 76.0 78.0 78.0 76.0 103.0 76.0 00:59:33 INFO - PROCESS | 16599 | 00:59:33 INFO - PROCESS | 16599 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:83.00 stddev:17.55 (21.1%) stddev-sans-first:18.15 00:59:33 INFO - PROCESS | 16599 | Values: 83.0 83.0 118.0 84.0 84.0 84.0 112.0 83.0 83.0 127.0 00:59:33 INFO - PROCESS | 16599 | 00:59:33 INFO - PROCESS | 16599 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 00:59:33 INFO - PROCESS | 16599 | Values: 118.0 118.0 117.0 118.0 118.0 117.0 118.0 118.0 118.0 118.0 00:59:33 INFO - PROCESS | 16599 | 00:59:33 INFO - PROCESS | 16599 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 00:59:33 INFO - PROCESS | 16599 | Values: 146.0 146.0 145.0 145.0 146.0 146.0 145.0 146.0 146.0 146.0 00:59:33 INFO - PROCESS | 16599 | 00:59:33 INFO - PROCESS | 16599 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.00 stddev:2.25 (2.4%) stddev-sans-first:2.37 00:59:33 INFO - PROCESS | 16599 | Values: 95.0 95.0 95.0 96.0 94.0 96.0 95.0 95.0 95.0 102.0 00:59:33 INFO - PROCESS | 16599 | 00:59:33 INFO - PROCESS | 16599 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 00:59:33 INFO - PROCESS | 16599 | Values: 64.0 63.0 63.0 64.0 64.0 66.0 64.0 64.0 64.0 64.0 00:59:33 INFO - PROCESS | 16599 | 00:59:33 INFO - PROCESS | 16599 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 00:59:33 INFO - PROCESS | 16599 | Values: 66.0 66.0 67.0 66.0 68.0 67.0 67.0 67.0 67.0 67.0 00:59:33 INFO - PROCESS | 16599 | 00:59:33 INFO - PROCESS | 16599 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:84.50 stddev:3.55 (4.2%) stddev-sans-first:3.68 00:59:33 INFO - PROCESS | 16599 | Values: 83.0 92.0 84.0 82.0 82.0 85.0 88.0 83.0 83.0 90.0 00:59:33 INFO - PROCESS | 16599 | 00:59:33 INFO - PROCESS | 16599 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:137.00 stddev:12.70 (9.3%) stddev-sans-first:13.35 00:59:33 INFO - PROCESS | 16599 | Values: 135.0 138.0 144.0 132.0 132.0 131.0 141.0 136.0 174.0 135.0 00:59:33 INFO - PROCESS | 16599 | 00:59:33 INFO - PROCESS | 16599 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.10 Median:177.50 stddev:3.45 (1.9%) stddev-sans-first:2.92 00:59:33 INFO - PROCESS | 16599 | Values: 182.0 179.0 178.0 177.0 173.0 178.0 171.0 173.0 177.0 173.0 00:59:33 INFO - PROCESS | 16599 | 00:59:33 INFO - PROCESS | 16599 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.00 stddev:3.57 (5.0%) stddev-sans-first:3.67 00:59:33 INFO - PROCESS | 16599 | Values: 69.0 71.0 71.0 72.0 72.0 81.0 70.0 69.0 70.0 69.0 00:59:33 INFO - PROCESS | 16599 | -------- Summary: end -------- 00:59:33 INFO - PROCESS | 16599 | 00:59:34 INFO - TEST-INFO | 16599: exit 0 00:59:34 INFO - TEST-OK | kraken | took 65006ms 00:59:34 INFO - SUITE-END | took 1186s 00:59:35 INFO - Completed test suite (00:19:46) 00:59:35 INFO - javascript benchmark 00:59:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2568.987155064224, 2595.9870200649016, 2623.737626237376, 2634.380920483686, 2648.205538338498, 4505.9861531155475, 4564.201264778659, 4679.087577922302, 4682.836100736475, 4697.506761790014, 4602.493725690179, 4612.40038794957, 4627.028324051945, 4671.112488627158, 4711.128441238365, 4260.446142001551, 4295.591918767727, 4341.45731783527, 4351.021020270446, 4357.433533640622, 4296.312589985588, 4385.2106620808245, 4423.336499525081, 4430.379746835446, 4472.865814025585, 4184.0, 4318.762468064255, 4324.589164029444, 4333.285007973681, 4429.202743506167, 4221.577842215785, 4262.041040765834, 4262.957370426287, 4272.423222864935, 4310.892227694301, 4275.166342563201, 4286.357046443028, 4336.956630433687, 4345.956540434587, 4352.477702675699, 4622.352870598119, 4665.673402861801, 4668.066386722635, 4715.316279139505, 4732.858014259577, 4742.620590352763, 4814.157522433595, 4976.601871850244, 4983.750812459399, 4983.825566105169, 4908.779104940286, 4933.950660493385, 4975.154223781966, 4975.875603109951, 5046.394432668067, 4617.630589552828, 4630.305454181832, 4630.930536041962, 4636.582707556337, 4687.929681054787, 4924.975375123173, 5044.142495775727, 5065.6200784941275, 5076.771545280398, 5138.614603904722, 4784.234522476457, 4788.329633851264, 4790.041991601694, 4828.927566086511, 4846.3699719037, 4825.927611085836, 4836.733979631154, 4864.586510146677, 4919.385076865392, 4987.202047672427, 4916.508349165055, 4917.58200552957, 4919.458859525449, 4922.720092775904, 4993.7503124843615, 4749.548792864673, 4783.904321913612, 4785.545373189541, 4827.372441582642, 4868.488808675109, 4181.059261666162, 4184.225918205142, 4209.284421648327, 4232.30167022444, 4233.238017156941, 3652.196516766307, 3667.5598928128798, 3671.100580357776, 3717.126475278307, 3721.739478236552, 4123.36087906375, 4187.7696726679715, 4229.767362795014, 4248.808803603845, 4253.957460425418, 4925.655204135748, 4926.310316555685, 4926.605871530269, 4963.0, 4964.379452568429, 4233.428487154257, 4264.850730224427, 4270.935935960901, 4318.460192475941, 4322.1139666368945, 4333.913321733611, 4372.213001659732, 4466.0, 4466.196084704784, 4473.753943533137, 4682.695624784378, 4729.55069268419, 4731.219348807408, 4751.976240118777, 4767.570918617341, 4966.056449274626, 4979.029089327546, 4979.800807967641, 4986.576141028053, 5049.545540901337, 4552.954470455253, 4728.0780247851335, 4742.549457801503, 4742.881427964328, 4800.35195248637, 4813.7352445615825, 4863.294822250825, 4918.016396720599, 4935.383077115361, 4994.250862370528, 4960.50394960501, 4982.62630302736, 4986.077575648516, 4987.376577927759, 5055.014272216882, 4848.612111031039, 4870.537298956593, 4903.485134060872, 4905.0, 4956.925646115239, 4713.67004309695, 4776.641751868554, 4845.370101886732, 4871.634627402888, 4898.069366820293, 4825.396825396825, 4827.879303017453, 4835.057163853015, 4882.121218180761, 4887.853364399074, 4696.694714843524, 4712.128256272601, 4868.610511159028, 4892.730899800546, 4893.363862697826, 4706.623470122314, 4767.523247675204, 4813.590844778233, 4827.0, 4884.584810291165], "value": 4560.067935200524, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.6124712701109, 568.2186992884783, 570.9921987691724, 573.1288441568815, 577.0737965565265, 28279.575806362896, 37836.24327513448, 39336.80331598345, 39388.212235755265, 42923.570764292344, 39964.80017599915, 40438.39342409859, 40453.0, 40487.0, 40528.79735601325, 7534.171241163468, 7685.923140768605, 7687.538747675129, 7688.654010569509, 7690.038745156856, 7659.080910290745, 7747.573883436408, 7751.147373788879, 7751.418643601753, 7754.0695116586085, 7750.5349679019155, 7797.532148071105, 7803.29770320671, 7804.336631386311, 7806.921930780676, 7730.033745781778, 7760.922390776076, 7770.067591888953, 7770.883436748453, 7779.961100194491, 7625.580593067379, 7698.03774528184, 7700.383969282444, 7703.499272547267, 7706.576138312391, 37805.62194378048, 38183.427248591295, 38248.80875595632, 38262.23475530501, 38278.80860595707, 2980.76153907689, 2992.62592175978, 3030.2878823476467, 3082.9383412331626, 3258.527513510551, 28602.0, 28788.568171477236, 28802.279943001384, 28990.565141522893, 29519.85240073786, 3423.178437175085, 3425.0581090200144, 3434.708049815769, 3467.5665541807275, 3480.077779388464, 243198.0, 243691.0, 243811.0, 243915.0, 243948.0, 30876.0, 32125.0, 32154.0, 51621.22568161481, 52068.739656302234, 33547.83226083903, 33588.801399825024, 33687.83156084204, 33757.0, 33768.32463350719, 12126.151169418055, 12249.510019599116, 12257.203281786655, 12259.896609305206, 12272.263664180178, 9723.9027609723, 9757.073078057572, 9758.414495130315, 9759.170470510086, 9765.902340976641, 7683.846323073507, 7811.804704882424, 7811.843763124706, 7822.530648161129, 7875.566843823644, 2970.12381347503, 3019.4715924713087, 3028.6668466468673, 3035.3929214157256, 3083.938321233563, 880.1418616848522, 892.3664198419195, 913.2100732866156, 921.6589861751195, 933.6918816790443, 27109.72890271072, 27360.903006692875, 27446.313842153708, 27962.72037279601, 27990.72009279922, 948.3266880514911, 950.1875896108866, 954.8042651256476, 970.3207754571828, 990.0594435286363, 14263.330655797865, 14763.483278085216, 14801.925990369979, 14874.181919994504, 14953.551393458214, 363216.0, 435144.0, 442362.0, 442634.0, 645855.6243312708, 49412.75293623509, 49975.75012124916, 50060.249096263586, 50100.49899501031, 50101.49898500968, 1079.1420820447763, 1117.765269293425, 1179.5930404010603, 1197.9940100299616, 1200.7598480303975, 24611.0, 30531.694683053774, 31050.223744406572, 31311.53032704557, 31621.0, 46135.53864461447, 46956.7652161737, 46995.53004469912, 47056.52943470521, 47169.528304716514, 337310.0, 339778.0, 340431.0, 340552.0, 340686.0, 24665.87667061725, 25491.617625736, 25506.362340941625, 25514.744852551237, 25517.23448296554, 40907.0, 41384.172316554104, 41399.58600413957, 41706.16587668169, 41890.58109418989, 34595.4810677835, 35235.47146792852, 35373.82313088418, 35416.29167416689, 35511.28977420489, 34775.65224347825, 34911.301773964886, 34930.0, 35044.29911401809, 35478.29043419169, 34254.82872585721, 34324.313513730085, 34966.215372629464, 35004.299914001065, 35009.61802693027, 29937.401251974403, 31884.36231275315, 32023.359532808747, 32033.67966320307, 32382.514262285615, 25168.37079073038, 25271.0, 25339.366515837253, 25369.0, 25586.744132558437], "value": 16282.793830163317, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.7223113162774, 354.88821021378266, 361.3549813582755, 364.89782860798977, 386.7157639135235, 12560.560380386676, 15721.76417353739, 15724.29240684169, 16732.58168545784, 17634.647307053885, 16583.253753581088, 17039.74440383392, 17272.56818579536, 17345.306187752474, 17478.825211747877, 4841.1285968525735, 4891.25277798587, 5005.2492126181, 5052.974735126338, 5070.873228169288, 3664.340418724642, 3852.4028775539696, 5032.924506132411, 5126.615503837208, 5576.386597474275, 5782.797602083928, 5919.112133180036, 5920.703964801743, 5931.940680593182, 5933.465988061073, 5726.7422965966425, 5880.852978675524, 5915.378885217055, 5922.674252916088, 5928.584999050068, 5221.164613661834, 5221.556167725748, 5221.582273418117, 5227.0, 5227.869303267411, 20170.495737606532, 20581.176752929863, 20634.896825515927, 20823.479413014644, 20839.270625528185, 1751.6440387678551, 1877.2584828992472, 1942.2522328903474, 2343.27358518858, 2419.334682962182, 12486.625401237978, 13169.736605267937, 13409.46362145513, 13759.0, 13759.656008599764, 1657.734762438004, 1755.7717496725345, 1773.9822601774076, 1781.0, 1797.7123660214434, 67439.0, 68716.65641671809, 70905.0, 72569.63715181443, 72617.63691181563, 8136.308413784776, 8687.956560217159, 8750.431221970552, 9173.724788256362, 9412.67055653049, 11213.495392707347, 11246.325220486797, 11281.26671766349, 11283.984441400313, 11294.04000659953, 6636.369544893324, 6740.157480314961, 6803.4557235422035, 6832.487563432763, 6890.2076261229595, 6747.426468750113, 6774.119364482585, 6934.895976560255, 6961.82595435108, 6965.442764578822, 3550.2721942002345, 3685.4103343464917, 3743.6069212732273, 3924.156306394139, 4090.202410529918, 1603.7594360845967, 1693.4580934101216, 1743.6599863026588, 1748.4579780268157, 1753.798313193999, 789.9802504937422, 829.701307529289, 839.7061028639927, 866.7443104284251, 879.8416285068621, 15628.2185890705, 16675.79872284054, 16801.57996050084, 17103.14484275781, 17297.827021729874, 827.5324441690426, 841.7516832534417, 863.5595846118525, 894.0567701075298, 909.2226146644656, 7215.819604509929, 9244.168024877794, 9571.952140239255, 9626.566804493814, 9681.70954871355, 336775.0, 346011.0, 347831.0, 352625.0, 354925.0, 45959.54040459619, 46151.0, 77828.93916340372, 78521.60739196381, 79875.0, 814.5886327404622, 827.23480780278, 828.9917100829035, 831.5301854452337, 836.610975896199, 14814.48149314812, 15012.324445399765, 15024.474143405365, 15501.84498155004, 15759.0, 36430.635693642726, 37701.81149094237, 37976.620233798414, 38119.61880381161, 39511.20977580375, 50031.49968500414, 50580.49419505758, 50831.237531436316, 51332.48667513426, 51733.0, 7398.445116616383, 7522.924770752441, 7583.620818959141, 7657.234276572298, 7739.458237923516, 9023.684171053981, 11149.275297105987, 11400.543978240778, 11433.1996760226, 11926.642200733992, 10395.428251446243, 10402.115820155372, 10496.68509944703, 10544.789104218025, 10874.510647021061, 9791.65729199503, 10034.397936123856, 10072.194224461879, 10120.797584048425, 10243.436610986468, 9804.803903922024, 9827.606895724091, 10275.126614237874, 10478.952104789765, 10649.627263045757, 7321.74373896911, 7356.742514011984, 7547.396208303432, 7566.394688424803, 7937.563434011185, 9711.708648740549, 10066.647667331608, 10068.848967265643, 10532.789344213226, 10752.83870741955], "value": 8028.381653678164, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1313.6124843171267, 1357.2670757790788, 1366.7949807528873, 1606.9196540172989, 1641.9261133248995, 6571.3757193066585, 7043.50695451318, 7568.508046976949, 7571.772846814591, 7579.507332023421, 6661.333866613336, 6813.7955861324235, 6999.545029573074, 6999.545029573074, 7170.677319520634, 2050.374635736096, 2079.8440116991287, 2088.8955552222405, 2091.717618121557, 2093.6231478333893, 1793.2737241417246, 1853.0, 2071.7513898332145, 2072.6580114281123, 2081.240347273242, 2013.1041686449537, 2086.321945367754, 2091.3203208957075, 2111.313823007521, 2116.6824976253533, 2080.843936704746, 2084.4476213803355, 2090.6550419180817, 2096.465401322668, 2122.395117391536, 2098.26560703754, 2115.894205289729, 2118.406846083099, 2118.4492032071616, 2119.3853782403085, 7305.086864141982, 7320.084989376328, 7372.594507302097, 7379.151397589292, 7384.2246564111065, 4459.732416055047, 4518.254488009475, 4608.101420223024, 4608.193566125915, 4609.055143695535, 2784.665840099201, 2929.2383980165096, 2956.9852150739107, 2971.3463038131576, 2984.3882004189304, 900.5497251374313, 931.6133804471204, 943.2925306020485, 947.6114792934864, 963.3834346018554, 10041.748956276078, 10043.54804033813, 10044.0, 10054.447005414699, 10109.797804043952, 4009.218202450494, 4028.738132021409, 4185.246655602021, 4193.666035501783, 4209.5790420957655, 7656.157822639505, 7677.347425468898, 7712.113106992768, 7713.344365728976, 7729.227077292338, 4501.459824821042, 4523.140603285366, 4524.773761311922, 4531.252343363374, 4532.0, 4086.203190377848, 4168.6039826216465, 4212.220739163265, 4218.177455396169, 4218.957810421918, 3047.6952304769347, 3055.4194703006356, 3129.8591563379246, 3150.2754366495833, 3164.256399746058, 888.7244954064261, 929.8655640119044, 948.4641177734558, 953.2374100719396, 964.9855252171224, 769.5036701327613, 780.4380845791021, 793.3415265329762, 817.7178873288706, 869.8431086654734, 4818.373611430492, 5080.237964305384, 5080.568151707146, 5091.287219789232, 5187.766550505236, 448.45736658642755, 452.9456465224128, 456.9543045695404, 459.35231323833233, 603.646866583045, 3485.8431370588382, 3498.8600455981987, 3702.074481379655, 3763.190913953458, 3764.153065560282, 8632.309415246766, 8963.193312601898, 9032.36773425854, 9170.541472926327, 9182.403143795633, 9047.773805654911, 9133.725988220363, 9136.223421009288, 9145.176934075966, 9151.267898568098, 6457.225132983978, 6975.79072627822, 7080.504364694525, 7081.964590177016, 7088.468364872552, 4927.975360123177, 5113.846584602468, 5216.452272511484, 5241.135212690016, 5322.308099946982, 8259.380546458919, 8274.338052955869, 8395.790105247417, 8418.410711250399, 8441.15588441151, 8479.703210387606, 8489.617967191614, 8533.74398768038, 8566.871496927426, 8608.870866936875, 6268.091126786681, 6412.807615771534, 6416.967915160394, 6443.259025212161, 6449.355064493513, 6906.758263460755, 6958.234594194736, 6958.965205173941, 6963.199232088375, 6971.5468494547695, 6317.778877739257, 6428.19647544057, 6446.09754634361, 6478.935210647834, 6516.543841931019, 6243.7814676486105, 6255.343188965275, 6307.0, 6360.427561519486, 6447.806565803034, 6084.39156084388, 6190.442860142609, 6192.752289908353, 6194.256689197326, 6195.504359651307, 4101.302778527598, 4202.348635961431, 4295.4201182839915, 4315.11540134278, 4328.069465065026, 4370.278903980935, 4446.710963787473, 4459.219636563654, 4461.687681862239, 4465.5311192325635], "value": 3869.8520768177923, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.0732160746415, 290.1599868381037, 300.7368552516548, 302.1871166561947, 303.25097010384343, 4799.136155492014, 4820.975895120519, 4829.44461386941, 4852.85441436757, 4855.863420095156, 4769.713817170972, 4788.80844766209, 4790.928136077961, 4806.5193480651915, 4806.870385459423, 3568.8750893718725, 3675.9448608270895, 3678.356287649664, 3681.3005528949416, 3714.1457464783116, 3623.6773577644235, 3713.9814300928456, 3764.0, 3769.227308401771, 3783.186614877801, 3719.888403347904, 3733.1413774831803, 3739.626037396266, 3748.9437658435145, 3752.4558938953837, 3606.090197094396, 3741.9812900935594, 3743.8128093595346, 3748.6438788315068, 3754.943675844851, 3284.1953721338186, 3306.570145881044, 3309.7683162178655, 3311.420501412267, 3316.585426821647, 4523.683342166017, 4524.298733696282, 4571.337156112345, 4592.885177870547, 4604.58558729716, 4220.240356735786, 4225.598568136023, 4231.767252801125, 4235.91528169438, 4248.171606536726, 4704.529547045302, 4870.366852309177, 4908.361912951329, 4926.802927882881, 4930.704157750546, 3608.8376023078763, 3615.9096022599383, 3617.3307938031285, 3617.7105831533413, 3618.1135621772833, 5136.64043516954, 5139.614528910347, 5142.717150556718, 5150.587952963791, 5205.843824685227, 3605.351036813346, 3697.8520859165333, 3734.7012239020814, 3736.5889752127246, 3737.551493820759, 3761.8119094045187, 3780.319542482325, 3781.4516895050065, 3781.9432708509394, 3789.3368660484307, 4259.488861336659, 4261.595148460891, 4276.935845962313, 4291.914161716748, 4304.225239456928, 4861.152761950436, 4892.877678058077, 4907.3620429343955, 4930.408350997904, 4981.879077207599, 1241.9875801242054, 1292.8965682745359, 1302.2251760202664, 1302.908796384244, 1303.687115092371, 822.2394285286206, 833.741540122564, 846.7417437681443, 847.1782371100023, 849.1466076592984, 3971.781552014609, 4196.706230563831, 4292.871213863589, 4331.155424692155, 4423.270160423494, 5114.897702045938, 5118.820841270612, 5121.924395876833, 5124.718140502308, 5131.255373173064, 4428.357888106271, 4429.933550996738, 4445.777711114431, 4445.844395446144, 4452.107854161968, 2583.522048421048, 2684.7583717465523, 2688.206978941217, 2702.662167229096, 2707.160780158157, 4829.782659780319, 4833.782479788418, 4840.733759643183, 4852.816232695231, 4863.635227357962, 5218.165093585008, 5234.502722241381, 5242.9213561796605, 5263.499967503081, 5296.682199068068, 4766.712987493357, 4813.326134341195, 4912.1649319615035, 4922.778474968635, 4923.950760492349, 5150.845474635767, 5163.580015495769, 5167.870803229949, 5170.250313704567, 5170.482951704799, 5122.513361230677, 5126.820561280487, 5133.332666753298, 5135.409427915837, 5135.845924622267, 4694.413198350207, 4827.155247831545, 4880.80476780939, 4883.169861123689, 4890.242012487928, 3624.1120925373452, 3633.5094762207823, 3645.54430696163, 3652.817359132086, 3680.521532200904, 5190.766415511386, 5215.4002289735645, 5215.843524694265, 5227.660202086852, 5231.790728370975, 4963.0, 4981.135846887982, 5020.447750747488, 5028.823991160438, 5036.521530454601, 5021.6735912165595, 5023.748812559431, 5028.245763135559, 5035.295058691713, 5054.2923990642075, 4957.677750946177, 4974.7512624369365, 4978.1288274552535, 4991.425986011655, 5001.699898006132, 4773.71357718538, 4840.709557426566, 4981.8007279709855, 5026.623003274696, 5045.268436076822, 4791.179351846276, 4805.37530121082, 4905.190643543775, 4914.459409465027, 4919.877003074952], "value": 3771.510060075494, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.176912397751, 674.554793836068, 714.9847216951928, 729.9671514781834, 746.8730315846306, 12386.504539818408, 13198.53805116821, 13203.207807531555, 13245.536406225783, 13269.933650331746, 13681.3159342033, 13910.582682519514, 13966.30168491574, 14004.64988375291, 14026.789598156036, 762.8931949527084, 778.9610519474032, 779.3842864137325, 779.5556532776292, 779.6179871862774, 763.7326935572561, 764.2433990349542, 765.2844590308052, 766.4290103872595, 767.386091127096, 815.213319147023, 816.4203415574949, 816.5549775372407, 816.930560902324, 817.358373676664, 812.7764864662206, 813.0203105258208, 813.3086876155221, 813.5769399912042, 813.6379311206515, 598.5181928547518, 599.143225187981, 599.2240049136379, 600.432591201315, 600.6996501749126, 11669.591564295293, 11899.702507437296, 12015.339156346397, 12054.457549410297, 13052.21686698801, 11279.266847654877, 11442.0, 11478.311301321948, 11516.193866429354, 11749.236299640495, 9916.752081197956, 10154.0, 10200.79598408035, 10496.632617858415, 10849.78300433987, 4101.323281658552, 4141.254574176647, 4174.165166966619, 4261.296886013804, 4400.889977750549, 60087.69956150235, 64312.0, 64398.678006610135, 64446.35553644497, 64466.67766661184, 10085.949570252102, 10139.7465063374, 10237.0, 10310.123639490577, 10319.226058045677, 17584.208710608054, 18989.145488453054, 18999.05004749757, 19000.714989275173, 19001.42995710131, 5566.359868615161, 5857.6862139455525, 6077.969610151921, 6451.967740161269, 6962.825929351706, 3586.659267369596, 3792.6776224020714, 3829.483019792348, 3853.2871418787613, 3889.2610404023144, 2970.7326340629015, 3095.597572315585, 3104.2239440139965, 3108.8290144042294, 3113.2995076107695, 529.1295818378823, 529.5313647421982, 532.3877540828001, 533.4105813076573, 543.4538289019589, 471.43663322329485, 499.48552990419927, 501.9272205530178, 546.8906218756265, 557.3395526301346, 6982.33667801558, 7219.422446204291, 7467.215942326086, 7591.4685971981435, 7602.0, 494.451159213273, 520.3443660987183, 533.6904595334696, 544.6731960823554, 550.0813641219173, 4085.264652362603, 4131.194417088639, 4210.136921930997, 4222.577742225752, 4229.915401691949, 96652.51673741586, 100223.0, 103173.48413257886, 105386.0, 105713.47143264388, 85276.0, 85499.57250213834, 90212.0, 91769.54115229515, 92832.53583732038, 45747.908339333546, 46091.539084609394, 46680.299795503095, 79825.60087199527, 81226.59386703146, 7955.761327160194, 8307.335413167053, 8325.125861784425, 8328.708495202638, 8363.581820909052, 42898.35652465153, 43728.56271437245, 43974.0, 45128.0, 45233.77383113063, 60564.69717651384, 67147.0, 67217.32782672111, 67520.3247967514, 71101.0, 10781.62264320745, 11188.87411391833, 11426.885731142582, 11789.705257368634, 11814.468348924147, 12050.337231452355, 12309.79417675657, 13162.341882905625, 13717.657058573217, 14159.716805664035, 10112.0, 10375.377477351383, 11616.825747613624, 11644.941775291069, 11930.463129159381, 11006.449677515931, 11544.0, 12138.393080346124, 12341.444634991267, 12810.952693431978, 10721.946390267998, 11323.547058117583, 11391.54433822671, 11398.829017564578, 11464.770704586028, 8744.868826967473, 9899.703008909744, 9902.405855648683, 9951.253655975686, 10251.646681304059, 8836.779080523038, 8847.029683192923, 9372.60998445392, 9427.717168484956, 9435.905640943503], "value": 6510.450462431637, "unit": "score"}], "name": "dromaeo_css", "value": 6197.2605271521015, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 115.0, 114.0, 114.0, 116.0, 115.0, 114.0, 113.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 128.0, 124.0, 176.0, 137.0, 125.0, 128.0, 128.0, 157.0, 125.0], "value": 138.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 168.0, 162.0, 164.0, 163.0, 162.0, 163.0, 162.0, 163.0, 161.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 78.0, 110.0, 76.0, 78.0, 78.0, 76.0, 103.0, 76.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 118.0, 84.0, 84.0, 84.0, 112.0, 83.0, 83.0, 127.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 94.0, 96.0, 95.0, 95.0, 95.0, 102.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 64.0, 64.0, 66.0, 64.0, 64.0, 64.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 92.0, 84.0, 82.0, 82.0, 85.0, 88.0, 83.0, 83.0, 90.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 138.0, 144.0, 132.0, 132.0, 131.0, 141.0, 136.0, 174.0, 135.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 179.0, 178.0, 177.0, 173.0, 178.0, 171.0, 173.0, 177.0, 173.0], "value": 176.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 71.0, 72.0, 72.0, 81.0, 70.0, 69.0, 70.0, 69.0], "value": 71.4, "unit": "score"}], "name": "kraken", "value": 1554.8999999999999, "alertThreshold": 2.0}]} 00:59:35 INFO - Return code: 0 00:59:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:59:35 INFO - # TBPL SUCCESS # 00:59:35 INFO - Running post-action listener: _resource_record_post_action 00:59:35 INFO - [mozharness: 2016-09-27 07:59:35.223731Z] Finished run-tests step (success) 00:59:35 INFO - Running post-run listener: _resource_record_post_run 00:59:35 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 390963200; Read time: 0; Write time: 308992 00:59:35 INFO - TinderboxPrint: CPU usage
13.0% 00:59:35 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 00:59:35 INFO - TinderboxPrint: I/O write bytes / time
390,963,200 / 308,992 00:59:35 INFO - TinderboxPrint: CPU idle
8,350.3 (87.0%) 00:59:35 INFO - TinderboxPrint: CPU user
1,199.5 (12.5%) 00:59:35 INFO - TinderboxPrint: Swap in / out
0 / 0 00:59:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99909632; Read time: 0; Write time: 117856 00:59:35 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 291053568; Read time: 0; Write time: 191136 00:59:35 INFO - Running post-run listener: _upload_blobber_files 00:59:35 INFO - Blob upload gear active. 00:59:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:59:35 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 00:59:35 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'] 00:59:35 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 00:59:36 INFO - (blobuploader) - INFO - Open directory for files ... 00:59:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:59:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:59:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:59:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:59:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:59:37 INFO - (blobuploader) - INFO - Done attempting. 00:59:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:59:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:59:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:59:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:59:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:59:38 INFO - (blobuploader) - INFO - Done attempting. 00:59:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:59:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:59:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:59:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:59:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:59:41 INFO - (blobuploader) - INFO - Done attempting. 00:59:41 INFO - (blobuploader) - INFO - Iteration through files over. 00:59:41 INFO - Return code: 0 00:59:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:59:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:59:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fae33a985005ac4b194423fbccd88d393784dcf9c948eb00910f437b86a276cbdb0753f4a8a4b786236a50b3c9b5dbecb423ad3fa92bf6743cdb5d54edaac55d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50e3e248efd823d365eed9f92f2f268e0deca10b43334d3208f7b2483a5c951865d1ed20cf8376be0d1f7e756f71f9bc59eef0bf09432f0576b1bdad1793ec3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/84b5938f23003db8927067ed2097e5076fdbfc997d4f63c705503ed7699d996e4ea6b010901e54fb61a7807b7057467b29819f72d61abb46d2759f469c2fbe7f"} 00:59:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:59:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:59:41 INFO - Contents: 00:59:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fae33a985005ac4b194423fbccd88d393784dcf9c948eb00910f437b86a276cbdb0753f4a8a4b786236a50b3c9b5dbecb423ad3fa92bf6743cdb5d54edaac55d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50e3e248efd823d365eed9f92f2f268e0deca10b43334d3208f7b2483a5c951865d1ed20cf8376be0d1f7e756f71f9bc59eef0bf09432f0576b1bdad1793ec3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/84b5938f23003db8927067ed2097e5076fdbfc997d4f63c705503ed7699d996e4ea6b010901e54fb61a7807b7057467b29819f72d61abb46d2759f469c2fbe7f"} 00:59:41 INFO - Running post-run listener: copy_logs_to_upload_dir 00:59:41 INFO - Copying logs to upload dir... 00:59:41 INFO - mkdir: /builds/slave/test/build/upload/logs 00:59:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.817648 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-09-27 00:59:40.692543) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 00:59:40.696100) ========= 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=652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871 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/fae33a985005ac4b194423fbccd88d393784dcf9c948eb00910f437b86a276cbdb0753f4a8a4b786236a50b3c9b5dbecb423ad3fa92bf6743cdb5d54edaac55d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50e3e248efd823d365eed9f92f2f268e0deca10b43334d3208f7b2483a5c951865d1ed20cf8376be0d1f7e756f71f9bc59eef0bf09432f0576b1bdad1793ec3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/84b5938f23003db8927067ed2097e5076fdbfc997d4f63c705503ed7699d996e4ea6b010901e54fb61a7807b7057467b29819f72d61abb46d2759f469c2fbe7f"} build_url:https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011503 build_url: 'https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/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/fae33a985005ac4b194423fbccd88d393784dcf9c948eb00910f437b86a276cbdb0753f4a8a4b786236a50b3c9b5dbecb423ad3fa92bf6743cdb5d54edaac55d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50e3e248efd823d365eed9f92f2f268e0deca10b43334d3208f7b2483a5c951865d1ed20cf8376be0d1f7e756f71f9bc59eef0bf09432f0576b1bdad1793ec3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/84b5938f23003db8927067ed2097e5076fdbfc997d4f63c705503ed7699d996e4ea6b010901e54fb61a7807b7057467b29819f72d61abb46d2759f469c2fbe7f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 00:59:40.720820) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 00:59:40.721111) ========= 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=652eb03db935cfc1c15ebda0000001ad-1474961805.103596-1509774871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 00:59:40.805310) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 00:59:40.805610) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 00:59:40.805907) ========= ========= Total master_lag: 1.35 =========