builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-068 starttime: 1472721868.03 results: success (0) buildid: 20160901013119 builduid: 847b3be37b4749a29fb0e3642b8ea0fd revision: d3bf9bbe73ba35c4257dcd10339f6ccecbb1fd5e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 02:24:28.029108) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 02:24:28.029642) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 02:24:28.029992) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 02:24:28.046707) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 02:24:28.048767) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-01 02:24:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2016-09-01 02:24:29 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093288 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 02:24:28.164546) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 02:24:28.164912) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018867 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 02:24:28.224770) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 02:24:28.225141) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d3bf9bbe73ba35c4257dcd10339f6ccecbb1fd5e --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 d3bf9bbe73ba35c4257dcd10339f6ccecbb1fd5e --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=97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-01 02:24:29,883 truncating revision to first 12 chars 2016-09-01 02:24:29,883 Setting DEBUG logging. 2016-09-01 02:24:29,883 attempt 1/10 2016-09-01 02:24:29,883 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d3bf9bbe73ba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 02:24:30,435 unpacking tar archive at: fx-team-d3bf9bbe73ba/testing/mozharness/ program finished with exit code 0 elapsedTime=0.879840 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 02:24:29.121429) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 02:24:29.122117) ========= script_repo_revision: d3bf9bbe73ba35c4257dcd10339f6ccecbb1fd5e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 02:24:29.122901) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 02:24:29.123472) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 02:24:29.135305) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-09-01 02:24:29.135606) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:24:30 INFO - MultiFileLogger online at 20160901 02:24:30 in /builds/slave/test 02:24:30 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 02:24:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:24:30 INFO - {'append_to_log': False, 02:24:30 INFO - 'base_work_dir': '/builds/slave/test', 02:24:30 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:24:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:24:30 INFO - 'branch': 'Fx-Team-Non-PGO', 02:24:30 INFO - 'buildbot_json_path': 'buildprops.json', 02:24:30 INFO - 'config_files': ('talos/linux_config.py',), 02:24:30 INFO - 'default_actions': ('clobber', 02:24:30 INFO - 'read-buildbot-config', 02:24:30 INFO - 'download-and-extract', 02:24:30 INFO - 'populate-webroot', 02:24:30 INFO - 'create-virtualenv', 02:24:30 INFO - 'install', 02:24:30 INFO - 'run-tests'), 02:24:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:24:30 INFO - 'download_minidump_stackwalk': True, 02:24:30 INFO - 'download_symbols': 'ondemand', 02:24:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:24:30 INFO - 'tooltool.py': '/tools/tooltool.py', 02:24:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:24:30 INFO - '/tools/misc-python/virtualenv.py')}, 02:24:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:24:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:24:30 INFO - 'installer_path': 'installer.exe', 02:24:30 INFO - 'log_level': 'info', 02:24:30 INFO - 'log_name': 'talos', 02:24:30 INFO - 'log_to_console': True, 02:24:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:24:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:24:30 INFO - 'opt_config_files': (), 02:24:30 INFO - 'pip_index': False, 02:24:30 INFO - 'sps_profile': False, 02:24:30 INFO - 'sps_profile_interval': 0, 02:24:30 INFO - 'suite': 'dromaeojs', 02:24:30 INFO - 'system_bits': '32', 02:24:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:24:30 INFO - 'title': 'talos-linux64-ix-068', 02:24:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:24:30 INFO - 'use_talos_json': True, 02:24:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:24:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:24:30 INFO - 'work_dir': 'build'} 02:24:30 INFO - [mozharness: 2016-09-01 09:24:30.892668Z] Running clobber step. 02:24:30 INFO - Running pre-action listener: _resource_record_pre_action 02:24:30 INFO - Running main action method: clobber 02:24:30 INFO - rmtree: /builds/slave/test/build 02:24:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:24:31 INFO - Running post-action listener: _resource_record_post_action 02:24:31 INFO - [mozharness: 2016-09-01 09:24:31.360908Z] Finished clobber step (success) 02:24:31 INFO - [mozharness: 2016-09-01 09:24:31.361012Z] Running read-buildbot-config step. 02:24:31 INFO - Running pre-action listener: _resource_record_pre_action 02:24:31 INFO - Running main action method: read_buildbot_config 02:24:31 INFO - Using buildbot properties: 02:24:31 INFO - { 02:24:31 INFO - "project": "", 02:24:31 INFO - "product": "firefox", 02:24:31 INFO - "script_repo_revision": "production", 02:24:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:24:31 INFO - "repository": "", 02:24:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:24:31 INFO - "buildid": "20160901013119", 02:24:31 INFO - "pgo_build": "False", 02:24:31 INFO - "basedir": "/builds/slave/test", 02:24:31 INFO - "buildnumber": 3263, 02:24:31 INFO - "slavename": "talos-linux64-ix-068", 02:24:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:24:31 INFO - "platform": "ubuntu64_hw", 02:24:31 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:24:31 INFO - "branch": "fx-team", 02:24:31 INFO - "repo_path": "integration/fx-team", 02:24:31 INFO - "revision": "d3bf9bbe73ba35c4257dcd10339f6ccecbb1fd5e", 02:24:31 INFO - "stage_platform": "linux64", 02:24:31 INFO - "builduid": "847b3be37b4749a29fb0e3642b8ea0fd", 02:24:31 INFO - "slavebuilddir": "test" 02:24:31 INFO - } 02:24:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/SIHnhxNbSveOtg1zpIOwGw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 02:24:31 INFO - Running post-action listener: _resource_record_post_action 02:24:31 INFO - [mozharness: 2016-09-01 09:24:31.363467Z] Finished read-buildbot-config step (success) 02:24:31 INFO - [mozharness: 2016-09-01 09:24:31.363558Z] Running download-and-extract step. 02:24:31 INFO - Running pre-action listener: _resource_record_pre_action 02:24:31 INFO - Running main action method: download_and_extract 02:24:31 INFO - mkdir: /builds/slave/test/build/tests 02:24: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')]} 02:24:31 INFO - trying https://queue.taskcluster.net/v1/task/SIHnhxNbSveOtg1zpIOwGw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:24:31 INFO - Downloading https://queue.taskcluster.net/v1/task/SIHnhxNbSveOtg1zpIOwGw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:24:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SIHnhxNbSveOtg1zpIOwGw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:24:31 INFO - Downloaded 1361 bytes. 02:24:31 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:24:31 INFO - Using the following test package requirements: 02:24:31 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:24:31 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:24:31 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:24:31 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:31 INFO - u'jsshell-linux-x86_64.zip'], 02:24:31 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:24:31 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:24:31 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:24:31 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:24:31 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:24:31 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:24:31 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:24: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')]} 02:24:31 INFO - trying https://queue.taskcluster.net/v1/task/SIHnhxNbSveOtg1zpIOwGw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:24:31 INFO - Downloading https://queue.taskcluster.net/v1/task/SIHnhxNbSveOtg1zpIOwGw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:24:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SIHnhxNbSveOtg1zpIOwGw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:24:32 INFO - Downloaded 20335243 bytes. 02:24:32 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 02:24:37 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:24:37 INFO - trying https://queue.taskcluster.net/v1/task/SIHnhxNbSveOtg1zpIOwGw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:24:37 INFO - Downloading https://queue.taskcluster.net/v1/task/SIHnhxNbSveOtg1zpIOwGw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:24:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SIHnhxNbSveOtg1zpIOwGw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:24:37 INFO - Downloaded 20335243 bytes. 02:24:37 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 02:24:42 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')]} 02:24:42 INFO - trying https://queue.taskcluster.net/v1/task/SIHnhxNbSveOtg1zpIOwGw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 02:24:42 INFO - Downloading https://queue.taskcluster.net/v1/task/SIHnhxNbSveOtg1zpIOwGw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 02:24:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SIHnhxNbSveOtg1zpIOwGw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:24:43 INFO - Downloaded 14413998 bytes. 02:24:43 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 02:24:43 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')]} 02:24:43 INFO - trying https://queue.taskcluster.net/v1/task/SIHnhxNbSveOtg1zpIOwGw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:24:43 INFO - Downloading https://queue.taskcluster.net/v1/task/SIHnhxNbSveOtg1zpIOwGw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:24:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SIHnhxNbSveOtg1zpIOwGw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:24:44 INFO - Downloaded 55870276 bytes. 02:24:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SIHnhxNbSveOtg1zpIOwGw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:24:44 INFO - mkdir: /builds/slave/test/properties 02:24:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:24:44 INFO - Writing to file /builds/slave/test/properties/build_url 02:24:44 INFO - Contents: 02:24:44 INFO - build_url:https://queue.taskcluster.net/v1/task/SIHnhxNbSveOtg1zpIOwGw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:24:45 INFO - Running post-action listener: _resource_record_post_action 02:24:45 INFO - Running post-action listener: set_extra_try_arguments 02:24:45 INFO - [mozharness: 2016-09-01 09:24:45.337591Z] Finished download-and-extract step (success) 02:24:45 INFO - [mozharness: 2016-09-01 09:24:45.337819Z] Running populate-webroot step. 02:24:45 INFO - Running pre-action listener: _resource_record_pre_action 02:24:45 INFO - Running main action method: populate_webroot 02:24:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:24:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:24:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:24:45 INFO - '--tppagecycles', 02:24:45 INFO - '7'], 02:24:45 INFO - 'tests': ['tsvgm']}}, 02:24:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:24:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:24:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:24:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:24:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:24:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:24:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:45 INFO - 'talos_options': ['--disable-e10s'], 02:24:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:24:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:24:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:45 INFO - 'talos_options': ['--disable-e10s'], 02:24:45 INFO - 'tests': ['damp', 'tps']}, 02:24:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:45 INFO - 'tests': ['damp', 'tps']}, 02:24:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:24:45 INFO - 'tests': ['dromaeo_dom']}, 02:24:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:24:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:24:45 INFO - 'tests': ['basic_compositor_video']}, 02:24:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:24:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:24:45 INFO - 'tests': ['a11yr', 02:24:45 INFO - 'ts_paint', 02:24:45 INFO - 'tpaint', 02:24:45 INFO - 'sessionrestore', 02:24:45 INFO - 'sessionrestore_no_auto_restore', 02:24:45 INFO - 'tabpaint']}, 02:24:45 INFO - 'other-e10s': {'tests': ['a11yr', 02:24:45 INFO - 'ts_paint', 02:24:45 INFO - 'tpaint', 02:24:45 INFO - 'sessionrestore', 02:24:45 INFO - 'sessionrestore_no_auto_restore', 02:24:45 INFO - 'tabpaint']}, 02:24:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:24:45 INFO - 'ts_paint', 02:24:45 INFO - 'tpaint', 02:24:45 INFO - 'sessionrestore', 02:24:45 INFO - 'sessionrestore_no_auto_restore', 02:24:45 INFO - 'tabpaint']}, 02:24:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:24:45 INFO - 'ts_paint', 02:24:45 INFO - 'tpaint', 02:24:45 INFO - 'sessionrestore', 02:24:45 INFO - 'sessionrestore_no_auto_restore', 02:24:45 INFO - 'tabpaint']}, 02:24:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:24:45 INFO - 'tests': ['a11yr', 02:24:45 INFO - 'ts_paint', 02:24:45 INFO - 'tpaint', 02:24:45 INFO - 'sessionrestore', 02:24:45 INFO - 'sessionrestore_no_auto_restore', 02:24:45 INFO - 'tabpaint']}, 02:24:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:24:45 INFO - 'tests': ['a11yr', 02:24:45 INFO - 'ts_paint', 02:24:45 INFO - 'tpaint', 02:24:45 INFO - 'sessionrestore', 02:24:45 INFO - 'sessionrestore_no_auto_restore', 02:24:45 INFO - 'tabpaint']}, 02:24:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:24:45 INFO - 'tests': ['tsvgx', 02:24:45 INFO - 'tsvgr_opacity', 02:24:45 INFO - 'tart', 02:24:45 INFO - 'tscrollx', 02:24:45 INFO - 'cart']}, 02:24:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:24:45 INFO - 'tsvgr_opacity', 02:24:45 INFO - 'tart', 02:24:45 INFO - 'tscrollx', 02:24:45 INFO - 'cart']}, 02:24:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:45 INFO - 'talos_options': ['--disable-e10s'], 02:24:45 INFO - 'tests': ['tp5o']}, 02:24:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:45 INFO - 'tests': ['tp5o']}, 02:24:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:45 INFO - 'talos_options': ['--disable-e10s', 02:24:45 INFO - '--xperf_path', 02:24:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:24:45 INFO - 'tests': ['tp5n']}, 02:24:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:45 INFO - 'talos_options': ['--xperf_path', 02:24:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:24:45 INFO - 'tests': ['tp5n']}}, 02:24:45 INFO - 'talos.zip': {'path': '', 02:24:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:24:45 INFO - Running post-action listener: _resource_record_post_action 02:24:45 INFO - [mozharness: 2016-09-01 09:24:45.360014Z] Finished populate-webroot step (success) 02:24:45 INFO - [mozharness: 2016-09-01 09:24:45.360105Z] Running create-virtualenv step. 02:24:45 INFO - Running pre-action listener: _resource_record_pre_action 02:24:45 INFO - Running main action method: create_virtualenv 02:24:45 INFO - Creating virtualenv /builds/slave/test/build/venv 02:24:45 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 02:24:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:24:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:24:45 INFO - Using real prefix '/usr' 02:24:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:24:45 INFO - Installing distribute.............................................................................................................................................................................................done. 02:24:47 INFO - Installing pip.................done. 02:24:47 INFO - Return code: 0 02:24:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:24:47 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')]} 02:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:47 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')]} 02:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:47 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 0x7f90c178cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd090>, '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 0x10d09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425', '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 02:24:47 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 02:24:47 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 02:24:47 INFO - Using env: {'DISPLAY': ':0', 02:24:47 INFO - 'HOME': '/home/cltbld', 02:24:47 INFO - 'LANG': 'en_US.UTF-8', 02:24:47 INFO - 'LANGUAGE': 'en_US:en', 02:24:47 INFO - 'LOGNAME': 'cltbld', 02:24:47 INFO - 'MAIL': '/var/mail/cltbld', 02:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:47 INFO - 'MOZ_NO_REMOTE': '1', 02:24:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:47 INFO - 'NO_EM_RESTART': '1', 02:24:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:47 INFO - 'PWD': '/builds/slave/test', 02:24:47 INFO - 'SHELL': '/bin/bash', 02:24:47 INFO - 'SHLVL': '1', 02:24:47 INFO - 'TERM': 'linux', 02:24:47 INFO - 'TMOUT': '86400', 02:24:47 INFO - 'USER': 'cltbld', 02:24:47 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425', 02:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:47 INFO - '_': '/tools/buildbot/bin/python'} 02:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:48 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 02:24:48 INFO - Cleaning up... 02:24:48 INFO - Return code: 0 02:24:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:24: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')]} 02:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24: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')]} 02:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:48 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 0x7f90c178cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd090>, '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 0x10d09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425', '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 02:24:48 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 02:24:48 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 02:24:48 INFO - Using env: {'DISPLAY': ':0', 02:24:48 INFO - 'HOME': '/home/cltbld', 02:24:48 INFO - 'LANG': 'en_US.UTF-8', 02:24:48 INFO - 'LANGUAGE': 'en_US:en', 02:24:48 INFO - 'LOGNAME': 'cltbld', 02:24:48 INFO - 'MAIL': '/var/mail/cltbld', 02:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:48 INFO - 'MOZ_NO_REMOTE': '1', 02:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:48 INFO - 'NO_EM_RESTART': '1', 02:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:48 INFO - 'PWD': '/builds/slave/test', 02:24:48 INFO - 'SHELL': '/bin/bash', 02:24:48 INFO - 'SHLVL': '1', 02:24:48 INFO - 'TERM': 'linux', 02:24:48 INFO - 'TMOUT': '86400', 02:24:48 INFO - 'USER': 'cltbld', 02:24:48 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425', 02:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:48 INFO - '_': '/tools/buildbot/bin/python'} 02:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:48 INFO - Downloading/unpacking psutil>=3.1.1 02:24:48 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 02:24:48 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 02:24:48 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 02:24:48 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 02:24:48 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 02:24:48 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 02:24:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:24:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:24:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:24:50 INFO - Installing collected packages: psutil 02:24:50 INFO - Running setup.py install for psutil 02:24:50 INFO - building 'psutil._psutil_linux' extension 02:24:50 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 02:24:50 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 02:24:50 INFO - building 'psutil._psutil_posix' extension 02:24:50 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 02:24:50 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 02:24:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:24:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:24:50 INFO - Successfully installed psutil 02:24:50 INFO - Cleaning up... 02:24:50 INFO - Return code: 0 02:24:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:24:50 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')]} 02:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:50 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')]} 02:24:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:50 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 0x7f90c178cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd090>, '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 0x10d09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425', '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 02:24:50 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 02:24:50 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 02:24:50 INFO - Using env: {'DISPLAY': ':0', 02:24:50 INFO - 'HOME': '/home/cltbld', 02:24:50 INFO - 'LANG': 'en_US.UTF-8', 02:24:50 INFO - 'LANGUAGE': 'en_US:en', 02:24:50 INFO - 'LOGNAME': 'cltbld', 02:24:50 INFO - 'MAIL': '/var/mail/cltbld', 02:24:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:50 INFO - 'MOZ_NO_REMOTE': '1', 02:24:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:50 INFO - 'NO_EM_RESTART': '1', 02:24:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:50 INFO - 'PWD': '/builds/slave/test', 02:24:50 INFO - 'SHELL': '/bin/bash', 02:24:50 INFO - 'SHLVL': '1', 02:24:50 INFO - 'TERM': 'linux', 02:24:50 INFO - 'TMOUT': '86400', 02:24:50 INFO - 'USER': 'cltbld', 02:24:50 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425', 02:24:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:50 INFO - '_': '/tools/buildbot/bin/python'} 02:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:24:51 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 02:24:51 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 02:24:51 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 02:24:51 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 02:24:51 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 02:24:51 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 02:24:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:24:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:24:53 INFO - Installing collected packages: mozsystemmonitor 02:24:53 INFO - Running setup.py install for mozsystemmonitor 02:24:53 INFO - Successfully installed mozsystemmonitor 02:24:53 INFO - Cleaning up... 02:24:53 INFO - Return code: 0 02:24:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f90c178cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd090>, '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 0x10d09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425', '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 02:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:24:53 INFO - Using env: {'DISPLAY': ':0', 02:24:53 INFO - 'HOME': '/home/cltbld', 02:24:53 INFO - 'LANG': 'en_US.UTF-8', 02:24:53 INFO - 'LANGUAGE': 'en_US:en', 02:24:53 INFO - 'LOGNAME': 'cltbld', 02:24:53 INFO - 'MAIL': '/var/mail/cltbld', 02:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:53 INFO - 'MOZ_NO_REMOTE': '1', 02:24:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:53 INFO - 'NO_EM_RESTART': '1', 02:24:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:53 INFO - 'PWD': '/builds/slave/test', 02:24:53 INFO - 'SHELL': '/bin/bash', 02:24:53 INFO - 'SHLVL': '1', 02:24:53 INFO - 'TERM': 'linux', 02:24:53 INFO - 'TMOUT': '86400', 02:24:53 INFO - 'USER': 'cltbld', 02:24:53 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425', 02:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:53 INFO - '_': '/tools/buildbot/bin/python'} 02:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:53 INFO - Downloading/unpacking jsonschema==2.5.1 02:24:53 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 02:24:53 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 02:24:53 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 02:24:53 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 02:24:53 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 02:24:53 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 02:24:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:24:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:24:55 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 02:24:55 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 02:24:55 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 02:24:55 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 02:24:55 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 02:24:55 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 02:24:55 INFO - Downloading functools32-3.2.3-2.tar.gz 02:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:24:55 INFO - warning: no files found matching '*.txt' 02:24:55 INFO - no previously-included directories found matching 'build' 02:24:55 INFO - no previously-included directories found matching 'dist' 02:24:55 INFO - no previously-included directories found matching '.git*' 02:24:55 INFO - Installing collected packages: jsonschema, functools32 02:24:55 INFO - Running setup.py install for functools32 02:24:55 INFO - warning: no files found matching '*.txt' 02:24:55 INFO - no previously-included directories found matching 'build' 02:24:55 INFO - no previously-included directories found matching 'dist' 02:24:55 INFO - no previously-included directories found matching '.git*' 02:24:55 INFO - Successfully installed jsonschema functools32 02:24:55 INFO - Cleaning up... 02:24:55 INFO - Return code: 0 02:24:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:24:55 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')]} 02:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:55 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')]} 02:24:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:55 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 0x7f90c178cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd090>, '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 0x10d09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425', '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 02:24:55 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 02:24:55 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 02:24:55 INFO - Using env: {'DISPLAY': ':0', 02:24:55 INFO - 'HOME': '/home/cltbld', 02:24:55 INFO - 'LANG': 'en_US.UTF-8', 02:24:55 INFO - 'LANGUAGE': 'en_US:en', 02:24:55 INFO - 'LOGNAME': 'cltbld', 02:24:55 INFO - 'MAIL': '/var/mail/cltbld', 02:24:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:55 INFO - 'MOZ_NO_REMOTE': '1', 02:24:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:55 INFO - 'NO_EM_RESTART': '1', 02:24:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:55 INFO - 'PWD': '/builds/slave/test', 02:24:55 INFO - 'SHELL': '/bin/bash', 02:24:55 INFO - 'SHLVL': '1', 02:24:55 INFO - 'TERM': 'linux', 02:24:55 INFO - 'TMOUT': '86400', 02:24:55 INFO - 'USER': 'cltbld', 02:24:55 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425', 02:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:55 INFO - '_': '/tools/buildbot/bin/python'} 02:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:24:56 INFO - Cleaning up... 02:24:56 INFO - Return code: 0 02:24:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f90c178cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd090>, '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 0x10d09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425', '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 02:24:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:24:56 INFO - Using env: {'DISPLAY': ':0', 02:24:56 INFO - 'HOME': '/home/cltbld', 02:24:56 INFO - 'LANG': 'en_US.UTF-8', 02:24:56 INFO - 'LANGUAGE': 'en_US:en', 02:24:56 INFO - 'LOGNAME': 'cltbld', 02:24:56 INFO - 'MAIL': '/var/mail/cltbld', 02:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:56 INFO - 'MOZ_NO_REMOTE': '1', 02:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:56 INFO - 'NO_EM_RESTART': '1', 02:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:56 INFO - 'PWD': '/builds/slave/test', 02:24:56 INFO - 'SHELL': '/bin/bash', 02:24:56 INFO - 'SHLVL': '1', 02:24:56 INFO - 'TERM': 'linux', 02:24:56 INFO - 'TMOUT': '86400', 02:24:56 INFO - 'USER': 'cltbld', 02:24:56 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425', 02:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:56 INFO - '_': '/tools/buildbot/bin/python'} 02:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:56 INFO - Downloading/unpacking blobuploader==1.2.4 02:24:56 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 02:24:56 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 02:24:56 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 02:24:56 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 02:24:56 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 02:24:56 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 02:24:58 INFO - Downloading blobuploader-1.2.4.tar.gz 02:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:24:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:24:58 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 02:24:58 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 02:24:58 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 02:24:58 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 02:24:58 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 02:24:58 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 02:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:24:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:24:58 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 02:24:58 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 02:24:58 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 02:24:58 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 02:24:58 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 02:24:58 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 02:24:58 INFO - Downloading docopt-0.6.1.tar.gz 02:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:24:58 INFO - Installing collected packages: blobuploader, requests, docopt 02:24:58 INFO - Running setup.py install for blobuploader 02:24:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:24:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:24:59 INFO - Running setup.py install for requests 02:24:59 INFO - Running setup.py install for docopt 02:24:59 INFO - Successfully installed blobuploader requests docopt 02:24:59 INFO - Cleaning up... 02:24:59 INFO - Return code: 0 02:24:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:59 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 0x7f90c178cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd090>, '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 0x10d09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425', '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 02:24:59 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 02:24:59 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 02:24:59 INFO - Using env: {'DISPLAY': ':0', 02:24:59 INFO - 'HOME': '/home/cltbld', 02:24:59 INFO - 'LANG': 'en_US.UTF-8', 02:24:59 INFO - 'LANGUAGE': 'en_US:en', 02:24:59 INFO - 'LOGNAME': 'cltbld', 02:24:59 INFO - 'MAIL': '/var/mail/cltbld', 02:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:59 INFO - 'MOZ_NO_REMOTE': '1', 02:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:59 INFO - 'NO_EM_RESTART': '1', 02:24:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:59 INFO - 'PWD': '/builds/slave/test', 02:24:59 INFO - 'SHELL': '/bin/bash', 02:24:59 INFO - 'SHLVL': '1', 02:24:59 INFO - 'TERM': 'linux', 02:24:59 INFO - 'TMOUT': '86400', 02:24:59 INFO - 'USER': 'cltbld', 02:24:59 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425', 02:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:59 INFO - '_': '/tools/buildbot/bin/python'} 02:24:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:24:59 INFO - Running setup.py (path:/tmp/pip-Juk2kZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:24:59 INFO - Running setup.py (path:/tmp/pip-_yr_7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:24:59 INFO - Running setup.py (path:/tmp/pip-whIz6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:24:59 INFO - Running setup.py (path:/tmp/pip-HKqwJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:25:00 INFO - Running setup.py (path:/tmp/pip-SC5PZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:25:00 INFO - Running setup.py (path:/tmp/pip-nS3XyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:25:00 INFO - Running setup.py (path:/tmp/pip-B0TuWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:25:00 INFO - Running setup.py (path:/tmp/pip-FRFWu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:25:00 INFO - Running setup.py (path:/tmp/pip-kOwaGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:25:00 INFO - Running setup.py (path:/tmp/pip-qxX3x9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:25:00 INFO - Running setup.py (path:/tmp/pip-xx1uYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:25:00 INFO - Running setup.py (path:/tmp/pip-rsDLAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:25:00 INFO - Running setup.py (path:/tmp/pip-wWLpPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:25:00 INFO - Running setup.py (path:/tmp/pip-5CpRry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:25:00 INFO - Running setup.py (path:/tmp/pip-FQIla6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:25:00 INFO - Running setup.py (path:/tmp/pip-bIsEG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:25:00 INFO - Running setup.py (path:/tmp/pip-wFtGTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:25:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:25:00 INFO - Running setup.py install for manifestparser 02:25:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:25:01 INFO - Running setup.py install for mozcrash 02:25:01 INFO - Running setup.py install for mozdebug 02:25:01 INFO - Running setup.py install for mozdevice 02:25:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:25:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:25:01 INFO - Running setup.py install for mozfile 02:25:01 INFO - Running setup.py install for mozhttpd 02:25:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:25:01 INFO - Running setup.py install for mozinfo 02:25:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:25:01 INFO - Running setup.py install for mozInstall 02:25:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:25:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:25:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:25:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:25:01 INFO - Running setup.py install for mozleak 02:25:01 INFO - Running setup.py install for mozlog 02:25:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:25:02 INFO - Running setup.py install for moznetwork 02:25:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:25:02 INFO - Running setup.py install for mozprocess 02:25:02 INFO - Running setup.py install for mozprofile 02:25:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:25:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:25:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:25:02 INFO - Running setup.py install for mozrunner 02:25:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:25:02 INFO - Running setup.py install for mozscreenshot 02:25:02 INFO - Running setup.py install for moztest 02:25:02 INFO - Running setup.py install for mozversion 02:25:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:25:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:25:02 INFO - Cleaning up... 02:25:02 INFO - Return code: 0 02:25:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:02 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 0x7f90c178cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd090>, '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 0x10d09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425', '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 02:25:02 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 02:25:02 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 02:25:02 INFO - Using env: {'DISPLAY': ':0', 02:25:02 INFO - 'HOME': '/home/cltbld', 02:25:02 INFO - 'LANG': 'en_US.UTF-8', 02:25:02 INFO - 'LANGUAGE': 'en_US:en', 02:25:02 INFO - 'LOGNAME': 'cltbld', 02:25:02 INFO - 'MAIL': '/var/mail/cltbld', 02:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:02 INFO - 'MOZ_NO_REMOTE': '1', 02:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:02 INFO - 'NO_EM_RESTART': '1', 02:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:02 INFO - 'PWD': '/builds/slave/test', 02:25:02 INFO - 'SHELL': '/bin/bash', 02:25:02 INFO - 'SHLVL': '1', 02:25:02 INFO - 'TERM': 'linux', 02:25:02 INFO - 'TMOUT': '86400', 02:25:02 INFO - 'USER': 'cltbld', 02:25:02 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425', 02:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:02 INFO - '_': '/tools/buildbot/bin/python'} 02:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:25:03 INFO - Running setup.py (path:/tmp/pip-hfzxu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:25:03 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)) 02:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:25:03 INFO - Running setup.py (path:/tmp/pip-FUL5Ra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:25:03 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)) 02:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:25:03 INFO - Running setup.py (path:/tmp/pip-faG53A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:25:03 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)) 02:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:25:03 INFO - Running setup.py (path:/tmp/pip-2IhZwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:25:03 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)) 02:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:25:03 INFO - Running setup.py (path:/tmp/pip-ZHlqZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:25:03 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)) 02:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:25:03 INFO - Running setup.py (path:/tmp/pip-AJqUlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:25:03 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)) 02:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:25:03 INFO - Running setup.py (path:/tmp/pip-7nVSYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:25:03 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)) 02:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:25:03 INFO - Running setup.py (path:/tmp/pip-GXq2sJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:25:03 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)) 02:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:25:03 INFO - Running setup.py (path:/tmp/pip-P6Tx31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:25:03 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)) 02:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:25:03 INFO - Running setup.py (path:/tmp/pip-NSV9UK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 02:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:25:03 INFO - Running setup.py (path:/tmp/pip-eqczPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:25:03 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)) 02:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:25:03 INFO - Running setup.py (path:/tmp/pip-l9MbBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:25:03 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)) 02:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:25:03 INFO - Running setup.py (path:/tmp/pip-rppKwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:25:03 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)) 02:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:25:03 INFO - Running setup.py (path:/tmp/pip-I3_2xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:25:04 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)) 02:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:25:04 INFO - Running setup.py (path:/tmp/pip-HYGMsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:25:04 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)) 02:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:25:04 INFO - Running setup.py (path:/tmp/pip-3AVHqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:25:04 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)) 02:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:25:04 INFO - Running setup.py (path:/tmp/pip-LwQ6DR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:25:04 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)) 02:25:04 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)) 02:25:04 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)) 02:25:04 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)) 02:25:04 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)) 02:25:04 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)) 02:25:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:06 INFO - Downloading blessings-1.6.tar.gz 02:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:25:06 INFO - Installing collected packages: blessings 02:25:06 INFO - Running setup.py install for blessings 02:25:06 INFO - Successfully installed blessings 02:25:06 INFO - Cleaning up... 02:25:06 INFO - Return code: 0 02:25:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:25:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:25:06 INFO - Reading from file tmpfile_stdout 02:25:06 INFO - Current package versions: 02:25:06 INFO - argparse == 1.2.1 02:25:06 INFO - blessings == 1.6 02:25:06 INFO - blobuploader == 1.2.4 02:25:06 INFO - docopt == 0.6.1 02:25:06 INFO - functools32 == 3.2.3-2 02:25:06 INFO - jsonschema == 2.5.1 02:25:06 INFO - manifestparser == 1.1 02:25:06 INFO - mozInstall == 1.12 02:25:06 INFO - mozcrash == 0.17 02:25:06 INFO - mozdebug == 0.1 02:25:06 INFO - mozdevice == 0.48 02:25:06 INFO - mozfile == 1.2 02:25:06 INFO - mozhttpd == 0.7 02:25:06 INFO - mozinfo == 0.9 02:25:06 INFO - mozleak == 0.1 02:25:06 INFO - mozlog == 3.3 02:25:06 INFO - moznetwork == 0.27 02:25:06 INFO - mozprocess == 0.23 02:25:06 INFO - mozprofile == 0.28 02:25:06 INFO - mozrunner == 6.12 02:25:06 INFO - mozscreenshot == 0.1 02:25:06 INFO - mozsystemmonitor == 0.3 02:25:06 INFO - moztest == 0.7 02:25:06 INFO - mozversion == 1.4 02:25:06 INFO - psutil == 3.1.1 02:25:06 INFO - requests == 1.2.3 02:25:06 INFO - wsgiref == 0.1.2 02:25:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:06 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 0x7f90c178cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd090>, '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 0x10d09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425', '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 02:25:06 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 02:25:06 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 02:25:06 INFO - Using env: {'DISPLAY': ':0', 02:25:06 INFO - 'HOME': '/home/cltbld', 02:25:06 INFO - 'LANG': 'en_US.UTF-8', 02:25:06 INFO - 'LANGUAGE': 'en_US:en', 02:25:06 INFO - 'LOGNAME': 'cltbld', 02:25:06 INFO - 'MAIL': '/var/mail/cltbld', 02:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:06 INFO - 'MOZ_NO_REMOTE': '1', 02:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:06 INFO - 'NO_EM_RESTART': '1', 02:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:06 INFO - 'PWD': '/builds/slave/test', 02:25:06 INFO - 'SHELL': '/bin/bash', 02:25:06 INFO - 'SHLVL': '1', 02:25:06 INFO - 'TERM': 'linux', 02:25:06 INFO - 'TMOUT': '86400', 02:25:06 INFO - 'USER': 'cltbld', 02:25:06 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425', 02:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:06 INFO - '_': '/tools/buildbot/bin/python'} 02:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:06 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)) 02:25:06 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)) 02:25:06 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)) 02:25:06 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)) 02:25:06 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)) 02:25:06 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)) 02:25:06 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)) 02:25:06 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)) 02:25:06 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)) 02:25:06 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)) 02:25:06 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)) 02:25:06 INFO - Cleaning up... 02:25:06 INFO - Return code: 0 02:25:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90c178cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd090>, '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 0x10d09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425', '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 02:25:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:25:06 INFO - Using env: {'DISPLAY': ':0', 02:25:06 INFO - 'HOME': '/home/cltbld', 02:25:06 INFO - 'LANG': 'en_US.UTF-8', 02:25:06 INFO - 'LANGUAGE': 'en_US:en', 02:25:06 INFO - 'LOGNAME': 'cltbld', 02:25:06 INFO - 'MAIL': '/var/mail/cltbld', 02:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:06 INFO - 'MOZ_NO_REMOTE': '1', 02:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:06 INFO - 'NO_EM_RESTART': '1', 02:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:06 INFO - 'PWD': '/builds/slave/test', 02:25:06 INFO - 'SHELL': '/bin/bash', 02:25:06 INFO - 'SHLVL': '1', 02:25:06 INFO - 'TERM': 'linux', 02:25:06 INFO - 'TMOUT': '86400', 02:25:06 INFO - 'USER': 'cltbld', 02:25:06 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425', 02:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:06 INFO - '_': '/tools/buildbot/bin/python'} 02:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:25:07 INFO - Cleaning up... 02:25:07 INFO - Return code: 0 02:25:07 INFO - Running post-action listener: _resource_record_post_action 02:25:07 INFO - Running post-action listener: _start_resource_monitoring 02:25:07 INFO - Starting resource monitoring. 02:25:07 INFO - [mozharness: 2016-09-01 09:25:07.170449Z] Finished create-virtualenv step (success) 02:25:07 INFO - [mozharness: 2016-09-01 09:25:07.170916Z] Running install step. 02:25:07 INFO - Running pre-action listener: _resource_record_pre_action 02:25:07 INFO - Running main action method: install 02:25:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:25:07 INFO - Reading from file tmpfile_stdout 02:25:07 INFO - Detecting whether we're running mozinstall >=1.0... 02:25:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:25:07 INFO - Reading from file tmpfile_stdout 02:25:07 INFO - Output received: 02:25:07 INFO - Usage: mozinstall [options] installer 02:25:07 INFO - Options: 02:25:07 INFO - -h, --help show this help message and exit 02:25:07 INFO - -d DEST, --destination=DEST 02:25:07 INFO - Directory to install application into. [default: 02:25:07 INFO - "/builds/slave/test"] 02:25:07 INFO - --app=APP Application being installed. [default: firefox] 02:25:07 INFO - mkdir: /builds/slave/test/build/application 02:25:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:25:23 INFO - Reading from file tmpfile_stdout 02:25:23 INFO - Output received: 02:25:23 INFO - /builds/slave/test/build/application/firefox/firefox 02:25:23 INFO - Running post-action listener: _resource_record_post_action 02:25:23 INFO - [mozharness: 2016-09-01 09:25:23.632154Z] Finished install step (success) 02:25:23 INFO - [mozharness: 2016-09-01 09:25:23.632433Z] Running run-tests step. 02:25:23 INFO - Running pre-action listener: _resource_record_pre_action 02:25:23 INFO - Running main action method: run_tests 02:25:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:25:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:25:23 INFO - Python 2.7.3 02:25:23 INFO - Return code: 0 02:25:23 INFO - grabbing minidump binary from tooltool 02:25:23 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')]} 02:25:23 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 0x10cd090>, '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 0x10d09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:25:23 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 02:25:23 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 02:25:23 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 02:25:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:25:23 INFO - Return code: 0 02:25:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:25:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:25:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:25:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:25:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:25:23 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/SIHnhxNbSveOtg1zpIOwGw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 02:25:23 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/SIHnhxNbSveOtg1zpIOwGw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 02:25:23 INFO - Using env: {'DISPLAY': ':0', 02:25:23 INFO - 'HOME': '/home/cltbld', 02:25:23 INFO - 'LANG': 'en_US.UTF-8', 02:25:23 INFO - 'LANGUAGE': 'en_US:en', 02:25:23 INFO - 'LOGNAME': 'cltbld', 02:25:23 INFO - 'MAIL': '/var/mail/cltbld', 02:25:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:25:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:23 INFO - 'MOZ_NO_REMOTE': '1', 02:25:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:25:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:23 INFO - 'NO_EM_RESTART': '1', 02:25:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:23 INFO - 'PWD': '/builds/slave/test', 02:25:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:25:23 INFO - 'SHELL': '/bin/bash', 02:25:23 INFO - 'SHLVL': '1', 02:25:23 INFO - 'TERM': 'linux', 02:25:23 INFO - 'TMOUT': '86400', 02:25:23 INFO - 'USER': 'cltbld', 02:25:23 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425', 02:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:23 INFO - '_': '/tools/buildbot/bin/python'} 02:25:23 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/SIHnhxNbSveOtg1zpIOwGw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 02:25:23 INFO - mozversion application_buildid: 20160901013119 02:25:23 INFO - mozversion application_changeset: d3bf9bbe73ba35c4257dcd10339f6ccecbb1fd5e 02:25:23 INFO - mozversion application_display_name: Nightly 02:25:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:25:23 INFO - mozversion application_name: Firefox 02:25:23 INFO - mozversion application_remotingname: firefox 02:25:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:25:23 INFO - mozversion application_vendor: Mozilla 02:25:23 INFO - mozversion application_version: 51.0a1 02:25:23 INFO - mozversion platform_buildid: 20160901013119 02:25:23 INFO - mozversion platform_changeset: d3bf9bbe73ba35c4257dcd10339f6ccecbb1fd5e 02:25:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:25:23 INFO - mozversion platform_version: 51.0a1 02:25:23 INFO - using testdate: 1472721923 02:25:23 INFO - actual date: 1472721923 02:25:23 INFO - starting webserver on 'localhost:45641' 02:25:23 INFO - SUITE-START | Running 2 tests 02:25:23 INFO - TEST-START | dromaeo_css 02:25:23 INFO - operating with platform_type : linux_ 02:25:23 INFO - Initialising browser for dromaeo_css test... 02:25:23 INFO - TEST-INFO | started process 22914 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4u1A8v/profile http://localhost:45641/getInfo.html) 02:25:28 INFO - PROCESS | 22914 | __metrics Screen width/height:1600/1200 02:25:28 INFO - PROCESS | 22914 | colorDepth:24 02:25:28 INFO - PROCESS | 22914 | Browser inner width/height: 1024/697 02:25:28 INFO - PROCESS | 22914 | __metrics 02:25:29 INFO - PROCESS | 22914 | 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" 02:25:29 INFO - PROCESS | 22914 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:25:29 INFO - PROCESS | 22914 | console.error: PushService: 02:25:29 INFO - PROCESS | 22914 | stateChangeProcessEnqueue: Error transitioning state 02:25:29 INFO - PROCESS | 22914 | UnknownError 02:25:30 INFO - TEST-INFO | 22914: exit 0 02:25:30 INFO - Browser initialized. 02:25:30 INFO - Running cycle 1/1 for dromaeo_css test... 02:25:30 INFO - TEST-INFO | started process 22995 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4u1A8v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:25:42 INFO - PROCESS | 22995 | RSS: Main: 182345728 02:25:42 INFO - PROCESS | 22995 | 02:26:33 INFO - PROCESS | 22995 | 1472721993825 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] 02:28:47 INFO - PROCESS | 22995 | Cycle 1(1): loaded http://localhost:45641/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45641/tests/dromaeo/cssquery-ext.html) 02:28:48 INFO - PROCESS | 22995 | RSS: Main: 302272512 02:28:48 INFO - PROCESS | 22995 | 02:31:51 INFO - PROCESS | 22995 | Cycle 1(1): loaded http://localhost:45641/tests/dromaeo/cssquery-ext.html (next: http://localhost:45641/tests/dromaeo/cssquery-jquery.html) 02:31:51 INFO - PROCESS | 22995 | RSS: Main: 275361792 02:31:51 INFO - PROCESS | 22995 | 02:34:54 INFO - PROCESS | 22995 | Cycle 1(1): loaded http://localhost:45641/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45641/tests/dromaeo/cssquery-mootools.html) 02:34:54 INFO - PROCESS | 22995 | RSS: Main: 219787264 02:34:54 INFO - PROCESS | 22995 | 02:37:57 INFO - PROCESS | 22995 | Cycle 1(1): loaded http://localhost:45641/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45641/tests/dromaeo/cssquery-prototype.html) 02:37:57 INFO - PROCESS | 22995 | RSS: Main: 229560320 02:37:57 INFO - PROCESS | 22995 | 02:41:00 INFO - PROCESS | 22995 | Cycle 1(1): loaded http://localhost:45641/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45641/tests/dromaeo/cssquery-yui.html) 02:41:01 INFO - PROCESS | 22995 | RSS: Main: 219758592 02:41:01 INFO - PROCESS | 22995 | 02:44:04 INFO - PROCESS | 22995 | Cycle 1(1): loaded http://localhost:45641/tests/dromaeo/cssquery-yui.html (next: http://localhost:45641/tests/dromaeo/cssquery-dojo.html) 02:44:04 INFO - PROCESS | 22995 | RSS: Main: 308289536 02:44:04 INFO - PROCESS | 22995 | 02:44:04 INFO - PROCESS | 22995 | __start_tp_report 02:44:04 INFO - PROCESS | 22995 | _x_x_mozilla_page_load 02:44:04 INFO - PROCESS | 22995 | _x_x_mozilla_page_load_details 02:44:04 INFO - PROCESS | 22995 | |i|pagename|runs| 02:44:04 INFO - PROCESS | 22995 | |0;dojo.html;2569.5374832530147;2584;2599.2072417912527;2608.6608740863685;2630.671166104238;4431.889202769924;4500.909981800362;4605.194091034073;4623.791929363182;4641.953580464195;4547.794834368895;4556.635469162467;4567.58891699747;4592.586667199951;4648.558386953234;4280.78596070196;4340.370646256291;4361.34579813029;4373.2565463871215;4379.781010949439;4334.523202447728;4348.195583816988;4373;4378.408914796493;4433.667474939376;4280.336547835091;4383.649308055348;4441.200583894898;4450.465944086714;4456.509783923782;4188.602082802129;4236.449261596003;4313.051128751669;4339.522652508222;4372;4175.68682348822;4210.431591735138;4227.217964676544;4250.787460626956;4269.935950960738;4585.243434833248;4639.559241872017;4654.674172807905;4655.534446555352;4656.161890859644;4762.64280178988;4936.062148191868;4947.82682606107;4958.380202474691;5015.673981191211;4974.801007959677;5022.070916880389;5024.346834911438;5032.220005899091;5042.39491261051;4685.976570117127;4704;4706.388169537972;4714.646401519831;4767.904641907143;4919.3604831371695;5056.342675452242;5138.306328645585;5148.716820574829;5149.613778966593;4860.198067318924;4897.461279259279;4904.166291730343;4959.305697202394;4961.330220420197;4965.503449655005;4971.776270067856;4975.303457515951;4981.302617633534;5035.395752509722;4740.5733483986605;4788.401449818773;4933.333999909966;4946.183879659888;5011.724355160502;4859.927101093415;4877.292792545061;4879.243717223836;4963.627727920348;4974.925376119361;4240.215560121387;4261.74429534229;4298.720583162084;4311.784410779448;4312.805923733439;3720.311742327624;3735.9066023349633;3741.5323084614424;3745.569259535134;3769.5853456119803;4137.606927341898;4183.247015537172;4254.638355739735;4258.893527661833;4290.506591741927;4896.828610998669;4906.533879281463;4907.656464047483;4966.130927087817;4980.203167493184;4197.9370309445385;4198.475190601175;4208.095259519218;4251.681123915719;4257.127288905767;4398.890027749268;4452.398926144929;4455.732656040648;4457.487388950248;4503.121891231179;4656.580907718321;4664.090502352076;4689.038747056777;4732.02993386348;4749.786259618395;4975.601951843916;5020.974895125501;5027.170516864677;5037.143685573535;5091;4511.548845115462;4654.511276315938;4697.859064228079;4705.317728929354;4758.619310455086;4914.336564563881;4945.060438516671;4965.4041515018425;5017.0216807722145;5029.773660185374;4986.12742770021;5021.899562008813;5032.874178145429;5039.26930595069;5093.7707803148205;4744.644151688706;4811.470738218723;4895.926561101515;4903.509649035068;4948.38145231846;4799.424069111729;4821.879453013703;4842.370491836039;4869.147899117711;4873.853784386474;4705.858824235278;4710.387649605529;4712.128256272601;4727.550882666142;4773.236282194832;4751.121042607128;4800.711957282574;4819.975900120477;4875.68308059975;4897.118518666674;4798.352222449925;4801.7118972861745;4810.8797280068275;4876.756162191805;4881.438634556929 02:44:04 INFO - PROCESS | 22995 | |1;ext.html;557.9107342825149;564.3763641176503;571.3714913595045;578.7077525849445;581.4737662415514;27972.580411293846;30728.53907191394;37767.24465510688;38800.417993730116;38843.80578097106;39471.802640986825;39666;39684.206315873664;39715.801420992924;39721.60278397215;7604.16354201036;7753.4960227585025;7756.34071103954;7759.224077592224;7762.728304509344;7115.146182458112;7629.6948122075055;9737.172340351079;10051.69844904654;10057.094861462467;10149.035841595074;10195.592176312939;10204.234682398812;10219.54012069455;10227.232957528178;10046.849297260547;10106.090451859294;10111.49442527878;10120.443375614339;10122.493875306205;9923.404595724207;9990.250731195189;9990.850137247948;9994.90005099947;9995.500224988722;38167.427488587695;38531;38546.61453385487;38552;38606;2586.44391455836;2778.638776959003;2794.5249307617755;2868.526693095637;3184.1243657994005;28439.857800710863;28520.71479285222;28754.568681469795;29027.12918612445;29080.418391632047;3272.9018129456153;3288.128645908836;3294.6870047345465;3299.835008249578;3365.4612075832415;262632;263206;263333;263595.6820215906;264621.24545054714;52080.47919520832;53035.46964530383;53367;53677;53715.73142134264;50531;50557.49442505528;50596.74701626542;50598.49401506012;50754.74622626863;14762.778558321634;14769.556913292618;15090.698186036218;15204.315805788767;15248.390064397521;10315.638952636622;11404.258723182966;11492.253003554742;11512.136589755803;11524.596639117759;17745;18184.272629094954;18299.614571304086;18357.265709371743;18411.72382414265;6539.47684185264;6666.600013997115;6716.194056713226;6726.461883049442;6755.256921738604;769.9461037727306;860.9354298427643;864.6541383446546;946.9715908522755;972.9837503738496;26505.734942650713;27256.31859203496;27832.304192394946;28185.295367615563;28205;916.2578311567652;923.4643906534194;953.756792018031;962.9470379129075;1006.4967516241879;13629.522966696119;14622.122672639676;14747.705045899022;14989;15000.474983375529;410927;414641;414907;415415;415459;48884.511154887994;49131.50868491341;49165.26252106221;49245.50754492481;49431.50568494341;901.8106197698556;1124.9156313276374;1171.5196769324536;1171.8359429679851;1196.3778835005921;26301.473970520867;28878.090724577294;28963.275918102216;29011;29286.56070158992;39849.40225896672;40175.19649606933;40451.59548404478;40467.190656187304;40482;287089;287521;288106;289155;291574;24556.508869822148;24828.503429930937;25228.62157067609;25271.49457010886;25284.87357563274;40712.3893141609;40751;40986;41366.1726765469;41726.79136604298;35026;35042.474362884066;35292.64707352893;35443.45565443435;35653.82173089118;34633.826830865684;35213;35439.11402214965;35551;35551.288974220886;34302.48546271858;34627.13432164216;34829.30341393209;35209.82395088008;35582.644173557936;28277.02180107045;32811.67188328086;32850.83574582112;32921.17697057497;33336.99945008268;24783;24912.750872491044;24993.375165620277;25171.370715732253;25474.490510190062 02:44:04 INFO - PROCESS | 22995 | |2;jquery.html;343.9363717712225;356.93039857227836;364.8376472469751;372.4543543708467;381.6812961177417;12259.938700306497;15585;16045.43840965565;16583.66832663346;17522.211500482477;16769.413070542534;16812.74780878288;16860.156992150372;17366.218520166592;17459.650806983853;4701.271302948048;4862.36789217403;5170.276161337397;5391.245225668409;5437.537809286196;3399.4051041067837;4997.475265097167;5426.728663566825;5462.262594549745;5462.7268636568215;5247.1866860636665;5286.762095705702;5303.496167864047;5309.761060752276;5318.388385335678;5152.484751524855;5300.655457395257;5306.761195746181;5386.057439948033;5411.702356370398;5253.553447956928;5254.474552544715;5255.527002569749;5258.290130832365;5259.789608415697;12282.570110046196;17135.314587416487;19640.410787676392;20418.387448376572;20524;1974.0919177178514;1994.2820584589535;2022.5853699991467;2086.5722526882105;2400.5918993770924;8853.557322133933;8872.911270887273;8914.108589141098;9254;9626.66306679263;1649.645326254861;1716.2791627516474;1742.8431441170228;1746.6506698660319;1747.1962897067365;66267.66866165686;70395.64802176008;70546.64726676384;71143.93284100795;71976;9740.415575065519;9879.11088002069;10032.899671003197;10096.394216347042;10122.595096196217;13870.237136957565;13901.096428732302;13950.720985580232;13993.510227142002;13996;7108.537945033556;7239.638018099074;7261.310175533422;7373.88939165913;7421.183669796318;6768.7292508299115;6798.830029249309;6949.880286512662;7019.0875186226485;7042.190148132928;4035.9394609080887;4069.206504731608;4104.138130992525;4134.834606615702;4466.508684044752;1752.4129416645312;1782.5311942958836;1804.3053424431425;1817.3820900893759;1823.954401139982;790.9881351779728;840.6763396092548;855.5251835231506;877.9868301975475;890.8708237305555;15804.446844360393;16070.11614361198;16893.91553042227;17043.318267269417;17159.742603860952;840.8654615261529;854.5086575219274;881.0792721605937;895.359817730326;917.6925729880431;8704.26013788835;8938.642454301886;9389.76525586852;9420.434773913586;9560.235181185488;271623;279071.1161104862;279765;394952;399819;47352.763236184284;48555.271670924965;73037;74853;76046.61976690081;893.0801274686953;899.9685011024714;941.077743811069;941.3410612571228;943.6885827676988;15357;15400.614984625026;15616.687666246838;16111.274992625125;16180.67638647244;36719.63280367162;37238.44142337921;38595.614043859205;38754.80622596869;39272.60727392689;52430.47569524256;53701.19448208358;54251.45748542464;54939;55533.44466555283;7122.5726456412785;7407.148177959388;7438.330550250287;7605.23947605235;7607.075746776468;9594.232461402931;11451.312921224753;11778.175527712978;12019.858113479206;12483.75032499363;10159.23805714589;10279.486025698536;10350.637727679496;10606.787864242518;10734.302270352402;9819.607215711292;10219.335743176669;10301.381917084998;10373.792524149323;10797.352158870493;5429.348478182644;10226.284160109019;10513;10544.261901667116;10903.945480272865;5712.457316554921;7002.7899163025195;7026.929730702832;7477.102747670315;7862.646180921758;9998.500074996076;10288.176945844165;10341.534630941474;10444.529996150039;10461 02:44:04 INFO - PROCESS | 22995 | |3;mootools.html;1090.9962834192543;1343.8118663387124;1349.4534713441058;1381.5026590427444;1651.2486818497578;7034.2262351141335;7323.084614423197;7387.556746595208;7521.849563008736;7533.058367704037;7359.190489046201;7450.18048014718;7452.515586486875;7466.4773465857415;7473.663685134168;1812.193573859633;2117.375374264596;2132.8187104096132;2157.094020511389;2160.2763074370105;2191.539776646906;2221.80003799658;2226.8886555672234;2227.287268074217;2228.1198926424054;2133.6372816621133;2134.253011445989;2139.1978008246906;2140.950934042316;2234.028197733983;2010.2260629657542;2093.2882819841325;2131.936041918745;2134.9146034158616;2138.764735879052;2169.945751356213;2190.2005767894602;2191.375457994464;2192.9561408771897;2195.1768086967386;7875.960620196863;7907.881381779278;7929.088154862149;7934.484258523177;7942.880856787153;4472.753998530079;4585.931211031837;4611.492735799059;4612.331211974279;4618.930716039262;2866.613007244037;2875.5830404591215;3014.8794048238046;3041.81749095055;3047.832369219692;946.1957336264189;949.8907625623003;970.9368891022132;972.8832540095163;981.3326937682373;10478.947605262001;10527.052565269163;10565.41890196039;10584.417857017861;10600.62897798581;3994.1811928555157;4163.2298024865495;4189.518205406356;4231.851885184004;4507.391502147234;7837.529748215125;7957.283844454027;7969.043714754266;7969.163237860057;7977.401694872908;4524.434445694288;4529.569690879362;4533.659975501851;4535.31970204472;4537.2059889519205;3535.840887160084;4033.6773058155277;4123.793810309473;4239.046214601752;4240.321548552217;3341.4486609709124;3346.130006198406;3471.9652803472145;3472.374972504923;3500.5974312953826;1005.7636455432968;1008.3798463944621;1019.1744686803713;1019.6889948565758;1028.8353863381824;626.1703243202775;664.6875968294894;710.5203987308546;717.526432554522;744.8659241336503;4705.95294047062;4946.727929963815;4976.62675299354;5034.773435195351;5152.201408781645;858.8668756342777;866.5580553917547;872.1409411729442;879.1647934462286;910.1762904571374;3330.6502817204328;3435.1927297085167;3504.002718450459;3519.2609551993855;3558.5373901392654;9311.813763724687;9686;9689.224862011164;9732;9770.902290977;8894.59974301158;9258;9629.807403851884;9656;9665.275104367201;7065.89401158983;7291.9270807292305;7292.854142917218;7296.963515182496;7301.050863387725;5142.717150556755;5281.683099014072;5315.867103322294;5393.514583687487;5428.430014848384;8782.648694052166;8884.24588377605;8912.73261802147;8918.73243802687;8958.10418958099;8848.91151088481;9165.129312715282;9189.586468608795;9246.722598322061;9283.210927071004;5772.509336706427;5947.791827286024;6092.0252759560035;6356.68216589178;6542.869142617026;6651.135352404156;6661.16735408074;6680.933190668031;6694.263631000488;6745.561538499982;5856.328437388566;6016.2780466342565;6029.427204415573;6066.787662431793;6077.331493535796;5954.345022047658;5986.610870293417;5998.4601385875485;6056.9091463628965;6126.050462178369;5817.854553636193;5831.446012628793;5861.736221870111;5876.647401155944;5880.794172203952;4346.413234213467;4366.454193225847;4392.692511524163;4489.9775501122285;4506.616937560344;4258.584690821653;4292.484901811803;4347.3261644445165;4374.825006999812;4584.862454126382 02:44:04 INFO - PROCESS | 22995 | |4;prototype.html;291.80594904388585;296.30664245665145;299.8365890589629;304.7912180156594;305.4898319805924;4614.400127983366;4695.084458530588;4735.50277220892;4795.544423279787;4807.182778927587;4540.341650460689;4681.4382274127065;4705.176594096037;4708.764561771906;4718.292256161569;3768.7361884668085;3769.170782427875;3770.189409277005;3771.396576547746;3778.6032466591023;3583.157957879896;3624.9275014499694;3772.905677358074;3783.186614877801;3794.260119276742;3714.6099659535766;3718.237761258949;3736.0846592584853;3738.7009039276927;3740.3267411865854;3715.6284371562897;3716.312482190803;3724.087598538362;3725.0128715890446;3725.217704282104;3307.024427793807;3314.5193946877807;3333.949990750141;3344.347852168828;3361.907380101477;4464.732116073046;4598.310253461974;4620.353150558924;4624.537546245382;4721.433427988629;4183.707140500166;4195.538490766014;4198.496180458334;4220.9025653330045;4230.21740977917;4901.338319326881;4905.460399356068;4909.165441874889;4911.238757992517;4960.454350021495;3475.113845969287;3523.735719821024;3529.1882866940746;3541.451075083366;3607.0161411223985;5044.39467263927;5055.646104772704;5128.846009647837;5139.74301284938;5141.717205553693;3625.4380571011006;3631.8547258109907;3641.8725344612812;3694.9261014779554;3704.629537046274;3746.4754934309217;3757.1734218471893;3768.246350729865;3787.3750831113107;3793.279276937373;4024.2756303865;4189.162167566499;4192.559781222928;4201.747895126302;4291.442112525414;4962.826301079445;4968.527989840959;4970.602351811846;4971.602271818246;4983.526564976394;1193.6419074277683;1227.2023184929687;1256.5413624027165;1267.2016629523341;1286.8713128687057;817.3787921179946;825.0264687668608;831.0816547714688;834.2700137379793;843.7763992541982;4382.276924307517;4382.758948257812;4389.209942210369;4390.726689260079;4423.336499525097;5077.466865979093;5081.161608334657;5085.669431486942;5092.516210960027;5097.923531147036;4361.582485692099;4371.584699453547;4379.562043795595;4384.868453946387;4394.769464549931;2319.005655136581;2347.9434254585503;2377.904883804663;2392.4616961183942;2415.6376543518263;4213.389058586549;4232.365145228179;4238.533761286318;4251.319788833834;4314.546972567898;4563.520830312836;4576.633869290516;4622.95377046232;4670.673052886265;4687.7656117194;4244.363345498138;4259.87220383389;4440;4828.903421931542;4843.975780121077;5144.30551875492;5158.6131040171385;5169.405518365436;5172.767225474788;5175.81884634036;5091.338126043591;5098;5107.8212262572115;5121.132165987059;5124.795673016913;4564.543545645542;4740.075685241345;4797.160496913096;4806.134895718665;4819.2530157825595;3630.475200415779;3642.7085833132755;3645.854165833337;3665.395209790355;3692.6122757111193;5171.92242116361;5207.947920520898;5223.45153758865;5228;5228.738563071755;4654.6741728078705;4859.125357435695;4902.975485122552;4945.950540494549;4969.130402179677;4936.815164360456;4983.526564976321;4987.251912213197;4988.72562009093;5004.3494345734825;4799.28010798383;4928.975355123202;4954.628402869727;4991.677205540462;5004.674696144739;5016.648834581544;5049.671771334852;5052.823151189691;5053.36832895888;5069.69581825077;4915.8033678652455;4917.778699958439;4924.655274130777;4945.357103576656;4948.356713627206 02:44:04 INFO - PROCESS | 22995 | |5;yui.html;584.5148526722818;587.20727018525;621.5214285000549;637.5186734015817;656.9062510919316;11594;12035.939820300908;12226.083043771709;12292.385380730972;12293.569725059624;12361.443735031922;12688.936555317234;12708.173968692028;12744.107912446132;12790.104692671517;601.377574210692;739.5377888819488;745.7501736918139;746.3432179681872;756.9848603027937;613.8526753579131;622.4864486798386;622.5735371270672;744.8659241336558;763.6907052643688;801.9037715474151;802.7832485228985;802.835418739157;803.5982008995502;804.4569915307173;798.6006996501749;798.8522123407159;800.2637573432456;800.5276886636854;801.0627565748089;468.46594881834733;559.1333433178557;572.9828105156811;580.2862479150626;584.6199970019479;11852.170348075639;11877.287362758263;11893.52425902963;11916.165868389216;11921.642350729491;12457.875421245762;12948.546800861925;13089.280089595068;13212.405441755143;13420.374369333964;11950.880491195063;12102.282649370089;12158.51365945361;12399.25604463735;12569.74860502794;3870.806459677033;3965.2862484753023;4114.382842573608;4125.030617804813;4132.752034877887;62788.68605656988;63047.36952630507;63759.36240637627;63832.68083659552;66584.3341566583;10716.142708583295;10849.837252441219;10980.121590272758;11025;11027.669169924915;17738.822611773718;17792.55518612045;17834.5541361467;17852.91073544624;17860.01769902642;6747.6626168692355;6854.931450685429;6862.176538815274;7078.327558881898;7115.430765538745;3606.2787442511603;3686.09690625793;3730.459083432887;3736.626337366242;3760.3983362661843;2689.475552267289;2796.5245908195657;2800.7199280072236;2802.5796130580575;2805.3968396794785;511.8183045019039;527.3250239693199;529.6927781886496;530.9867253318698;543.6194663735401;457.0478861535236;546.3907742866675;552.8479668091308;562.361719448429;572.2732130194629;7807.102183248886;7809.960950195213;7827.373810095179;7921.841563168704;8013.759587212393;542.2354480182923;560.2576586023536;567.4609121334748;585.3502612100565;596.5287422935919;3447.500112483676;3547.166415892263;3787.791671458041;3903.3559462688904;3963.7027222958395;61321;101082.4945875266;102859;103851;104970;51046.74476627593;77946.61026694831;89501;93016;95050.52474737582;77592;78924;79838.60080699559;79865;80327;6363.5227357947415;6374.968125159345;6598.406143447113;6650.339864054417;6695.866082678416;45713.77143114263;46445.76777116093;47959;48712.26931595958;49515.50484495109;62403.07946109503;68427;69336.65331673309;70089;70640.64679676775;8821.294296456139;8933.776655583662;9157.404768690014;9321.580528876353;9860.408375497493;9755.951220243853;10213.591456341663;10225.948870255601;10323.896761032594;10401.167906567305;10056.89943100589;10262.332948358333;10370.325928814604;12350.62948111558;13133.540326088541;11231.382273974683;11428.257163284692;11907.106966977339;12225.205361651464;12229.87770122323;10903.454827258764;11152.776944460904;11852.407379631157;11967.341796200944;12756.87243127594;9873.308868379145;10094.747631308983;10176.185905127424;10319.793604128026;10572.524236409226;9470.952645237005;10304.587816487257;10420.531076101744;10429.582816687247;10546.736331591772 02:44:04 INFO - PROCESS | 22995 | __end_tp_report 02:44:04 INFO - PROCESS | 22995 | __start_cc_report 02:44:04 INFO - PROCESS | 22995 | _x_x_mozilla_cycle_collect,1091 02:44:04 INFO - PROCESS | 22995 | __end_cc_report 02:44:04 INFO - PROCESS | 22995 | __startTimestamp1472723044836__endTimestamp 02:44:04 INFO - PROCESS | 22995 | 02:44:04 INFO - PROCESS | 22995 | ------- Summary: start ------- 02:44:04 INFO - PROCESS | 22995 | Number of tests: 6 02:44:04 INFO - PROCESS | 22995 | 02:44:04 INFO - PROCESS | 22995 | [#0] dojo.html Cycles:165 Average:4600.40 Median:4712.13 stddev:476.99 (10.1%) stddev-sans-first:451.07 02:44:04 INFO - PROCESS | 22995 | Values: 2569.5 2584.0 2599.2 2608.7 2630.7 4431.9 4500.9 4605.2 4623.8 4642.0 4547.8 4556.6 4567.6 4592.6 4648.6 4280.8 4340.4 4361.3 4373.3 4379.8 4334.5 4348.2 4373.0 4378.4 4433.7 4280.3 4383.6 4441.2 4450.5 4456.5 4188.6 4236.4 4313.1 4339.5 4372.0 4175.7 4210.4 4227.2 4250.8 4269.9 4585.2 4639.6 4654.7 4655.5 4656.2 4762.6 4936.1 4947.8 4958.4 5015.7 4974.8 5022.1 5024.3 5032.2 5042.4 4686.0 4704.0 4706.4 4714.6 4767.9 4919.4 5056.3 5138.3 5148.7 5149.6 4860.2 4897.5 4904.2 4959.3 4961.3 4965.5 4971.8 4975.3 4981.3 5035.4 4740.6 4788.4 4933.3 4946.2 5011.7 4859.9 4877.3 4879.2 4963.6 4974.9 4240.2 4261.7 4298.7 4311.8 4312.8 3720.3 3735.9 3741.5 3745.6 3769.6 4137.6 4183.2 4254.6 4258.9 4290.5 4896.8 4906.5 4907.7 4966.1 4980.2 4197.9 4198.5 4208.1 4251.7 4257.1 4398.9 4452.4 4455.7 4457.5 4503.1 4656.6 4664.1 4689.0 4732.0 4749.8 4975.6 5021.0 5027.2 5037.1 5091.0 4511.5 4654.5 4697.9 4705.3 4758.6 4914.3 4945.1 4965.4 5017.0 5029.8 4986.1 5021.9 5032.9 5039.3 5093.8 4744.6 4811.5 4895.9 4903.5 4948.4 4799.4 4821.9 4842.4 4869.1 4873.9 4705.9 4710.4 4712.1 4727.6 4773.2 4751.1 4800.7 4820.0 4875.7 4897.1 4798.4 4801.7 4810.9 4876.8 4881.4 02:44:04 INFO - PROCESS | 22995 | 02:44:04 INFO - PROCESS | 22995 | [#1] ext.html Cycles:180 Average:47459.54 Median:34630.48 stddev:86604.80 (250.1%) stddev-sans-first:86776.16 02:44:04 INFO - PROCESS | 22995 | Values: 557.9 564.4 571.4 578.7 581.5 27972.6 30728.5 37767.2 38800.4 38843.8 39471.8 39666.0 39684.2 39715.8 39721.6 7604.2 7753.5 7756.3 7759.2 7762.7 7115.1 7629.7 9737.2 10051.7 10057.1 10149.0 10195.6 10204.2 10219.5 10227.2 10046.8 10106.1 10111.5 10120.4 10122.5 9923.4 9990.3 9990.9 9994.9 9995.5 38167.4 38531.0 38546.6 38552.0 38606.0 2586.4 2778.6 2794.5 2868.5 3184.1 28439.9 28520.7 28754.6 29027.1 29080.4 3272.9 3288.1 3294.7 3299.8 3365.5 262632.0 263206.0 263333.0 263595.7 264621.2 52080.5 53035.5 53367.0 53677.0 53715.7 50531.0 50557.5 50596.7 50598.5 50754.7 14762.8 14769.6 15090.7 15204.3 15248.4 10315.6 11404.3 11492.3 11512.1 11524.6 17745.0 18184.3 18299.6 18357.3 18411.7 6539.5 6666.6 6716.2 6726.5 6755.3 769.9 860.9 864.7 947.0 973.0 26505.7 27256.3 27832.3 28185.3 28205.0 916.3 923.5 953.8 962.9 1006.5 13629.5 14622.1 14747.7 14989.0 15000.5 410927.0 414641.0 414907.0 415415.0 415459.0 48884.5 49131.5 49165.3 49245.5 49431.5 901.8 1124.9 1171.5 1171.8 1196.4 26301.5 28878.1 28963.3 29011.0 29286.6 39849.4 40175.2 40451.6 40467.2 40482.0 287089.0 287521.0 288106.0 289155.0 291574.0 24556.5 24828.5 25228.6 25271.5 25284.9 40712.4 40751.0 40986.0 41366.2 41726.8 35026.0 35042.5 35292.6 35443.5 35653.8 34633.8 35213.0 35439.1 35551.0 35551.3 34302.5 34627.1 34829.3 35209.8 35582.6 28277.0 32811.7 32850.8 32921.2 33337.0 24783.0 24912.8 24993.4 25171.4 25474.5 02:44:04 INFO - PROCESS | 22995 | 02:44:04 INFO - PROCESS | 22995 | [#2] jquery.html Cycles:180 Average:22110.00 Median:26027.02 stddev:54899.21 (210.9%) stddev-sans-first:55028.89 02:44:04 INFO - PROCESS | 22995 | Values: 343.9 356.9 364.8 372.5 381.7 12259.9 15585.0 16045.4 16583.7 17522.2 16769.4 16812.7 16860.2 17366.2 17459.7 4701.3 4862.4 5170.3 5391.2 5437.5 3399.4 4997.5 5426.7 5462.3 5462.7 5247.2 5286.8 5303.5 5309.8 5318.4 5152.5 5300.7 5306.8 5386.1 5411.7 5253.6 5254.5 5255.5 5258.3 5259.8 12282.6 17135.3 19640.4 20418.4 20524.0 1974.1 1994.3 2022.6 2086.6 2400.6 8853.6 8872.9 8914.1 9254.0 9626.7 1649.6 1716.3 1742.8 1746.7 1747.2 66267.7 70395.6 70546.6 71143.9 71976.0 9740.4 9879.1 10032.9 10096.4 10122.6 13870.2 13901.1 13950.7 13993.5 13996.0 7108.5 7239.6 7261.3 7373.9 7421.2 6768.7 6798.8 6949.9 7019.1 7042.2 4035.9 4069.2 4104.1 4134.8 4466.5 1752.4 1782.5 1804.3 1817.4 1824.0 791.0 840.7 855.5 878.0 890.9 15804.4 16070.1 16893.9 17043.3 17159.7 840.9 854.5 881.1 895.4 917.7 8704.3 8938.6 9389.8 9420.4 9560.2 271623.0 279071.1 279765.0 394952.0 399819.0 47352.8 48555.3 73037.0 74853.0 76046.6 893.1 900.0 941.1 941.3 943.7 15357.0 15400.6 15616.7 16111.3 16180.7 36719.6 37238.4 38595.6 38754.8 39272.6 52430.5 53701.2 54251.5 54939.0 55533.4 7122.6 7407.1 7438.3 7605.2 7607.1 9594.2 11451.3 11778.2 12019.9 12483.8 10159.2 10279.5 10350.6 10606.8 10734.3 9819.6 10219.3 10301.4 10373.8 10797.4 5429.3 10226.3 10513.0 10544.3 10903.9 5712.5 7002.8 7026.9 7477.1 7862.6 9998.5 10288.2 10341.5 10444.5 10461.0 02:44:04 INFO - PROCESS | 22995 | 02:44:04 INFO - PROCESS | 22995 | [#3] mootools.html Cycles:180 Average:4950.76 Median:5216.94 stddev:2789.88 (53.5%) stddev-sans-first:2782.63 02:44:04 INFO - PROCESS | 22995 | Values: 1091.0 1343.8 1349.5 1381.5 1651.2 7034.2 7323.1 7387.6 7521.8 7533.1 7359.2 7450.2 7452.5 7466.5 7473.7 1812.2 2117.4 2132.8 2157.1 2160.3 2191.5 2221.8 2226.9 2227.3 2228.1 2133.6 2134.3 2139.2 2141.0 2234.0 2010.2 2093.3 2131.9 2134.9 2138.8 2169.9 2190.2 2191.4 2193.0 2195.2 7876.0 7907.9 7929.1 7934.5 7942.9 4472.8 4585.9 4611.5 4612.3 4618.9 2866.6 2875.6 3014.9 3041.8 3047.8 946.2 949.9 970.9 972.9 981.3 10478.9 10527.1 10565.4 10584.4 10600.6 3994.2 4163.2 4189.5 4231.9 4507.4 7837.5 7957.3 7969.0 7969.2 7977.4 4524.4 4529.6 4533.7 4535.3 4537.2 3535.8 4033.7 4123.8 4239.0 4240.3 3341.4 3346.1 3472.0 3472.4 3500.6 1005.8 1008.4 1019.2 1019.7 1028.8 626.2 664.7 710.5 717.5 744.9 4706.0 4946.7 4976.6 5034.8 5152.2 858.9 866.6 872.1 879.2 910.2 3330.7 3435.2 3504.0 3519.3 3558.5 9311.8 9686.0 9689.2 9732.0 9770.9 8894.6 9258.0 9629.8 9656.0 9665.3 7065.9 7291.9 7292.9 7297.0 7301.1 5142.7 5281.7 5315.9 5393.5 5428.4 8782.6 8884.2 8912.7 8918.7 8958.1 8848.9 9165.1 9189.6 9246.7 9283.2 5772.5 5947.8 6092.0 6356.7 6542.9 6651.1 6661.2 6680.9 6694.3 6745.6 5856.3 6016.3 6029.4 6066.8 6077.3 5954.3 5986.6 5998.5 6056.9 6126.1 5817.9 5831.4 5861.7 5876.6 5880.8 4346.4 4366.5 4392.7 4490.0 4506.6 4258.6 4292.5 4347.3 4374.8 4584.9 02:44:04 INFO - PROCESS | 22995 | 02:44:04 INFO - PROCESS | 22995 | [#4] prototype.html Cycles:180 Average:4090.71 Median:4564.03 stddev:1191.81 (26.1%) stddev-sans-first:1160.54 02:44:04 INFO - PROCESS | 22995 | Values: 291.8 296.3 299.8 304.8 305.5 4614.4 4695.1 4735.5 4795.5 4807.2 4540.3 4681.4 4705.2 4708.8 4718.3 3768.7 3769.2 3770.2 3771.4 3778.6 3583.2 3624.9 3772.9 3783.2 3794.3 3714.6 3718.2 3736.1 3738.7 3740.3 3715.6 3716.3 3724.1 3725.0 3725.2 3307.0 3314.5 3333.9 3344.3 3361.9 4464.7 4598.3 4620.4 4624.5 4721.4 4183.7 4195.5 4198.5 4220.9 4230.2 4901.3 4905.5 4909.2 4911.2 4960.5 3475.1 3523.7 3529.2 3541.5 3607.0 5044.4 5055.6 5128.8 5139.7 5141.7 3625.4 3631.9 3641.9 3694.9 3704.6 3746.5 3757.2 3768.2 3787.4 3793.3 4024.3 4189.2 4192.6 4201.7 4291.4 4962.8 4968.5 4970.6 4971.6 4983.5 1193.6 1227.2 1256.5 1267.2 1286.9 817.4 825.0 831.1 834.3 843.8 4382.3 4382.8 4389.2 4390.7 4423.3 5077.5 5081.2 5085.7 5092.5 5097.9 4361.6 4371.6 4379.6 4384.9 4394.8 2319.0 2347.9 2377.9 2392.5 2415.6 4213.4 4232.4 4238.5 4251.3 4314.5 4563.5 4576.6 4623.0 4670.7 4687.8 4244.4 4259.9 4440.0 4828.9 4844.0 5144.3 5158.6 5169.4 5172.8 5175.8 5091.3 5098.0 5107.8 5121.1 5124.8 4564.5 4740.1 4797.2 4806.1 4819.3 3630.5 3642.7 3645.9 3665.4 3692.6 5171.9 5207.9 5223.5 5228.0 5228.7 4654.7 4859.1 4903.0 4946.0 4969.1 4936.8 4983.5 4987.3 4988.7 5004.3 4799.3 4929.0 4954.6 4991.7 5004.7 5016.6 5049.7 5052.8 5053.4 5069.7 4915.8 4917.8 4924.7 4945.4 4948.4 02:44:04 INFO - PROCESS | 22995 | 02:44:04 INFO - PROCESS | 22995 | [#5] yui.html Cycles:180 Average:17831.59 Median:48335.63 stddev:26019.86 (53.8%) stddev-sans-first:26060.62 02:44:04 INFO - PROCESS | 22995 | Values: 584.5 587.2 621.5 637.5 656.9 11594.0 12035.9 12226.1 12292.4 12293.6 12361.4 12688.9 12708.2 12744.1 12790.1 601.4 739.5 745.8 746.3 757.0 613.9 622.5 622.6 744.9 763.7 801.9 802.8 802.8 803.6 804.5 798.6 798.9 800.3 800.5 801.1 468.5 559.1 573.0 580.3 584.6 11852.2 11877.3 11893.5 11916.2 11921.6 12457.9 12948.5 13089.3 13212.4 13420.4 11950.9 12102.3 12158.5 12399.3 12569.7 3870.8 3965.3 4114.4 4125.0 4132.8 62788.7 63047.4 63759.4 63832.7 66584.3 10716.1 10849.8 10980.1 11025.0 11027.7 17738.8 17792.6 17834.6 17852.9 17860.0 6747.7 6854.9 6862.2 7078.3 7115.4 3606.3 3686.1 3730.5 3736.6 3760.4 2689.5 2796.5 2800.7 2802.6 2805.4 511.8 527.3 529.7 531.0 543.6 457.0 546.4 552.8 562.4 572.3 7807.1 7810.0 7827.4 7921.8 8013.8 542.2 560.3 567.5 585.4 596.5 3447.5 3547.2 3787.8 3903.4 3963.7 61321.0 101082.5 102859.0 103851.0 104970.0 51046.7 77946.6 89501.0 93016.0 95050.5 77592.0 78924.0 79838.6 79865.0 80327.0 6363.5 6375.0 6598.4 6650.3 6695.9 45713.8 46445.8 47959.0 48712.3 49515.5 62403.1 68427.0 69336.7 70089.0 70640.6 8821.3 8933.8 9157.4 9321.6 9860.4 9756.0 10213.6 10225.9 10323.9 10401.2 10056.9 10262.3 10370.3 12350.6 13133.5 11231.4 11428.3 11907.1 12225.2 12229.9 10903.5 11152.8 11852.4 11967.3 12756.9 9873.3 10094.7 10176.2 10319.8 10572.5 9471.0 10304.6 10420.5 10429.6 10546.7 02:44:04 INFO - PROCESS | 22995 | -------- Summary: end -------- 02:44:04 INFO - PROCESS | 22995 | 02:44:05 INFO - TEST-INFO | 22995: exit 0 02:44:05 INFO - TEST-OK | dromaeo_css | took 1121870ms 02:44:05 INFO - TEST-START | kraken 02:44:05 INFO - operating with platform_type : linux_ 02:44:05 INFO - Initialising browser for kraken test... 02:44:05 INFO - TEST-INFO | started process 23296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk3Arei/profile http://localhost:45641/getInfo.html) 02:44:10 INFO - PROCESS | 23296 | __metrics Screen width/height:1600/1200 02:44:10 INFO - PROCESS | 23296 | colorDepth:24 02:44:10 INFO - PROCESS | 23296 | Browser inner width/height: 1024/697 02:44:10 INFO - PROCESS | 23296 | __metrics 02:44:11 INFO - PROCESS | 23296 | 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" 02:44:11 INFO - PROCESS | 23296 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:44:11 INFO - PROCESS | 23296 | console.error: PushService: 02:44:11 INFO - PROCESS | 23296 | stateChangeProcessEnqueue: Error transitioning state 02:44:11 INFO - PROCESS | 23296 | UnknownError 02:44:12 INFO - TEST-INFO | 23296: exit 0 02:44:12 INFO - Browser initialized. 02:44:12 INFO - Running cycle 1/1 for kraken test... 02:44:12 INFO - TEST-INFO | started process 23377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk3Arei/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:44:24 INFO - PROCESS | 23377 | RSS: Main: 182296576 02:44:24 INFO - PROCESS | 23377 | 02:44:27 INFO - PROCESS | 23377 | Cycle 1(1): loaded http://localhost:45641/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45641/tests/kraken/driver.html?testName=audio-beat-detection) 02:44:28 INFO - PROCESS | 23377 | RSS: Main: 235298816 02:44:28 INFO - PROCESS | 23377 | 02:44:31 INFO - PROCESS | 23377 | Cycle 1(1): loaded http://localhost:45641/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45641/tests/kraken/driver.html?testName=audio-dft) 02:44:31 INFO - PROCESS | 23377 | RSS: Main: 226070528 02:44:31 INFO - PROCESS | 23377 | 02:44:35 INFO - PROCESS | 23377 | Cycle 1(1): loaded http://localhost:45641/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45641/tests/kraken/driver.html?testName=audio-fft) 02:44:35 INFO - PROCESS | 23377 | RSS: Main: 303177728 02:44:35 INFO - PROCESS | 23377 | 02:44:37 INFO - PROCESS | 23377 | Cycle 1(1): loaded http://localhost:45641/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45641/tests/kraken/driver.html?testName=audio-oscillator) 02:44:38 INFO - PROCESS | 23377 | RSS: Main: 213585920 02:44:38 INFO - PROCESS | 23377 | 02:44:40 INFO - PROCESS | 23377 | Cycle 1(1): loaded http://localhost:45641/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45641/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:44:41 INFO - PROCESS | 23377 | RSS: Main: 215277568 02:44:41 INFO - PROCESS | 23377 | 02:44:44 INFO - PROCESS | 23377 | Cycle 1(1): loaded http://localhost:45641/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45641/tests/kraken/driver.html?testName=imaging-darkroom) 02:44:45 INFO - PROCESS | 23377 | RSS: Main: 254136320 02:44:45 INFO - PROCESS | 23377 | 02:44:48 INFO - PROCESS | 23377 | Cycle 1(1): loaded http://localhost:45641/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45641/tests/kraken/driver.html?testName=imaging-desaturate) 02:44:49 INFO - PROCESS | 23377 | RSS: Main: 247005184 02:44:49 INFO - PROCESS | 23377 | 02:44:52 INFO - PROCESS | 23377 | Cycle 1(1): loaded http://localhost:45641/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45641/tests/kraken/driver.html?testName=json-parse-financial) 02:44:52 INFO - PROCESS | 23377 | RSS: Main: 250015744 02:44:52 INFO - PROCESS | 23377 | 02:44:54 INFO - PROCESS | 23377 | Cycle 1(1): loaded http://localhost:45641/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45641/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:44:55 INFO - PROCESS | 23377 | RSS: Main: 214339584 02:44:55 INFO - PROCESS | 23377 | 02:44:56 INFO - PROCESS | 23377 | Cycle 1(1): loaded http://localhost:45641/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45641/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:44:57 INFO - PROCESS | 23377 | RSS: Main: 222015488 02:44:57 INFO - PROCESS | 23377 | 02:44:59 INFO - PROCESS | 23377 | Cycle 1(1): loaded http://localhost:45641/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45641/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:45:00 INFO - PROCESS | 23377 | RSS: Main: 223297536 02:45:00 INFO - PROCESS | 23377 | 02:45:03 INFO - PROCESS | 23377 | Cycle 1(1): loaded http://localhost:45641/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45641/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:45:03 INFO - PROCESS | 23377 | RSS: Main: 223289344 02:45:03 INFO - PROCESS | 23377 | 02:45:06 INFO - PROCESS | 23377 | Cycle 1(1): loaded http://localhost:45641/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45641/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:45:07 INFO - PROCESS | 23377 | RSS: Main: 221753344 02:45:07 INFO - PROCESS | 23377 | 02:45:09 INFO - PROCESS | 23377 | Cycle 1(1): loaded http://localhost:45641/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45641/tests/kraken/driver.html?testName=ai-astar) 02:45:09 INFO - PROCESS | 23377 | RSS: Main: 273039360 02:45:09 INFO - PROCESS | 23377 | 02:45:09 INFO - PROCESS | 23377 | __start_tp_report 02:45:09 INFO - PROCESS | 23377 | _x_x_mozilla_page_load 02:45:09 INFO - PROCESS | 23377 | _x_x_mozilla_page_load_details 02:45:09 INFO - PROCESS | 23377 | |i|pagename|runs| 02:45:09 INFO - PROCESS | 23377 | |0;ai-astar;114;115;133;114;114;114;115;117;113;118 02:45:09 INFO - PROCESS | 23377 | |1;audio-beat-detection;159;125;159;198;126;150;144;124;182;123 02:45:09 INFO - PROCESS | 23377 | |2;audio-dft;161;163;164;163;160;159;162;161;160;161 02:45:09 INFO - PROCESS | 23377 | |3;audio-fft;76;76;76;166;78;78;77;76;156;77 02:45:09 INFO - PROCESS | 23377 | |4;audio-oscillator;84;85;154;84;84;84;143;84;85;137 02:45:09 INFO - PROCESS | 23377 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;117;118 02:45:09 INFO - PROCESS | 23377 | |6;imaging-darkroom;146;147;146;147;147;146;146;146;146;146 02:45:09 INFO - PROCESS | 23377 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;94;94 02:45:09 INFO - PROCESS | 23377 | |8;json-parse-financial;64;64;65;65;64;69;65;66;65;64 02:45:09 INFO - PROCESS | 23377 | |9;json-stringify-tinderbox;66;67;66;66;66;66;67;66;67;67 02:45:09 INFO - PROCESS | 23377 | |10;stanford-crypto-aes;82;85;86;93;84;83;83;88;89;88 02:45:09 INFO - PROCESS | 23377 | |11;stanford-crypto-ccm;135;133;133;136;133;132;144;133;180;142 02:45:09 INFO - PROCESS | 23377 | |12;stanford-crypto-pbkdf2;181;178;173;171;172;174;180;175;177;174 02:45:09 INFO - PROCESS | 23377 | |13;stanford-crypto-sha256-iterative;69;70;68;69;68;68;69;74;67;70 02:45:09 INFO - PROCESS | 23377 | __end_tp_report 02:45:09 INFO - PROCESS | 23377 | __start_cc_report 02:45:09 INFO - PROCESS | 23377 | _x_x_mozilla_cycle_collect,2002 02:45:09 INFO - PROCESS | 23377 | __end_cc_report 02:45:09 INFO - PROCESS | 23377 | __startTimestamp1472723109596__endTimestamp 02:45:09 INFO - PROCESS | 23377 | 02:45:09 INFO - PROCESS | 23377 | ------- Summary: start ------- 02:45:09 INFO - PROCESS | 23377 | Number of tests: 14 02:45:09 INFO - PROCESS | 23377 | 02:45:09 INFO - PROCESS | 23377 | [#0] ai-astar Cycles:10 Average:116.70 Median:115.00 stddev:5.93 (5.2%) stddev-sans-first:6.20 02:45:09 INFO - PROCESS | 23377 | Values: 114.0 115.0 133.0 114.0 114.0 114.0 115.0 117.0 113.0 118.0 02:45:09 INFO - PROCESS | 23377 | 02:45:09 INFO - PROCESS | 23377 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:154.50 stddev:26.08 (16.9%) stddev-sans-first:27.41 02:45:09 INFO - PROCESS | 23377 | Values: 159.0 125.0 159.0 198.0 126.0 150.0 144.0 124.0 182.0 123.0 02:45:09 INFO - PROCESS | 23377 | 02:45:09 INFO - PROCESS | 23377 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.58 (1.0%) stddev-sans-first:1.67 02:45:09 INFO - PROCESS | 23377 | Values: 161.0 163.0 164.0 163.0 160.0 159.0 162.0 161.0 160.0 161.0 02:45:09 INFO - PROCESS | 23377 | 02:45:09 INFO - PROCESS | 23377 | [#3] audio-fft Cycles:10 Average:93.60 Median:76.50 stddev:35.61 (46.5%) stddev-sans-first:37.20 02:45:09 INFO - PROCESS | 23377 | Values: 76.0 76.0 76.0 166.0 78.0 78.0 77.0 76.0 156.0 77.0 02:45:09 INFO - PROCESS | 23377 | 02:45:09 INFO - PROCESS | 23377 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:84.00 stddev:29.45 (35.1%) stddev-sans-first:30.48 02:45:09 INFO - PROCESS | 23377 | Values: 84.0 85.0 154.0 84.0 84.0 84.0 143.0 84.0 85.0 137.0 02:45:09 INFO - PROCESS | 23377 | 02:45:09 INFO - PROCESS | 23377 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 02:45:09 INFO - PROCESS | 23377 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 118.0 02:45:09 INFO - PROCESS | 23377 | 02:45:09 INFO - PROCESS | 23377 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 02:45:09 INFO - PROCESS | 23377 | Values: 146.0 147.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 02:45:09 INFO - PROCESS | 23377 | 02:45:09 INFO - PROCESS | 23377 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 02:45:09 INFO - PROCESS | 23377 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 02:45:09 INFO - PROCESS | 23377 | 02:45:09 INFO - PROCESS | 23377 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:65.00 stddev:1.52 (2.3%) stddev-sans-first:1.56 02:45:09 INFO - PROCESS | 23377 | Values: 64.0 64.0 65.0 65.0 64.0 69.0 65.0 66.0 65.0 64.0 02:45:09 INFO - PROCESS | 23377 | 02:45:09 INFO - PROCESS | 23377 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 02:45:09 INFO - PROCESS | 23377 | Values: 66.0 67.0 66.0 66.0 66.0 66.0 67.0 66.0 67.0 67.0 02:45:09 INFO - PROCESS | 23377 | 02:45:09 INFO - PROCESS | 23377 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:87.00 stddev:3.41 (3.9%) stddev-sans-first:3.28 02:45:09 INFO - PROCESS | 23377 | Values: 82.0 85.0 86.0 93.0 84.0 83.0 83.0 88.0 89.0 88.0 02:45:09 INFO - PROCESS | 23377 | 02:45:09 INFO - PROCESS | 23377 | [#11] stanford-crypto-ccm Cycles:10 Average:140.10 Median:135.50 stddev:14.61 (10.8%) stddev-sans-first:15.38 02:45:09 INFO - PROCESS | 23377 | Values: 135.0 133.0 133.0 136.0 133.0 132.0 144.0 133.0 180.0 142.0 02:45:09 INFO - PROCESS | 23377 | 02:45:09 INFO - PROCESS | 23377 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.50 Median:176.00 stddev:3.37 (1.9%) stddev-sans-first:2.93 02:45:09 INFO - PROCESS | 23377 | Values: 181.0 178.0 173.0 171.0 172.0 174.0 180.0 175.0 177.0 174.0 02:45:09 INFO - PROCESS | 23377 | 02:45:09 INFO - PROCESS | 23377 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:1.93 (2.8%) stddev-sans-first:2.05 02:45:09 INFO - PROCESS | 23377 | Values: 69.0 70.0 68.0 69.0 68.0 68.0 69.0 74.0 67.0 70.0 02:45:09 INFO - PROCESS | 23377 | -------- Summary: end -------- 02:45:09 INFO - PROCESS | 23377 | 02:45:10 INFO - TEST-INFO | 23377: exit 0 02:45:10 INFO - TEST-OK | kraken | took 65133ms 02:45:10 INFO - SUITE-END | took 1187s 02:45:11 INFO - Completed test suite (00:19:47) 02:45:11 INFO - javascript benchmark 02:45:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2569.5374832530147, 2584.0, 2599.2072417912527, 2608.6608740863685, 2630.671166104238, 4431.889202769924, 4500.909981800362, 4605.194091034073, 4623.791929363182, 4641.953580464195, 4547.794834368895, 4556.635469162467, 4567.58891699747, 4592.586667199951, 4648.558386953234, 4280.78596070196, 4340.370646256291, 4361.34579813029, 4373.2565463871215, 4379.781010949439, 4334.523202447728, 4348.195583816988, 4373.0, 4378.408914796493, 4433.667474939376, 4280.336547835091, 4383.649308055348, 4441.200583894898, 4450.465944086714, 4456.509783923782, 4188.602082802129, 4236.449261596003, 4313.051128751669, 4339.522652508222, 4372.0, 4175.68682348822, 4210.431591735138, 4227.217964676544, 4250.787460626956, 4269.935950960738, 4585.243434833248, 4639.559241872017, 4654.674172807905, 4655.534446555352, 4656.161890859644, 4762.64280178988, 4936.062148191868, 4947.82682606107, 4958.380202474691, 5015.673981191211, 4974.801007959677, 5022.070916880389, 5024.346834911438, 5032.220005899091, 5042.39491261051, 4685.976570117127, 4704.0, 4706.388169537972, 4714.646401519831, 4767.904641907143, 4919.3604831371695, 5056.342675452242, 5138.306328645585, 5148.716820574829, 5149.613778966593, 4860.198067318924, 4897.461279259279, 4904.166291730343, 4959.305697202394, 4961.330220420197, 4965.503449655005, 4971.776270067856, 4975.303457515951, 4981.302617633534, 5035.395752509722, 4740.5733483986605, 4788.401449818773, 4933.333999909966, 4946.183879659888, 5011.724355160502, 4859.927101093415, 4877.292792545061, 4879.243717223836, 4963.627727920348, 4974.925376119361, 4240.215560121387, 4261.74429534229, 4298.720583162084, 4311.784410779448, 4312.805923733439, 3720.311742327624, 3735.9066023349633, 3741.5323084614424, 3745.569259535134, 3769.5853456119803, 4137.606927341898, 4183.247015537172, 4254.638355739735, 4258.893527661833, 4290.506591741927, 4896.828610998669, 4906.533879281463, 4907.656464047483, 4966.130927087817, 4980.203167493184, 4197.9370309445385, 4198.475190601175, 4208.095259519218, 4251.681123915719, 4257.127288905767, 4398.890027749268, 4452.398926144929, 4455.732656040648, 4457.487388950248, 4503.121891231179, 4656.580907718321, 4664.090502352076, 4689.038747056777, 4732.02993386348, 4749.786259618395, 4975.601951843916, 5020.974895125501, 5027.170516864677, 5037.143685573535, 5091.0, 4511.548845115462, 4654.511276315938, 4697.859064228079, 4705.317728929354, 4758.619310455086, 4914.336564563881, 4945.060438516671, 4965.4041515018425, 5017.0216807722145, 5029.773660185374, 4986.12742770021, 5021.899562008813, 5032.874178145429, 5039.26930595069, 5093.7707803148205, 4744.644151688706, 4811.470738218723, 4895.926561101515, 4903.509649035068, 4948.38145231846, 4799.424069111729, 4821.879453013703, 4842.370491836039, 4869.147899117711, 4873.853784386474, 4705.858824235278, 4710.387649605529, 4712.128256272601, 4727.550882666142, 4773.236282194832, 4751.121042607128, 4800.711957282574, 4819.975900120477, 4875.68308059975, 4897.118518666674, 4798.352222449925, 4801.7118972861745, 4810.8797280068275, 4876.756162191805, 4881.438634556929], "value": 4570.255210803777, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.9107342825149, 564.3763641176503, 571.3714913595045, 578.7077525849445, 581.4737662415514, 27972.580411293846, 30728.53907191394, 37767.24465510688, 38800.417993730116, 38843.80578097106, 39471.802640986825, 39666.0, 39684.206315873664, 39715.801420992924, 39721.60278397215, 7604.16354201036, 7753.4960227585025, 7756.34071103954, 7759.224077592224, 7762.728304509344, 7115.146182458112, 7629.6948122075055, 9737.172340351079, 10051.69844904654, 10057.094861462467, 10149.035841595074, 10195.592176312939, 10204.234682398812, 10219.54012069455, 10227.232957528178, 10046.849297260547, 10106.090451859294, 10111.49442527878, 10120.443375614339, 10122.493875306205, 9923.404595724207, 9990.250731195189, 9990.850137247948, 9994.90005099947, 9995.500224988722, 38167.427488587695, 38531.0, 38546.61453385487, 38552.0, 38606.0, 2586.44391455836, 2778.638776959003, 2794.5249307617755, 2868.526693095637, 3184.1243657994005, 28439.857800710863, 28520.71479285222, 28754.568681469795, 29027.12918612445, 29080.418391632047, 3272.9018129456153, 3288.128645908836, 3294.6870047345465, 3299.835008249578, 3365.4612075832415, 262632.0, 263206.0, 263333.0, 263595.6820215906, 264621.24545054714, 52080.47919520832, 53035.46964530383, 53367.0, 53677.0, 53715.73142134264, 50531.0, 50557.49442505528, 50596.74701626542, 50598.49401506012, 50754.74622626863, 14762.778558321634, 14769.556913292618, 15090.698186036218, 15204.315805788767, 15248.390064397521, 10315.638952636622, 11404.258723182966, 11492.253003554742, 11512.136589755803, 11524.596639117759, 17745.0, 18184.272629094954, 18299.614571304086, 18357.265709371743, 18411.72382414265, 6539.47684185264, 6666.600013997115, 6716.194056713226, 6726.461883049442, 6755.256921738604, 769.9461037727306, 860.9354298427643, 864.6541383446546, 946.9715908522755, 972.9837503738496, 26505.734942650713, 27256.31859203496, 27832.304192394946, 28185.295367615563, 28205.0, 916.2578311567652, 923.4643906534194, 953.756792018031, 962.9470379129075, 1006.4967516241879, 13629.522966696119, 14622.122672639676, 14747.705045899022, 14989.0, 15000.474983375529, 410927.0, 414641.0, 414907.0, 415415.0, 415459.0, 48884.511154887994, 49131.50868491341, 49165.26252106221, 49245.50754492481, 49431.50568494341, 901.8106197698556, 1124.9156313276374, 1171.5196769324536, 1171.8359429679851, 1196.3778835005921, 26301.473970520867, 28878.090724577294, 28963.275918102216, 29011.0, 29286.56070158992, 39849.40225896672, 40175.19649606933, 40451.59548404478, 40467.190656187304, 40482.0, 287089.0, 287521.0, 288106.0, 289155.0, 291574.0, 24556.508869822148, 24828.503429930937, 25228.62157067609, 25271.49457010886, 25284.87357563274, 40712.3893141609, 40751.0, 40986.0, 41366.1726765469, 41726.79136604298, 35026.0, 35042.474362884066, 35292.64707352893, 35443.45565443435, 35653.82173089118, 34633.826830865684, 35213.0, 35439.11402214965, 35551.0, 35551.288974220886, 34302.48546271858, 34627.13432164216, 34829.30341393209, 35209.82395088008, 35582.644173557936, 28277.02180107045, 32811.67188328086, 32850.83574582112, 32921.17697057497, 33336.99945008268, 24783.0, 24912.750872491044, 24993.375165620277, 25171.370715732253, 25474.490510190062], "value": 17658.592470201027, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.9363717712225, 356.93039857227836, 364.8376472469751, 372.4543543708467, 381.6812961177417, 12259.938700306497, 15585.0, 16045.43840965565, 16583.66832663346, 17522.211500482477, 16769.413070542534, 16812.74780878288, 16860.156992150372, 17366.218520166592, 17459.650806983853, 4701.271302948048, 4862.36789217403, 5170.276161337397, 5391.245225668409, 5437.537809286196, 3399.4051041067837, 4997.475265097167, 5426.728663566825, 5462.262594549745, 5462.7268636568215, 5247.1866860636665, 5286.762095705702, 5303.496167864047, 5309.761060752276, 5318.388385335678, 5152.484751524855, 5300.655457395257, 5306.761195746181, 5386.057439948033, 5411.702356370398, 5253.553447956928, 5254.474552544715, 5255.527002569749, 5258.290130832365, 5259.789608415697, 12282.570110046196, 17135.314587416487, 19640.410787676392, 20418.387448376572, 20524.0, 1974.0919177178514, 1994.2820584589535, 2022.5853699991467, 2086.5722526882105, 2400.5918993770924, 8853.557322133933, 8872.911270887273, 8914.108589141098, 9254.0, 9626.66306679263, 1649.645326254861, 1716.2791627516474, 1742.8431441170228, 1746.6506698660319, 1747.1962897067365, 66267.66866165686, 70395.64802176008, 70546.64726676384, 71143.93284100795, 71976.0, 9740.415575065519, 9879.11088002069, 10032.899671003197, 10096.394216347042, 10122.595096196217, 13870.237136957565, 13901.096428732302, 13950.720985580232, 13993.510227142002, 13996.0, 7108.537945033556, 7239.638018099074, 7261.310175533422, 7373.88939165913, 7421.183669796318, 6768.7292508299115, 6798.830029249309, 6949.880286512662, 7019.0875186226485, 7042.190148132928, 4035.9394609080887, 4069.206504731608, 4104.138130992525, 4134.834606615702, 4466.508684044752, 1752.4129416645312, 1782.5311942958836, 1804.3053424431425, 1817.3820900893759, 1823.954401139982, 790.9881351779728, 840.6763396092548, 855.5251835231506, 877.9868301975475, 890.8708237305555, 15804.446844360393, 16070.11614361198, 16893.91553042227, 17043.318267269417, 17159.742603860952, 840.8654615261529, 854.5086575219274, 881.0792721605937, 895.359817730326, 917.6925729880431, 8704.26013788835, 8938.642454301886, 9389.76525586852, 9420.434773913586, 9560.235181185488, 271623.0, 279071.1161104862, 279765.0, 394952.0, 399819.0, 47352.763236184284, 48555.271670924965, 73037.0, 74853.0, 76046.61976690081, 893.0801274686953, 899.9685011024714, 941.077743811069, 941.3410612571228, 943.6885827676988, 15357.0, 15400.614984625026, 15616.687666246838, 16111.274992625125, 16180.67638647244, 36719.63280367162, 37238.44142337921, 38595.614043859205, 38754.80622596869, 39272.60727392689, 52430.47569524256, 53701.19448208358, 54251.45748542464, 54939.0, 55533.44466555283, 7122.5726456412785, 7407.148177959388, 7438.330550250287, 7605.23947605235, 7607.075746776468, 9594.232461402931, 11451.312921224753, 11778.175527712978, 12019.858113479206, 12483.75032499363, 10159.23805714589, 10279.486025698536, 10350.637727679496, 10606.787864242518, 10734.302270352402, 9819.607215711292, 10219.335743176669, 10301.381917084998, 10373.792524149323, 10797.352158870493, 5429.348478182644, 10226.284160109019, 10513.0, 10544.261901667116, 10903.945480272865, 5712.457316554921, 7002.7899163025195, 7026.929730702832, 7477.102747670315, 7862.646180921758, 9998.500074996076, 10288.176945844165, 10341.534630941474, 10444.529996150039, 10461.0], "value": 8019.759772794964, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1090.9962834192543, 1343.8118663387124, 1349.4534713441058, 1381.5026590427444, 1651.2486818497578, 7034.2262351141335, 7323.084614423197, 7387.556746595208, 7521.849563008736, 7533.058367704037, 7359.190489046201, 7450.18048014718, 7452.515586486875, 7466.4773465857415, 7473.663685134168, 1812.193573859633, 2117.375374264596, 2132.8187104096132, 2157.094020511389, 2160.2763074370105, 2191.539776646906, 2221.80003799658, 2226.8886555672234, 2227.287268074217, 2228.1198926424054, 2133.6372816621133, 2134.253011445989, 2139.1978008246906, 2140.950934042316, 2234.028197733983, 2010.2260629657542, 2093.2882819841325, 2131.936041918745, 2134.9146034158616, 2138.764735879052, 2169.945751356213, 2190.2005767894602, 2191.375457994464, 2192.9561408771897, 2195.1768086967386, 7875.960620196863, 7907.881381779278, 7929.088154862149, 7934.484258523177, 7942.880856787153, 4472.753998530079, 4585.931211031837, 4611.492735799059, 4612.331211974279, 4618.930716039262, 2866.613007244037, 2875.5830404591215, 3014.8794048238046, 3041.81749095055, 3047.832369219692, 946.1957336264189, 949.8907625623003, 970.9368891022132, 972.8832540095163, 981.3326937682373, 10478.947605262001, 10527.052565269163, 10565.41890196039, 10584.417857017861, 10600.62897798581, 3994.1811928555157, 4163.2298024865495, 4189.518205406356, 4231.851885184004, 4507.391502147234, 7837.529748215125, 7957.283844454027, 7969.043714754266, 7969.163237860057, 7977.401694872908, 4524.434445694288, 4529.569690879362, 4533.659975501851, 4535.31970204472, 4537.2059889519205, 3535.840887160084, 4033.6773058155277, 4123.793810309473, 4239.046214601752, 4240.321548552217, 3341.4486609709124, 3346.130006198406, 3471.9652803472145, 3472.374972504923, 3500.5974312953826, 1005.7636455432968, 1008.3798463944621, 1019.1744686803713, 1019.6889948565758, 1028.8353863381824, 626.1703243202775, 664.6875968294894, 710.5203987308546, 717.526432554522, 744.8659241336503, 4705.95294047062, 4946.727929963815, 4976.62675299354, 5034.773435195351, 5152.201408781645, 858.8668756342777, 866.5580553917547, 872.1409411729442, 879.1647934462286, 910.1762904571374, 3330.6502817204328, 3435.1927297085167, 3504.002718450459, 3519.2609551993855, 3558.5373901392654, 9311.813763724687, 9686.0, 9689.224862011164, 9732.0, 9770.902290977, 8894.59974301158, 9258.0, 9629.807403851884, 9656.0, 9665.275104367201, 7065.89401158983, 7291.9270807292305, 7292.854142917218, 7296.963515182496, 7301.050863387725, 5142.717150556755, 5281.683099014072, 5315.867103322294, 5393.514583687487, 5428.430014848384, 8782.648694052166, 8884.24588377605, 8912.73261802147, 8918.73243802687, 8958.10418958099, 8848.91151088481, 9165.129312715282, 9189.586468608795, 9246.722598322061, 9283.210927071004, 5772.509336706427, 5947.791827286024, 6092.0252759560035, 6356.68216589178, 6542.869142617026, 6651.135352404156, 6661.16735408074, 6680.933190668031, 6694.263631000488, 6745.561538499982, 5856.328437388566, 6016.2780466342565, 6029.427204415573, 6066.787662431793, 6077.331493535796, 5954.345022047658, 5986.610870293417, 5998.4601385875485, 6056.9091463628965, 6126.050462178369, 5817.854553636193, 5831.446012628793, 5861.736221870111, 5876.647401155944, 5880.794172203952, 4346.413234213467, 4366.454193225847, 4392.692511524163, 4489.9775501122285, 4506.616937560344, 4258.584690821653, 4292.484901811803, 4347.3261644445165, 4374.825006999812, 4584.862454126382], "value": 3981.696494235321, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.80594904388585, 296.30664245665145, 299.8365890589629, 304.7912180156594, 305.4898319805924, 4614.400127983366, 4695.084458530588, 4735.50277220892, 4795.544423279787, 4807.182778927587, 4540.341650460689, 4681.4382274127065, 4705.176594096037, 4708.764561771906, 4718.292256161569, 3768.7361884668085, 3769.170782427875, 3770.189409277005, 3771.396576547746, 3778.6032466591023, 3583.157957879896, 3624.9275014499694, 3772.905677358074, 3783.186614877801, 3794.260119276742, 3714.6099659535766, 3718.237761258949, 3736.0846592584853, 3738.7009039276927, 3740.3267411865854, 3715.6284371562897, 3716.312482190803, 3724.087598538362, 3725.0128715890446, 3725.217704282104, 3307.024427793807, 3314.5193946877807, 3333.949990750141, 3344.347852168828, 3361.907380101477, 4464.732116073046, 4598.310253461974, 4620.353150558924, 4624.537546245382, 4721.433427988629, 4183.707140500166, 4195.538490766014, 4198.496180458334, 4220.9025653330045, 4230.21740977917, 4901.338319326881, 4905.460399356068, 4909.165441874889, 4911.238757992517, 4960.454350021495, 3475.113845969287, 3523.735719821024, 3529.1882866940746, 3541.451075083366, 3607.0161411223985, 5044.39467263927, 5055.646104772704, 5128.846009647837, 5139.74301284938, 5141.717205553693, 3625.4380571011006, 3631.8547258109907, 3641.8725344612812, 3694.9261014779554, 3704.629537046274, 3746.4754934309217, 3757.1734218471893, 3768.246350729865, 3787.3750831113107, 3793.279276937373, 4024.2756303865, 4189.162167566499, 4192.559781222928, 4201.747895126302, 4291.442112525414, 4962.826301079445, 4968.527989840959, 4970.602351811846, 4971.602271818246, 4983.526564976394, 1193.6419074277683, 1227.2023184929687, 1256.5413624027165, 1267.2016629523341, 1286.8713128687057, 817.3787921179946, 825.0264687668608, 831.0816547714688, 834.2700137379793, 843.7763992541982, 4382.276924307517, 4382.758948257812, 4389.209942210369, 4390.726689260079, 4423.336499525097, 5077.466865979093, 5081.161608334657, 5085.669431486942, 5092.516210960027, 5097.923531147036, 4361.582485692099, 4371.584699453547, 4379.562043795595, 4384.868453946387, 4394.769464549931, 2319.005655136581, 2347.9434254585503, 2377.904883804663, 2392.4616961183942, 2415.6376543518263, 4213.389058586549, 4232.365145228179, 4238.533761286318, 4251.319788833834, 4314.546972567898, 4563.520830312836, 4576.633869290516, 4622.95377046232, 4670.673052886265, 4687.7656117194, 4244.363345498138, 4259.87220383389, 4440.0, 4828.903421931542, 4843.975780121077, 5144.30551875492, 5158.6131040171385, 5169.405518365436, 5172.767225474788, 5175.81884634036, 5091.338126043591, 5098.0, 5107.8212262572115, 5121.132165987059, 5124.795673016913, 4564.543545645542, 4740.075685241345, 4797.160496913096, 4806.134895718665, 4819.2530157825595, 3630.475200415779, 3642.7085833132755, 3645.854165833337, 3665.395209790355, 3692.6122757111193, 5171.92242116361, 5207.947920520898, 5223.45153758865, 5228.0, 5228.738563071755, 4654.6741728078705, 4859.125357435695, 4902.975485122552, 4945.950540494549, 4969.130402179677, 4936.815164360456, 4983.526564976321, 4987.251912213197, 4988.72562009093, 5004.3494345734825, 4799.28010798383, 4928.975355123202, 4954.628402869727, 4991.677205540462, 5004.674696144739, 5016.648834581544, 5049.671771334852, 5052.823151189691, 5053.36832895888, 5069.69581825077, 4915.8033678652455, 4917.778699958439, 4924.655274130777, 4945.357103576656, 4948.356713627206], "value": 3712.181149255588, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.5148526722818, 587.20727018525, 621.5214285000549, 637.5186734015817, 656.9062510919316, 11594.0, 12035.939820300908, 12226.083043771709, 12292.385380730972, 12293.569725059624, 12361.443735031922, 12688.936555317234, 12708.173968692028, 12744.107912446132, 12790.104692671517, 601.377574210692, 739.5377888819488, 745.7501736918139, 746.3432179681872, 756.9848603027937, 613.8526753579131, 622.4864486798386, 622.5735371270672, 744.8659241336558, 763.6907052643688, 801.9037715474151, 802.7832485228985, 802.835418739157, 803.5982008995502, 804.4569915307173, 798.6006996501749, 798.8522123407159, 800.2637573432456, 800.5276886636854, 801.0627565748089, 468.46594881834733, 559.1333433178557, 572.9828105156811, 580.2862479150626, 584.6199970019479, 11852.170348075639, 11877.287362758263, 11893.52425902963, 11916.165868389216, 11921.642350729491, 12457.875421245762, 12948.546800861925, 13089.280089595068, 13212.405441755143, 13420.374369333964, 11950.880491195063, 12102.282649370089, 12158.51365945361, 12399.25604463735, 12569.74860502794, 3870.806459677033, 3965.2862484753023, 4114.382842573608, 4125.030617804813, 4132.752034877887, 62788.68605656988, 63047.36952630507, 63759.36240637627, 63832.68083659552, 66584.3341566583, 10716.142708583295, 10849.837252441219, 10980.121590272758, 11025.0, 11027.669169924915, 17738.822611773718, 17792.55518612045, 17834.5541361467, 17852.91073544624, 17860.01769902642, 6747.6626168692355, 6854.931450685429, 6862.176538815274, 7078.327558881898, 7115.430765538745, 3606.2787442511603, 3686.09690625793, 3730.459083432887, 3736.626337366242, 3760.3983362661843, 2689.475552267289, 2796.5245908195657, 2800.7199280072236, 2802.5796130580575, 2805.3968396794785, 511.8183045019039, 527.3250239693199, 529.6927781886496, 530.9867253318698, 543.6194663735401, 457.0478861535236, 546.3907742866675, 552.8479668091308, 562.361719448429, 572.2732130194629, 7807.102183248886, 7809.960950195213, 7827.373810095179, 7921.841563168704, 8013.759587212393, 542.2354480182923, 560.2576586023536, 567.4609121334748, 585.3502612100565, 596.5287422935919, 3447.500112483676, 3547.166415892263, 3787.791671458041, 3903.3559462688904, 3963.7027222958395, 61321.0, 101082.4945875266, 102859.0, 103851.0, 104970.0, 51046.74476627593, 77946.61026694831, 89501.0, 93016.0, 95050.52474737582, 77592.0, 78924.0, 79838.60080699559, 79865.0, 80327.0, 6363.5227357947415, 6374.968125159345, 6598.406143447113, 6650.339864054417, 6695.866082678416, 45713.77143114263, 46445.76777116093, 47959.0, 48712.26931595958, 49515.50484495109, 62403.07946109503, 68427.0, 69336.65331673309, 70089.0, 70640.64679676775, 8821.294296456139, 8933.776655583662, 9157.404768690014, 9321.580528876353, 9860.408375497493, 9755.951220243853, 10213.591456341663, 10225.948870255601, 10323.896761032594, 10401.167906567305, 10056.89943100589, 10262.332948358333, 10370.325928814604, 12350.62948111558, 13133.540326088541, 11231.382273974683, 11428.257163284692, 11907.106966977339, 12225.205361651464, 12229.87770122323, 10903.454827258764, 11152.776944460904, 11852.407379631157, 11967.341796200944, 12756.87243127594, 9873.308868379145, 10094.747631308983, 10176.185905127424, 10319.793604128026, 10572.524236409226, 9470.952645237005, 10304.587816487257, 10420.531076101744, 10429.582816687247, 10546.736331591772], "value": 6400.456827206641, "unit": "score"}], "name": "dromaeo_css", "value": 6278.219104076262, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 133.0, 114.0, 114.0, 114.0, 115.0, 117.0, 113.0, 118.0], "value": 116.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 125.0, 159.0, 198.0, 126.0, 150.0, 144.0, 124.0, 182.0, 123.0], "value": 149.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 164.0, 163.0, 160.0, 159.0, 162.0, 161.0, 160.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 166.0, 78.0, 78.0, 77.0, 76.0, 156.0, 77.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 154.0, 84.0, 84.0, 84.0, 143.0, 84.0, 85.0, 137.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 65.0, 64.0, 69.0, 65.0, 66.0, 65.0, 64.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 67.0, 67.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 86.0, 93.0, 84.0, 83.0, 83.0, 88.0, 89.0, 88.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 133.0, 136.0, 133.0, 132.0, 144.0, 133.0, 180.0, 142.0], "value": 140.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 178.0, 173.0, 171.0, 172.0, 174.0, 180.0, 175.0, 177.0, 174.0], "value": 175.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 68.0, 69.0, 68.0, 68.0, 69.0, 74.0, 67.0, 70.0], "value": 69.2, "unit": "score"}], "name": "kraken", "value": 1583.7, "alertThreshold": 2.0}]} 02:45:11 INFO - Return code: 0 02:45:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:45:11 INFO - # TBPL SUCCESS # 02:45:11 INFO - Running post-action listener: _resource_record_post_action 02:45:11 INFO - [mozharness: 2016-09-01 09:45:11.383322Z] Finished run-tests step (success) 02:45:11 INFO - Running post-run listener: _resource_record_post_run 02:45:11 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 405295104; Read time: 16; Write time: 481784 02:45:11 INFO - TinderboxPrint: CPU usage
13.1% 02:45:11 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 02:45:11 INFO - TinderboxPrint: I/O write bytes / time
405,295,104 / 481,784 02:45:11 INFO - TinderboxPrint: CPU idle
8,351.4 (86.9%) 02:45:11 INFO - TinderboxPrint: CPU user
1,204.2 (12.5%) 02:45:11 INFO - TinderboxPrint: Swap in / out
0 / 0 02:45:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113639424; Read time: 0; Write time: 129192 02:45:11 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291655680; Read time: 0; Write time: 352592 02:45:12 INFO - Running post-run listener: _upload_blobber_files 02:45:12 INFO - Blob upload gear active. 02:45:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:45:12 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 02:45:12 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'] 02:45:12 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 02:45:12 INFO - (blobuploader) - INFO - Open directory for files ... 02:45:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:45:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:45:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:45:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:45:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:45:15 INFO - (blobuploader) - INFO - Done attempting. 02:45:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:45:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:45:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:45:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:45:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:45:16 INFO - (blobuploader) - INFO - Done attempting. 02:45:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:45:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:45:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:45:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:45:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:45:18 INFO - (blobuploader) - INFO - Done attempting. 02:45:18 INFO - (blobuploader) - INFO - Iteration through files over. 02:45:18 INFO - Return code: 0 02:45:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:45:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:45:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cdf6785a8946a5ca580fcdb5bf69b518e137e0b0bc4b86e389b86696a8dbf9bd330cf9a97cbe18cb86da6a43348f0db7cc60c9af4966ae36777b88b923472c7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/085726cdcbfbf37d59307497d59858321762328af3860366c8715ec1ada9457c356a180c25bb552a3d57dc701413208bc1eb57bc531336b49c443d7b7e2c61b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2bb839aee99ea80437b1abdda74ebe0e72e3130077a205cfba01b5126882c5e7dac1232bb5e2f304f083714292b3e5a4f6d874ed2590a2313e42513608fc3a6b"} 02:45:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:45:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:45:18 INFO - Contents: 02:45:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cdf6785a8946a5ca580fcdb5bf69b518e137e0b0bc4b86e389b86696a8dbf9bd330cf9a97cbe18cb86da6a43348f0db7cc60c9af4966ae36777b88b923472c7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/085726cdcbfbf37d59307497d59858321762328af3860366c8715ec1ada9457c356a180c25bb552a3d57dc701413208bc1eb57bc531336b49c443d7b7e2c61b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2bb839aee99ea80437b1abdda74ebe0e72e3130077a205cfba01b5126882c5e7dac1232bb5e2f304f083714292b3e5a4f6d874ed2590a2313e42513608fc3a6b"} 02:45:18 INFO - Running post-run listener: copy_logs_to_upload_dir 02:45:18 INFO - Copying logs to upload dir... 02:45:18 INFO - mkdir: /builds/slave/test/build/upload/logs 02:45:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.396840 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-09-01 02:45:16.527267) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 02:45:16.531078) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425 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/cdf6785a8946a5ca580fcdb5bf69b518e137e0b0bc4b86e389b86696a8dbf9bd330cf9a97cbe18cb86da6a43348f0db7cc60c9af4966ae36777b88b923472c7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/085726cdcbfbf37d59307497d59858321762328af3860366c8715ec1ada9457c356a180c25bb552a3d57dc701413208bc1eb57bc531336b49c443d7b7e2c61b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2bb839aee99ea80437b1abdda74ebe0e72e3130077a205cfba01b5126882c5e7dac1232bb5e2f304f083714292b3e5a4f6d874ed2590a2313e42513608fc3a6b"} build_url:https://queue.taskcluster.net/v1/task/SIHnhxNbSveOtg1zpIOwGw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010553 build_url: 'https://queue.taskcluster.net/v1/task/SIHnhxNbSveOtg1zpIOwGw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cdf6785a8946a5ca580fcdb5bf69b518e137e0b0bc4b86e389b86696a8dbf9bd330cf9a97cbe18cb86da6a43348f0db7cc60c9af4966ae36777b88b923472c7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/085726cdcbfbf37d59307497d59858321762328af3860366c8715ec1ada9457c356a180c25bb552a3d57dc701413208bc1eb57bc531336b49c443d7b7e2c61b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2bb839aee99ea80437b1abdda74ebe0e72e3130077a205cfba01b5126882c5e7dac1232bb5e2f304f083714292b3e5a4f6d874ed2590a2313e42513608fc3a6b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 02:45:16.552179) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 02:45:16.552498) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1472718889.152157-1611776425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004370 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 02:45:16.637577) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 02:45:16.638048) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 02:45:16.638515) ========= ========= Total master_lag: 0.17 =========