builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1472207739.48 results: success (0) buildid: 20160826002255 builduid: 272df3e024ae4d15a425fd8002e2f47a revision: 3cc6bb7fb81eaa8e47183a04f5662114a3113242 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 03:35:39.481952) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 03:35:39.482497) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 03:35:39.482836) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 03:35:39.497716) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 03:35:39.498049) ========= 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=6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-26 03:35:39-- 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% 46.6M=0s 2016-08-26 03:35:40 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120213 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 03:35:39.632687) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 03:35:39.633036) ========= 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=6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019468 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 03:35:39.682893) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 03:35:39.683305) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3cc6bb7fb81eaa8e47183a04f5662114a3113242 --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 3cc6bb7fb81eaa8e47183a04f5662114a3113242 --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=6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-26 03:35:40,219 truncating revision to first 12 chars 2016-08-26 03:35:40,219 Setting DEBUG logging. 2016-08-26 03:35:40,219 attempt 1/10 2016-08-26 03:35:40,219 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3cc6bb7fb81e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-26 03:35:40,852 unpacking tar archive at: fx-team-3cc6bb7fb81e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.972597 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 03:35:40.669819) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 03:35:40.670163) ========= script_repo_revision: 3cc6bb7fb81eaa8e47183a04f5662114a3113242 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 03:35:40.670591) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 03:35:40.670906) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 03:35:40.681756) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-26 03:35:40.682059) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:35:41 INFO - MultiFileLogger online at 20160826 03:35:41 in /builds/slave/test 03:35:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 03:35:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:35:41 INFO - {'append_to_log': False, 03:35:41 INFO - 'base_work_dir': '/builds/slave/test', 03:35:41 INFO - 'blob_upload_branch': 'Fx-Team', 03:35:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:35:41 INFO - 'branch': 'Fx-Team', 03:35:41 INFO - 'buildbot_json_path': 'buildprops.json', 03:35:41 INFO - 'config_files': ('talos/linux_config.py',), 03:35:41 INFO - 'default_actions': ('clobber', 03:35:41 INFO - 'read-buildbot-config', 03:35:41 INFO - 'download-and-extract', 03:35:41 INFO - 'populate-webroot', 03:35:41 INFO - 'create-virtualenv', 03:35:41 INFO - 'install', 03:35:41 INFO - 'run-tests'), 03:35:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:35:41 INFO - 'download_minidump_stackwalk': True, 03:35:41 INFO - 'download_symbols': 'ondemand', 03:35:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:35:41 INFO - 'tooltool.py': '/tools/tooltool.py', 03:35:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:35:41 INFO - '/tools/misc-python/virtualenv.py')}, 03:35:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:35:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:35:41 INFO - 'installer_path': 'installer.exe', 03:35:41 INFO - 'log_level': 'info', 03:35:41 INFO - 'log_name': 'talos', 03:35:41 INFO - 'log_to_console': True, 03:35:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:35:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:35:41 INFO - 'opt_config_files': (), 03:35:41 INFO - 'pip_index': False, 03:35:41 INFO - 'sps_profile': False, 03:35:41 INFO - 'sps_profile_interval': 0, 03:35:41 INFO - 'suite': 'dromaeojs', 03:35:41 INFO - 'system_bits': '32', 03:35:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:35:41 INFO - 'title': 'talos-linux64-ix-050', 03:35:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:35:41 INFO - 'use_talos_json': True, 03:35:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:35:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:35:41 INFO - 'work_dir': 'build'} 03:35:41 INFO - [mozharness: 2016-08-26 10:35:41.308685Z] Running clobber step. 03:35:41 INFO - Running pre-action listener: _resource_record_pre_action 03:35:41 INFO - Running main action method: clobber 03:35:41 INFO - rmtree: /builds/slave/test/build 03:35:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:35:41 INFO - Running post-action listener: _resource_record_post_action 03:35:41 INFO - [mozharness: 2016-08-26 10:35:41.770519Z] Finished clobber step (success) 03:35:41 INFO - [mozharness: 2016-08-26 10:35:41.770620Z] Running read-buildbot-config step. 03:35:41 INFO - Running pre-action listener: _resource_record_pre_action 03:35:41 INFO - Running main action method: read_buildbot_config 03:35:41 INFO - Using buildbot properties: 03:35:41 INFO - { 03:35:41 INFO - "project": "", 03:35:41 INFO - "product": "firefox", 03:35:41 INFO - "script_repo_revision": "production", 03:35:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:35:41 INFO - "repository": "", 03:35:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 03:35:41 INFO - "buildid": "20160826002255", 03:35:41 INFO - "pgo_build": "True", 03:35:41 INFO - "basedir": "/builds/slave/test", 03:35:41 INFO - "buildnumber": 1496, 03:35:41 INFO - "slavename": "talos-linux64-ix-050", 03:35:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:35:41 INFO - "platform": "ubuntu64_hw", 03:35:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 03:35:41 INFO - "branch": "fx-team", 03:35:41 INFO - "repo_path": "integration/fx-team", 03:35:41 INFO - "revision": "3cc6bb7fb81eaa8e47183a04f5662114a3113242", 03:35:41 INFO - "stage_platform": "linux64-pgo", 03:35:41 INFO - "builduid": "272df3e024ae4d15a425fd8002e2f47a", 03:35:41 INFO - "slavebuilddir": "test" 03:35:41 INFO - } 03:35:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/O44f-lOSQ2KnBFVTrdFA_g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 03:35:41 INFO - Running post-action listener: _resource_record_post_action 03:35:41 INFO - [mozharness: 2016-08-26 10:35:41.773116Z] Finished read-buildbot-config step (success) 03:35:41 INFO - [mozharness: 2016-08-26 10:35:41.773205Z] Running download-and-extract step. 03:35:41 INFO - Running pre-action listener: _resource_record_pre_action 03:35:41 INFO - Running main action method: download_and_extract 03:35:41 INFO - mkdir: /builds/slave/test/build/tests 03:35:41 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')]} 03:35:41 INFO - trying https://queue.taskcluster.net/v1/task/O44f-lOSQ2KnBFVTrdFA_g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:35:41 INFO - Downloading https://queue.taskcluster.net/v1/task/O44f-lOSQ2KnBFVTrdFA_g/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 03:35:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O44f-lOSQ2KnBFVTrdFA_g/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 03:35:42 INFO - Downloaded 1361 bytes. 03:35:42 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:35:42 INFO - Using the following test package requirements: 03:35:42 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 03:35:42 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:35:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:35:42 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:35:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:35:42 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:35:42 INFO - u'jsshell-linux-x86_64.zip'], 03:35:42 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:35:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:35:42 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 03:35:42 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:35:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:35:42 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:35:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:35:42 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:35:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:35:42 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:35:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:35:42 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:35: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')]} 03:35:42 INFO - trying https://queue.taskcluster.net/v1/task/O44f-lOSQ2KnBFVTrdFA_g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:35:42 INFO - Downloading https://queue.taskcluster.net/v1/task/O44f-lOSQ2KnBFVTrdFA_g/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 03:35:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O44f-lOSQ2KnBFVTrdFA_g/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 03:35:43 INFO - Downloaded 21913140 bytes. 03:35:43 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 03:35:47 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 03:35: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')]} 03:35:47 INFO - trying https://queue.taskcluster.net/v1/task/O44f-lOSQ2KnBFVTrdFA_g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:35:47 INFO - Downloading https://queue.taskcluster.net/v1/task/O44f-lOSQ2KnBFVTrdFA_g/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 03:35:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O44f-lOSQ2KnBFVTrdFA_g/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 03:35:48 INFO - Downloaded 21913140 bytes. 03:35:48 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 03:35: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')]} 03:35:53 INFO - trying https://queue.taskcluster.net/v1/task/O44f-lOSQ2KnBFVTrdFA_g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 03:35:53 INFO - Downloading https://queue.taskcluster.net/v1/task/O44f-lOSQ2KnBFVTrdFA_g/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 03:35:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O44f-lOSQ2KnBFVTrdFA_g/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 03:35:53 INFO - Downloaded 14413981 bytes. 03:35:53 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 03:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:54 INFO - trying https://queue.taskcluster.net/v1/task/O44f-lOSQ2KnBFVTrdFA_g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:35:54 INFO - Downloading https://queue.taskcluster.net/v1/task/O44f-lOSQ2KnBFVTrdFA_g/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 03:35:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O44f-lOSQ2KnBFVTrdFA_g/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 03:35:55 INFO - Downloaded 59627951 bytes. 03:35:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O44f-lOSQ2KnBFVTrdFA_g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:35:55 INFO - mkdir: /builds/slave/test/properties 03:35:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:35:55 INFO - Writing to file /builds/slave/test/properties/build_url 03:35:55 INFO - Contents: 03:35:55 INFO - build_url:https://queue.taskcluster.net/v1/task/O44f-lOSQ2KnBFVTrdFA_g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:35:55 INFO - Running post-action listener: _resource_record_post_action 03:35:55 INFO - Running post-action listener: set_extra_try_arguments 03:35:55 INFO - [mozharness: 2016-08-26 10:35:55.963583Z] Finished download-and-extract step (success) 03:35:55 INFO - [mozharness: 2016-08-26 10:35:55.963878Z] Running populate-webroot step. 03:35:55 INFO - Running pre-action listener: _resource_record_pre_action 03:35:55 INFO - Running main action method: populate_webroot 03:35:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:35:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:35:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:35:55 INFO - '--tppagecycles', 03:35:55 INFO - '7'], 03:35:55 INFO - 'tests': ['tsvgm']}}, 03:35:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:35:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:35:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:35:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:35:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:35:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:35:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:55 INFO - 'talos_options': ['--disable-e10s'], 03:35:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:35:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:35:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:55 INFO - 'talos_options': ['--disable-e10s'], 03:35:55 INFO - 'tests': ['damp', 'tps']}, 03:35:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:55 INFO - 'tests': ['damp', 'tps']}, 03:35:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:35:55 INFO - 'tests': ['dromaeo_dom']}, 03:35:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:35:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:35:55 INFO - 'tests': ['basic_compositor_video']}, 03:35:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:35:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:35:55 INFO - 'tests': ['a11yr', 03:35:55 INFO - 'ts_paint', 03:35:55 INFO - 'tpaint', 03:35:55 INFO - 'sessionrestore', 03:35:55 INFO - 'sessionrestore_no_auto_restore', 03:35:55 INFO - 'tabpaint']}, 03:35:55 INFO - 'other-e10s': {'tests': ['a11yr', 03:35:55 INFO - 'ts_paint', 03:35:55 INFO - 'tpaint', 03:35:55 INFO - 'sessionrestore', 03:35:55 INFO - 'sessionrestore_no_auto_restore', 03:35:55 INFO - 'tabpaint']}, 03:35:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:35:55 INFO - 'ts_paint', 03:35:55 INFO - 'tpaint', 03:35:55 INFO - 'sessionrestore', 03:35:55 INFO - 'sessionrestore_no_auto_restore', 03:35:55 INFO - 'tabpaint']}, 03:35:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:35:55 INFO - 'ts_paint', 03:35:55 INFO - 'tpaint', 03:35:55 INFO - 'sessionrestore', 03:35:55 INFO - 'sessionrestore_no_auto_restore', 03:35:55 INFO - 'tabpaint']}, 03:35:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:35:55 INFO - 'tests': ['a11yr', 03:35:55 INFO - 'ts_paint', 03:35:55 INFO - 'tpaint', 03:35:55 INFO - 'sessionrestore', 03:35:55 INFO - 'sessionrestore_no_auto_restore', 03:35:55 INFO - 'tabpaint']}, 03:35:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:35:55 INFO - 'tests': ['a11yr', 03:35:55 INFO - 'ts_paint', 03:35:55 INFO - 'tpaint', 03:35:55 INFO - 'sessionrestore', 03:35:55 INFO - 'sessionrestore_no_auto_restore', 03:35:55 INFO - 'tabpaint']}, 03:35:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:35:55 INFO - 'tests': ['tsvgx', 03:35:55 INFO - 'tsvgr_opacity', 03:35:55 INFO - 'tart', 03:35:55 INFO - 'tscrollx', 03:35:55 INFO - 'cart']}, 03:35:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:35:55 INFO - 'tsvgr_opacity', 03:35:55 INFO - 'tart', 03:35:55 INFO - 'tscrollx', 03:35:55 INFO - 'cart']}, 03:35:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:55 INFO - 'talos_options': ['--disable-e10s'], 03:35:55 INFO - 'tests': ['tp5o']}, 03:35:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:55 INFO - 'tests': ['tp5o']}, 03:35:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:55 INFO - 'talos_options': ['--disable-e10s', 03:35:55 INFO - '--xperf_path', 03:35:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:35:55 INFO - 'tests': ['tp5n']}, 03:35:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:55 INFO - 'talos_options': ['--xperf_path', 03:35:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:35:55 INFO - 'tests': ['tp5n']}}, 03:35:55 INFO - 'talos.zip': {'path': '', 03:35:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:35:55 INFO - Running post-action listener: _resource_record_post_action 03:35:55 INFO - [mozharness: 2016-08-26 10:35:55.983360Z] Finished populate-webroot step (success) 03:35:55 INFO - [mozharness: 2016-08-26 10:35:55.983453Z] Running create-virtualenv step. 03:35:55 INFO - Running pre-action listener: _resource_record_pre_action 03:35:55 INFO - Running main action method: create_virtualenv 03:35:55 INFO - Creating virtualenv /builds/slave/test/build/venv 03:35:55 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 03:35:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:35:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:35:56 INFO - Using real prefix '/usr' 03:35:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:35:56 INFO - Installing distribute.............................................................................................................................................................................................done. 03:35:58 INFO - Installing pip.................done. 03:35:58 INFO - Return code: 0 03:35:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3fa9c53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b50850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b370>, '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 0x2b4e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4ed80>, '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': '6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428', '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 03:35:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:35:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:35:58 INFO - Using env: {'DISPLAY': ':0', 03:35:58 INFO - 'HOME': '/home/cltbld', 03:35:58 INFO - 'LANG': 'en_US.UTF-8', 03:35:58 INFO - 'LANGUAGE': 'en_US:en', 03:35:58 INFO - 'LOGNAME': 'cltbld', 03:35:58 INFO - 'MAIL': '/var/mail/cltbld', 03:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:58 INFO - 'MOZ_NO_REMOTE': '1', 03:35:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:58 INFO - 'NO_EM_RESTART': '1', 03:35:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:58 INFO - 'PWD': '/builds/slave/test', 03:35:58 INFO - 'SHELL': '/bin/bash', 03:35:58 INFO - 'SHLVL': '1', 03:35:58 INFO - 'TERM': 'linux', 03:35:58 INFO - 'TMOUT': '86400', 03:35:58 INFO - 'USER': 'cltbld', 03:35:58 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428', 03:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:58 INFO - '_': '/tools/buildbot/bin/python'} 03:35:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:58 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 03:35:58 INFO - Cleaning up... 03:35:58 INFO - Return code: 0 03:35:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3fa9c53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b50850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b370>, '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 0x2b4e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4ed80>, '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': '6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428', '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 03:35:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:35:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:35:58 INFO - Using env: {'DISPLAY': ':0', 03:35:58 INFO - 'HOME': '/home/cltbld', 03:35:58 INFO - 'LANG': 'en_US.UTF-8', 03:35:58 INFO - 'LANGUAGE': 'en_US:en', 03:35:58 INFO - 'LOGNAME': 'cltbld', 03:35:58 INFO - 'MAIL': '/var/mail/cltbld', 03:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:58 INFO - 'MOZ_NO_REMOTE': '1', 03:35:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:58 INFO - 'NO_EM_RESTART': '1', 03:35:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:58 INFO - 'PWD': '/builds/slave/test', 03:35:58 INFO - 'SHELL': '/bin/bash', 03:35:58 INFO - 'SHLVL': '1', 03:35:58 INFO - 'TERM': 'linux', 03:35:58 INFO - 'TMOUT': '86400', 03:35:58 INFO - 'USER': 'cltbld', 03:35:58 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428', 03:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:58 INFO - '_': '/tools/buildbot/bin/python'} 03:35:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:58 INFO - Downloading/unpacking psutil>=3.1.1 03:35: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 03:35: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 03:35: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 03:35: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 03:35: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 03:35: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 03:36:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:36:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:00 INFO - Installing collected packages: psutil 03:36:00 INFO - Running setup.py install for psutil 03:36:01 INFO - building 'psutil._psutil_linux' extension 03:36:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:36:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:36:01 INFO - building 'psutil._psutil_posix' extension 03:36:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:36:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:36:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:01 INFO - Successfully installed psutil 03:36:01 INFO - Cleaning up... 03:36:01 INFO - Return code: 0 03:36:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:36:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3fa9c53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b50850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b370>, '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 0x2b4e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4ed80>, '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': '6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428', '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 03:36:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:36:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:36:01 INFO - Using env: {'DISPLAY': ':0', 03:36:01 INFO - 'HOME': '/home/cltbld', 03:36:01 INFO - 'LANG': 'en_US.UTF-8', 03:36:01 INFO - 'LANGUAGE': 'en_US:en', 03:36:01 INFO - 'LOGNAME': 'cltbld', 03:36:01 INFO - 'MAIL': '/var/mail/cltbld', 03:36:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:01 INFO - 'MOZ_NO_REMOTE': '1', 03:36:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:01 INFO - 'NO_EM_RESTART': '1', 03:36:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:01 INFO - 'PWD': '/builds/slave/test', 03:36:01 INFO - 'SHELL': '/bin/bash', 03:36:01 INFO - 'SHLVL': '1', 03:36:01 INFO - 'TERM': 'linux', 03:36:01 INFO - 'TMOUT': '86400', 03:36:01 INFO - 'USER': 'cltbld', 03:36:01 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428', 03:36:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:01 INFO - '_': '/tools/buildbot/bin/python'} 03:36:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:36:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:36:03 INFO - Installing collected packages: mozsystemmonitor 03:36:03 INFO - Running setup.py install for mozsystemmonitor 03:36:03 INFO - Successfully installed mozsystemmonitor 03:36:03 INFO - Cleaning up... 03:36:04 INFO - Return code: 0 03:36:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:36:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3fa9c53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b50850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b370>, '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 0x2b4e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4ed80>, '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': '6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428', '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 03:36:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:36:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:36:04 INFO - Using env: {'DISPLAY': ':0', 03:36:04 INFO - 'HOME': '/home/cltbld', 03:36:04 INFO - 'LANG': 'en_US.UTF-8', 03:36:04 INFO - 'LANGUAGE': 'en_US:en', 03:36:04 INFO - 'LOGNAME': 'cltbld', 03:36:04 INFO - 'MAIL': '/var/mail/cltbld', 03:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:04 INFO - 'MOZ_NO_REMOTE': '1', 03:36:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:04 INFO - 'NO_EM_RESTART': '1', 03:36:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:04 INFO - 'PWD': '/builds/slave/test', 03:36:04 INFO - 'SHELL': '/bin/bash', 03:36:04 INFO - 'SHLVL': '1', 03:36:04 INFO - 'TERM': 'linux', 03:36:04 INFO - 'TMOUT': '86400', 03:36:04 INFO - 'USER': 'cltbld', 03:36:04 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428', 03:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:04 INFO - '_': '/tools/buildbot/bin/python'} 03:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:04 INFO - Downloading/unpacking jsonschema==2.5.1 03:36: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 03:36: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 03:36: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 03:36: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 03:36: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 03:36: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 03:36:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:36:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:06 INFO - Downloading functools32-3.2.3-2.tar.gz 03:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:36:06 INFO - warning: no files found matching '*.txt' 03:36:06 INFO - no previously-included directories found matching 'build' 03:36:06 INFO - no previously-included directories found matching 'dist' 03:36:06 INFO - no previously-included directories found matching '.git*' 03:36:06 INFO - Installing collected packages: jsonschema, functools32 03:36:06 INFO - Running setup.py install for functools32 03:36:06 INFO - warning: no files found matching '*.txt' 03:36:06 INFO - no previously-included directories found matching 'build' 03:36:06 INFO - no previously-included directories found matching 'dist' 03:36:06 INFO - no previously-included directories found matching '.git*' 03:36:06 INFO - Successfully installed jsonschema functools32 03:36:06 INFO - Cleaning up... 03:36:06 INFO - Return code: 0 03:36:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:36: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')]} 03:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36: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')]} 03:36:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3fa9c53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b50850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b370>, '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 0x2b4e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4ed80>, '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': '6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428', '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 03:36:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:36:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:36:06 INFO - Using env: {'DISPLAY': ':0', 03:36:06 INFO - 'HOME': '/home/cltbld', 03:36:06 INFO - 'LANG': 'en_US.UTF-8', 03:36:06 INFO - 'LANGUAGE': 'en_US:en', 03:36:06 INFO - 'LOGNAME': 'cltbld', 03:36:06 INFO - 'MAIL': '/var/mail/cltbld', 03:36:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:06 INFO - 'MOZ_NO_REMOTE': '1', 03:36:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:06 INFO - 'NO_EM_RESTART': '1', 03:36:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:06 INFO - 'PWD': '/builds/slave/test', 03:36:06 INFO - 'SHELL': '/bin/bash', 03:36:06 INFO - 'SHLVL': '1', 03:36:06 INFO - 'TERM': 'linux', 03:36:06 INFO - 'TMOUT': '86400', 03:36:06 INFO - 'USER': 'cltbld', 03:36:06 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428', 03:36:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:06 INFO - '_': '/tools/buildbot/bin/python'} 03:36:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:36:06 INFO - Cleaning up... 03:36:06 INFO - Return code: 0 03:36:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:36: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')]} 03:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36: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')]} 03:36:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36: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', '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 0x7f3fa9c53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b50850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b370>, '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 0x2b4e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4ed80>, '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': '6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428', '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 03:36: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:36: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 blobuploader==1.2.4 03:36:06 INFO - Using env: {'DISPLAY': ':0', 03:36:06 INFO - 'HOME': '/home/cltbld', 03:36:06 INFO - 'LANG': 'en_US.UTF-8', 03:36:06 INFO - 'LANGUAGE': 'en_US:en', 03:36:06 INFO - 'LOGNAME': 'cltbld', 03:36:06 INFO - 'MAIL': '/var/mail/cltbld', 03:36:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:06 INFO - 'MOZ_NO_REMOTE': '1', 03:36:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:06 INFO - 'NO_EM_RESTART': '1', 03:36:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:06 INFO - 'PWD': '/builds/slave/test', 03:36:06 INFO - 'SHELL': '/bin/bash', 03:36:06 INFO - 'SHLVL': '1', 03:36:06 INFO - 'TERM': 'linux', 03:36:06 INFO - 'TMOUT': '86400', 03:36:06 INFO - 'USER': 'cltbld', 03:36:06 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428', 03:36:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:06 INFO - '_': '/tools/buildbot/bin/python'} 03:36:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:06 INFO - Downloading/unpacking blobuploader==1.2.4 03:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:08 INFO - Downloading blobuploader-1.2.4.tar.gz 03:36:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:36:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:36:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:09 INFO - Downloading docopt-0.6.1.tar.gz 03:36:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:36:09 INFO - Installing collected packages: blobuploader, requests, docopt 03:36:09 INFO - Running setup.py install for blobuploader 03:36:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:36:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:36:09 INFO - Running setup.py install for requests 03:36:10 INFO - Running setup.py install for docopt 03:36:10 INFO - Successfully installed blobuploader requests docopt 03:36:10 INFO - Cleaning up... 03:36:10 INFO - Return code: 0 03:36:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3fa9c53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b50850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b370>, '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 0x2b4e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4ed80>, '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': '6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428', '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 03:36:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:36:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:36:10 INFO - Using env: {'DISPLAY': ':0', 03:36:10 INFO - 'HOME': '/home/cltbld', 03:36:10 INFO - 'LANG': 'en_US.UTF-8', 03:36:10 INFO - 'LANGUAGE': 'en_US:en', 03:36:10 INFO - 'LOGNAME': 'cltbld', 03:36:10 INFO - 'MAIL': '/var/mail/cltbld', 03:36:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:10 INFO - 'MOZ_NO_REMOTE': '1', 03:36:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:10 INFO - 'NO_EM_RESTART': '1', 03:36:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:10 INFO - 'PWD': '/builds/slave/test', 03:36:10 INFO - 'SHELL': '/bin/bash', 03:36:10 INFO - 'SHLVL': '1', 03:36:10 INFO - 'TERM': 'linux', 03:36:10 INFO - 'TMOUT': '86400', 03:36:10 INFO - 'USER': 'cltbld', 03:36:10 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428', 03:36:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:10 INFO - '_': '/tools/buildbot/bin/python'} 03:36:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:36:10 INFO - Running setup.py (path:/tmp/pip-spr_f7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:36:10 INFO - Running setup.py (path:/tmp/pip-1T3JfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:36:10 INFO - Running setup.py (path:/tmp/pip-bo2TCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:36:10 INFO - Running setup.py (path:/tmp/pip-ComfxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:36:10 INFO - Running setup.py (path:/tmp/pip-oN_fpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:36:10 INFO - Running setup.py (path:/tmp/pip-CQqUdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:36:10 INFO - Running setup.py (path:/tmp/pip-8Vizzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:36:10 INFO - Running setup.py (path:/tmp/pip-cavgye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:36:11 INFO - Running setup.py (path:/tmp/pip-Cj_iED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:36:11 INFO - Running setup.py (path:/tmp/pip-CIXJoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:36:11 INFO - Running setup.py (path:/tmp/pip-bFsFC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:36:11 INFO - Running setup.py (path:/tmp/pip-LogbJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:36:11 INFO - Running setup.py (path:/tmp/pip-MTkhFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:36:11 INFO - Running setup.py (path:/tmp/pip-YDnsS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:11 INFO - Running setup.py (path:/tmp/pip-e1xIrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:36:11 INFO - Running setup.py (path:/tmp/pip-9N_CHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:36:11 INFO - Running setup.py (path:/tmp/pip-hYp9sa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:36:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:36:11 INFO - Running setup.py install for manifestparser 03:36:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:36:11 INFO - Running setup.py install for mozcrash 03:36:11 INFO - Running setup.py install for mozdebug 03:36:11 INFO - Running setup.py install for mozdevice 03:36:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:36:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:36:12 INFO - Running setup.py install for mozfile 03:36:12 INFO - Running setup.py install for mozhttpd 03:36:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:36:12 INFO - Running setup.py install for mozinfo 03:36:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:36:12 INFO - Running setup.py install for mozInstall 03:36:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:36:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:36:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:36:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:36:12 INFO - Running setup.py install for mozleak 03:36:12 INFO - Running setup.py install for mozlog 03:36:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:36:12 INFO - Running setup.py install for moznetwork 03:36:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:36:12 INFO - Running setup.py install for mozprocess 03:36:12 INFO - Running setup.py install for mozprofile 03:36:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:36:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:36:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:36:13 INFO - Running setup.py install for mozrunner 03:36:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:36:13 INFO - Running setup.py install for mozscreenshot 03:36:13 INFO - Running setup.py install for moztest 03:36:13 INFO - Running setup.py install for mozversion 03:36:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:36:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:36:13 INFO - Cleaning up... 03:36:13 INFO - Return code: 0 03:36:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3fa9c53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b50850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b370>, '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 0x2b4e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4ed80>, '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': '6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428', '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 03:36:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:36:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:36:13 INFO - Using env: {'DISPLAY': ':0', 03:36:13 INFO - 'HOME': '/home/cltbld', 03:36:13 INFO - 'LANG': 'en_US.UTF-8', 03:36:13 INFO - 'LANGUAGE': 'en_US:en', 03:36:13 INFO - 'LOGNAME': 'cltbld', 03:36:13 INFO - 'MAIL': '/var/mail/cltbld', 03:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:13 INFO - 'MOZ_NO_REMOTE': '1', 03:36:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:13 INFO - 'NO_EM_RESTART': '1', 03:36:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:13 INFO - 'PWD': '/builds/slave/test', 03:36:13 INFO - 'SHELL': '/bin/bash', 03:36:13 INFO - 'SHLVL': '1', 03:36:13 INFO - 'TERM': 'linux', 03:36:13 INFO - 'TMOUT': '86400', 03:36:13 INFO - 'USER': 'cltbld', 03:36:13 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428', 03:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:13 INFO - '_': '/tools/buildbot/bin/python'} 03:36:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:36:13 INFO - Running setup.py (path:/tmp/pip-ElmyAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:36:13 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)) 03:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:36:13 INFO - Running setup.py (path:/tmp/pip-f7wHSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:36:13 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)) 03:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:36:13 INFO - Running setup.py (path:/tmp/pip-1arbZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:36:13 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)) 03:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:36:13 INFO - Running setup.py (path:/tmp/pip-sdCIiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:36:13 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)) 03:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:36:13 INFO - Running setup.py (path:/tmp/pip-_iFYrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:36:14 INFO - Running setup.py (path:/tmp/pip-k6ogNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:36:14 INFO - Running setup.py (path:/tmp/pip-_A9WKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:36:14 INFO - Running setup.py (path:/tmp/pip-FVoWgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:36:14 INFO - Running setup.py (path:/tmp/pip-1IlxUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:36:14 INFO - Running setup.py (path:/tmp/pip-l44tcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:36:14 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)) 03:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:36:14 INFO - Running setup.py (path:/tmp/pip-z8186Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:36:14 INFO - Running setup.py (path:/tmp/pip-PlH_1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:36:14 INFO - Running setup.py (path:/tmp/pip-PBAr_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:36:14 INFO - Running setup.py (path:/tmp/pip-dwy5PN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:36:14 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)) 03:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:14 INFO - Running setup.py (path:/tmp/pip-Du6UJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:14 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)) 03:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:36:14 INFO - Running setup.py (path:/tmp/pip-DfEkt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:36:14 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)) 03:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:36:14 INFO - Running setup.py (path:/tmp/pip-gecDkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:36:14 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)) 03:36:14 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)) 03:36:14 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)) 03:36:14 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)) 03:36:14 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)) 03:36:14 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)) 03:36:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:36:14 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 03:36:14 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 03:36:14 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 03:36:14 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 03:36:14 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 03:36:14 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 03:36:16 INFO - Downloading blessings-1.6.tar.gz 03:36:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:36:16 INFO - Installing collected packages: blessings 03:36:16 INFO - Running setup.py install for blessings 03:36:17 INFO - Successfully installed blessings 03:36:17 INFO - Cleaning up... 03:36:17 INFO - Return code: 0 03:36:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:36:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:36:17 INFO - Reading from file tmpfile_stdout 03:36:17 INFO - Current package versions: 03:36:17 INFO - argparse == 1.2.1 03:36:17 INFO - blessings == 1.6 03:36:17 INFO - blobuploader == 1.2.4 03:36:17 INFO - docopt == 0.6.1 03:36:17 INFO - functools32 == 3.2.3-2 03:36:17 INFO - jsonschema == 2.5.1 03:36:17 INFO - manifestparser == 1.1 03:36:17 INFO - mozInstall == 1.12 03:36:17 INFO - mozcrash == 0.17 03:36:17 INFO - mozdebug == 0.1 03:36:17 INFO - mozdevice == 0.48 03:36:17 INFO - mozfile == 1.2 03:36:17 INFO - mozhttpd == 0.7 03:36:17 INFO - mozinfo == 0.9 03:36:17 INFO - mozleak == 0.1 03:36:17 INFO - mozlog == 3.3 03:36:17 INFO - moznetwork == 0.27 03:36:17 INFO - mozprocess == 0.23 03:36:17 INFO - mozprofile == 0.28 03:36:17 INFO - mozrunner == 6.12 03:36:17 INFO - mozscreenshot == 0.1 03:36:17 INFO - mozsystemmonitor == 0.3 03:36:17 INFO - moztest == 0.7 03:36:17 INFO - mozversion == 1.4 03:36:17 INFO - psutil == 3.1.1 03:36:17 INFO - requests == 1.2.3 03:36:17 INFO - wsgiref == 0.1.2 03:36:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3fa9c53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b50850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b370>, '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 0x2b4e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4ed80>, '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': '6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428', '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 03:36:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:36:17 INFO - Using env: {'DISPLAY': ':0', 03:36:17 INFO - 'HOME': '/home/cltbld', 03:36:17 INFO - 'LANG': 'en_US.UTF-8', 03:36:17 INFO - 'LANGUAGE': 'en_US:en', 03:36:17 INFO - 'LOGNAME': 'cltbld', 03:36:17 INFO - 'MAIL': '/var/mail/cltbld', 03:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:17 INFO - 'MOZ_NO_REMOTE': '1', 03:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:17 INFO - 'NO_EM_RESTART': '1', 03:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:17 INFO - 'PWD': '/builds/slave/test', 03:36:17 INFO - 'SHELL': '/bin/bash', 03:36:17 INFO - 'SHLVL': '1', 03:36:17 INFO - 'TERM': 'linux', 03:36:17 INFO - 'TMOUT': '86400', 03:36:17 INFO - 'USER': 'cltbld', 03:36:17 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428', 03:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:17 INFO - '_': '/tools/buildbot/bin/python'} 03:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:36:17 INFO - Cleaning up... 03:36:17 INFO - Return code: 0 03:36:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3fa9c53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b50850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b370>, '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 0x2b4e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4ed80>, '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': '6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428', '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 03:36:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:36:17 INFO - Using env: {'DISPLAY': ':0', 03:36:17 INFO - 'HOME': '/home/cltbld', 03:36:17 INFO - 'LANG': 'en_US.UTF-8', 03:36:17 INFO - 'LANGUAGE': 'en_US:en', 03:36:17 INFO - 'LOGNAME': 'cltbld', 03:36:17 INFO - 'MAIL': '/var/mail/cltbld', 03:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:17 INFO - 'MOZ_NO_REMOTE': '1', 03:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:17 INFO - 'NO_EM_RESTART': '1', 03:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:17 INFO - 'PWD': '/builds/slave/test', 03:36:17 INFO - 'SHELL': '/bin/bash', 03:36:17 INFO - 'SHLVL': '1', 03:36:17 INFO - 'TERM': 'linux', 03:36:17 INFO - 'TMOUT': '86400', 03:36:17 INFO - 'USER': 'cltbld', 03:36:17 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428', 03:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:17 INFO - '_': '/tools/buildbot/bin/python'} 03:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:36:17 INFO - Cleaning up... 03:36:17 INFO - Return code: 0 03:36:17 INFO - Running post-action listener: _resource_record_post_action 03:36:17 INFO - Running post-action listener: _start_resource_monitoring 03:36:17 INFO - Starting resource monitoring. 03:36:17 INFO - [mozharness: 2016-08-26 10:36:17.741536Z] Finished create-virtualenv step (success) 03:36:17 INFO - [mozharness: 2016-08-26 10:36:17.742025Z] Running install step. 03:36:17 INFO - Running pre-action listener: _resource_record_pre_action 03:36:17 INFO - Running main action method: install 03:36:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:36:17 INFO - Reading from file tmpfile_stdout 03:36:17 INFO - Detecting whether we're running mozinstall >=1.0... 03:36:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:36:18 INFO - Reading from file tmpfile_stdout 03:36:18 INFO - Output received: 03:36:18 INFO - Usage: mozinstall [options] installer 03:36:18 INFO - Options: 03:36:18 INFO - -h, --help show this help message and exit 03:36:18 INFO - -d DEST, --destination=DEST 03:36:18 INFO - Directory to install application into. [default: 03:36:18 INFO - "/builds/slave/test"] 03:36:18 INFO - --app=APP Application being installed. [default: firefox] 03:36:18 INFO - mkdir: /builds/slave/test/build/application 03:36:18 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'] 03:36:18 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 03:36:35 INFO - Reading from file tmpfile_stdout 03:36:35 INFO - Output received: 03:36:35 INFO - /builds/slave/test/build/application/firefox/firefox 03:36:35 INFO - Running post-action listener: _resource_record_post_action 03:36:35 INFO - [mozharness: 2016-08-26 10:36:35.074093Z] Finished install step (success) 03:36:35 INFO - [mozharness: 2016-08-26 10:36:35.074339Z] Running run-tests step. 03:36:35 INFO - Running pre-action listener: _resource_record_pre_action 03:36:35 INFO - Running main action method: run_tests 03:36:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:36:35 INFO - Python 2.7.3 03:36:35 INFO - Return code: 0 03:36:35 INFO - grabbing minidump binary from tooltool 03:36:35 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')]} 03:36:35 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 0x2b4b370>, '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 0x2b4e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4ed80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:36:35 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 03:36:35 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 03:36:35 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 03:36:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:36:35 INFO - Return code: 0 03:36:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:36:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:36:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:36:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:36:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:36:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O44f-lOSQ2KnBFVTrdFA_g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 03:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O44f-lOSQ2KnBFVTrdFA_g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 03:36:35 INFO - Using env: {'DISPLAY': ':0', 03:36:35 INFO - 'HOME': '/home/cltbld', 03:36:35 INFO - 'LANG': 'en_US.UTF-8', 03:36:35 INFO - 'LANGUAGE': 'en_US:en', 03:36:35 INFO - 'LOGNAME': 'cltbld', 03:36:35 INFO - 'MAIL': '/var/mail/cltbld', 03:36:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:36:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:35 INFO - 'MOZ_NO_REMOTE': '1', 03:36:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:35 INFO - 'NO_EM_RESTART': '1', 03:36:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:35 INFO - 'PWD': '/builds/slave/test', 03:36:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:36:35 INFO - 'SHELL': '/bin/bash', 03:36:35 INFO - 'SHLVL': '1', 03:36:35 INFO - 'TERM': 'linux', 03:36:35 INFO - 'TMOUT': '86400', 03:36:35 INFO - 'USER': 'cltbld', 03:36:35 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428', 03:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:35 INFO - '_': '/tools/buildbot/bin/python'} 03:36:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O44f-lOSQ2KnBFVTrdFA_g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 03:36:35 INFO - mozversion application_buildid: 20160826002255 03:36:35 INFO - mozversion application_changeset: 3cc6bb7fb81eaa8e47183a04f5662114a3113242 03:36:35 INFO - mozversion application_display_name: Nightly 03:36:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:36:35 INFO - mozversion application_name: Firefox 03:36:35 INFO - mozversion application_remotingname: firefox 03:36:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:36:35 INFO - mozversion application_vendor: Mozilla 03:36:35 INFO - mozversion application_version: 51.0a1 03:36:35 INFO - mozversion platform_buildid: 20160826002255 03:36:35 INFO - mozversion platform_changeset: 3cc6bb7fb81eaa8e47183a04f5662114a3113242 03:36:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:36:35 INFO - mozversion platform_version: 51.0a1 03:36:35 INFO - using testdate: 1472207795 03:36:35 INFO - actual date: 1472207795 03:36:35 INFO - starting webserver on 'localhost:42778' 03:36:35 INFO - SUITE-START | Running 2 tests 03:36:35 INFO - TEST-START | dromaeo_css 03:36:35 INFO - operating with platform_type : linux_ 03:36:35 INFO - Initialising browser for dromaeo_css test... 03:36:35 INFO - TEST-INFO | started process 2054 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ5oEPU/profile http://localhost:42778/getInfo.html) 03:36:39 INFO - PROCESS | 2054 | __metrics Screen width/height:1600/1200 03:36:39 INFO - PROCESS | 2054 | colorDepth:24 03:36:39 INFO - PROCESS | 2054 | Browser inner width/height: 1024/697 03:36:39 INFO - PROCESS | 2054 | __metrics 03:36:40 INFO - PROCESS | 2054 | 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" 03:36:40 INFO - PROCESS | 2054 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:36:40 INFO - PROCESS | 2054 | console.error: PushService: 03:36:40 INFO - PROCESS | 2054 | stateChangeProcessEnqueue: Error transitioning state 03:36:40 INFO - PROCESS | 2054 | UnknownError 03:36:41 INFO - TEST-INFO | 2054: exit 0 03:36:41 INFO - Browser initialized. 03:36:41 INFO - Running cycle 1/1 for dromaeo_css test... 03:36:41 INFO - TEST-INFO | started process 2136 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ5oEPU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:36:53 INFO - PROCESS | 2136 | RSS: Main: 180060160 03:36:53 INFO - PROCESS | 2136 | 03:37:45 INFO - PROCESS | 2136 | 1472207865115 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] 03:39:54 INFO - PROCESS | 2136 | Cycle 1(1): loaded http://localhost:42778/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42778/tests/dromaeo/cssquery-ext.html) 03:39:55 INFO - PROCESS | 2136 | RSS: Main: 273039360 03:39:55 INFO - PROCESS | 2136 | 03:42:58 INFO - PROCESS | 2136 | Cycle 1(1): loaded http://localhost:42778/tests/dromaeo/cssquery-ext.html (next: http://localhost:42778/tests/dromaeo/cssquery-jquery.html) 03:42:58 INFO - PROCESS | 2136 | RSS: Main: 273174528 03:42:58 INFO - PROCESS | 2136 | 03:46:00 INFO - PROCESS | 2136 | Cycle 1(1): loaded http://localhost:42778/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42778/tests/dromaeo/cssquery-mootools.html) 03:46:01 INFO - PROCESS | 2136 | RSS: Main: 248795136 03:46:01 INFO - PROCESS | 2136 | 03:49:03 INFO - PROCESS | 2136 | Cycle 1(1): loaded http://localhost:42778/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42778/tests/dromaeo/cssquery-prototype.html) 03:49:04 INFO - PROCESS | 2136 | RSS: Main: 236503040 03:49:04 INFO - PROCESS | 2136 | 03:52:07 INFO - PROCESS | 2136 | Cycle 1(1): loaded http://localhost:42778/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42778/tests/dromaeo/cssquery-yui.html) 03:52:07 INFO - PROCESS | 2136 | RSS: Main: 213929984 03:52:07 INFO - PROCESS | 2136 | 03:55:10 INFO - PROCESS | 2136 | Cycle 1(1): loaded http://localhost:42778/tests/dromaeo/cssquery-yui.html (next: http://localhost:42778/tests/dromaeo/cssquery-dojo.html) 03:55:10 INFO - PROCESS | 2136 | RSS: Main: 307322880 03:55:10 INFO - PROCESS | 2136 | 03:55:10 INFO - PROCESS | 2136 | __start_tp_report 03:55:10 INFO - PROCESS | 2136 | _x_x_mozilla_page_load 03:55:10 INFO - PROCESS | 2136 | _x_x_mozilla_page_load_details 03:55:10 INFO - PROCESS | 2136 | |i|pagename|runs| 03:55:10 INFO - PROCESS | 2136 | |0;dojo.html;3063.2648164440543;3067.263856674398;3067.7852550321472;3101.6122984626923;3123.8438078096087;5283.181106928432;5325.121354976424;5370.516653501189;5460.262864513289;5470.370907345651;5433.266509021281;5444.891102177954;5445.727713614323;5449.427810079944;5485.177223416489;4842.9515704843025;4855.247436647325;4882.877928051809;4911.582515486188;4928.310036594879;4917.2869933859565;4923.6077868198445;5036.722980236085;5044.974775126119;5068.113080210948;4913.656044076916;4931.605471562267;4971.552560269575;4983.526564976321;5014.2979982802435;4781.330613714083;4842.927356089662;4848.806047758086;4884.974155427364;4887.193613053842;4836.854894353175;4861.659683822134;4862.3922009748785;4902.534259245366;4959.851204463872;5384.461553844584;5425.430329815352;5431.565474762009;5470.99999999996;5492.697901615409;5676.858078548028;5695.088785794294;5751.511121554673;5809.970950145223;5819.6508209507565;5752.194692743019;5776.855578610526;5812.128180772876;5812.82561523155;5867.794627188071;5396.730163491809;5403.5136837684795;5407.3781515125875;5408.215808707715;5409.972950135224;5734.05388110957;5836.533077353802;5843.590948633555;5860.912086318709;5890;5674.06377947634;5678.432156784371;5679.204911312419;5682.801101961411;5736.311642602831;5766.913496297559;5778.797742079007;5782.508486778587;5786.508146807569;5794.82615521535;5553.611247212737;5642.4075472075665;5691.4877661010705;5706.115552089433;5709.68596727184;5709.885802283931;5710.885782284414;5714.171445140431;5717.970765262209;5772.9711351442975;4417.911641767147;4452.799624016927;4463.732176069446;4471.754053527022;4511.436070491189;3884.4561761353434;3949.289127956938;3963.583823698528;3993.341098718737;4004.6796256299426;5542.528885044736;5554.86112847174;5555.138953462219;5611.410801865745;5622.7750889963945;5828.6502809831545;5835.562332825055;5839.620424672383;5845.386234445407;5845.824625261249;5358.758855851496;5460.6177567570685;5476.644018138808;5531.668099914018;5546.77812887488;5001.824936127218;5066.721330326867;5087.643864929493;5094.261332106824;5094.592432605383;6000.849978750479;6040.214772079689;6043.335233124353;6048.455638992512;6049.18336024631;5544.1960915667805;5791.884162316645;5801.477866991822;5806.390329015392;5808.477237048686;5979.073243647242;6014.1580178775885;6036.788712395045;6037.104998936558;6101;5700.372958974426;5703.714814259188;5704.714764261853;5721.113227449752;5735.827925162252;5592.7203639817035;5798.739056742541;5804.2744656917885;5811.82564523065;5815.273090863642;5626.746796394254;5654.971725141348;5664.0937450007805;5727.31272247333;5777.162311464898;5668.178114173505;5704.172894930129;5712.571557133315;5723.484886360247;5724.79963201286;5464.863378415413;5624.521915637217;5659.462351076641;5663.716814159193;5677.943220567907;5668.0931051033285;5680.346760122638;5710.5717071219;5719.056355701263;5786.045302525036;5598.524125449219;5603.10350343943;5603.859903502445;5604.523615492566;5608.046632072476 03:55:10 INFO - PROCESS | 2136 | |1;ext.html;555.5664043429864;573.1689050876231;584.1383958660974;591.52973386158;615.2616859768276;32043.51934720978;35262.1184470388;43502.56497435029;44313;44360.334594981105;46120.308195377096;46971.29543056857;47058.529414705845;47082.76458617711;47117.76441117798;8825.293976481882;8885.822283554326;8893.28853691703;8977;8985.101489851028;8114.756557303291;8848.336374771885;10271.332363396356;10507.63223287185;10515.947420262926;10801.297915635498;10859.891401086006;10866.836997445005;10868.510917008754;10870.076043536308;10719.410432426213;10786.352818830817;10791.24461287714;10827.350358978409;10892.564297428173;10727.249092563447;10791.244612877103;10799.5680172793;10801.5679372825;10810.729731756768;43633.78183109096;43787.78106109481;43986.120277594586;44006.11987760259;44025.55974440279;3678.668919797231;3698.556173259199;3713.405855063177;3865.265599536079;4289.356596510548;33561;33746.83126584376;33995.83002084974;34612.48081278783;34886.302273954636;4128.710990230685;4223.514295855985;4294.355846623001;4295.763732994684;4447.355133505656;369337;373061;374436;374603;376904.1154794236;61766.69116654388;62519;62589.37410625927;62684;62739;37013;37639.81180094137;37691.62308376881;39450.605493945266;39691.40462893059;17389.47831565055;17535.736963945295;17548.29806807739;17549.912250438665;17556.912215438842;12065.758684826254;13374.33128343579;13469.528566500125;13472.730545389037;13477.326133693472;19315.90342048281;19586.96934256948;20177.293794717407;20398.69401958972;20481.180752770022;7035.92964070363;7182.604956727326;7294.927050729425;7415.925840741524;7459.403247740168;927.3230541704594;1023.923205759571;1079.8491196990312;1116.1405717597404;1122.1639878290725;32845.835770820995;32943.188124652894;33164.85439320085;33319.50020749691;33569.16077098043;1053.89461053894;1087.532361084741;1088.2001728729379;1147.9081673466103;1228.502456505117;16407.5898102546;17445.214965326337;17660;17827.821721782875;17885.37401190952;588998;835601;856885;871219;871256;59275.40724592699;59900.10149847756;59967.70016149891;66652.33347666558;66918.33081669218;1250.249850089957;1357.429879450633;1370.1299674706634;1436.0880840666252;1451.7604595241878;30488.237794055327;34540.481892771124;34827.303453930275;34921.47617785684;34975.475367868996;52926.470735292154;53161.46838531565;53514.46485535095;53543;53627;423300;427394;427921;428006;428551;37826.810865946594;44214;45697.77151114356;46864.297035545176;47562.76218618885;49945.500544995535;50248;51030.74484627553;52265;52273.7386313066;39499.40750888796;42249;42505.5749442514;42588.57411425846;44376.33435498406;42092.78953605212;42422.15155696807;42456.78771606122;43891.56108439002;44122.11755764931;41905;42127;42237.57762422336;42418.78790606151;43629;35922.64077359193;38058.809705951295;38267;38328;39088.80455597704;28086;28389.43221135607;28417;28524;28534.857325713238 03:55:10 INFO - PROCESS | 2136 | |2;jquery.html;397.7394806401808;403.68373809157765;411.78792921645356;411.9217348703745;422.3727764270058;13265.801012984788;18340.81659183408;20004.69992950105;20016.0992755326;20991.895040524814;18214.544636384097;19027.61944761104;19044.428667139975;19676.508087297825;19845.206191752313;5084.51697088776;5192.740362981855;5203.089459344618;5215.973920130394;5229.08491014071;3941.566427692966;5151.4333423323405;5164.251183578379;5199.376074871021;5205;5672.376038635747;5863.325717542494;5927.703614819264;5999.820005399845;6000.189974353472;5774.624649397776;5870.090136028923;5932.822015339547;5940.910886336686;5992.310884248323;5749.482546570829;5756.194132821408;5757.395473475267;5764.221830052973;5764.711764411804;14793.778093328609;15748.527544173694;22272.109115635354;23433.648495272413;23491.17780877661;2332.5101728637005;2413.3725231439953;2806.0880213930554;2899.0578062129894;2935.544990526472;10595.523201455953;11123.666290011313;11139.108871290277;11182.496787644575;13241.801372979413;1740.6953783088036;1825.3702472646914;1852.740616313717;1917.664408728467;1937.476881242071;81864;84454.57772711097;86017;86251.56874215651;86574.13425865787;11186.608468703556;11269.830952535718;11288.209825312313;11354.26197297173;11589.362585057903;15913.363465461483;15926;15929.36282548685;15935.681286374207;15940.92029539845;8076.676932922617;8295;8521.360897932556;8528.872066919;8536.402451828437;7689.577073261024;7730.420218483636;7796.415268854858;8056;8170;4544.909101817945;4660;4711.45818230901;4754.334393184957;4946.950530494721;1941.825235728763;1951.9902400487906;1973.3783858084657;2018.9394318170478;2053.9408744204356;846.8856704344835;948.307735353196;998.4009594243396;1009.5911155981839;1010.4745532323298;17778.199981000886;19610;19620.117094730773;19665;19994.30019949324;970.7864269860619;985.1478471122427;1033.5762337441613;1034.1984961654778;1035.891231420705;10387.117095047006;10764.515596798163;10854.18593605467;10913.508892099875;10920.945395273131;454160;460062;465720;483864;487033;50640.49359506431;67458.66270668615;76933.84599231016;79388.60305698434;90274;962.4177372689562;966.7341481092756;987.9061489158519;990.5294984882267;991.8115558043949;16640.667186655955;16846.410375636795;17368.39210627622;17397;17678.646427071642;31003.844980774953;39999.2000160001;40469.1906161881;41705.37441938313;43317.566824331356;55572.72213638906;57825;58461.70769146127;58887.11669325049;58919.11621325598;8109.635066421907;8120.715774947848;8195.549244791593;8281.254687078192;8799.736007919773;12357.814632780335;13369.66575835573;13421.731565368442;13477;13711.520096796565;10727.570897164025;11277.830832537355;11342.489587968395;11437.485313160762;11626.651200463999;11305.547778088785;11419;11458.828117578076;11502.94248528752;11598.94200528992;10870.565177392815;11148.554057837595;11338.659840204808;11771.411429428666;11983.880161198276;7662.272084151997;8113.148119447373;8208.384371172067;8287.419880608299;8329.33413317351;7705.537667739954;10860.67417977462;11341.092712583139;11447.656570302905;11509.769804604028 03:55:10 INFO - PROCESS | 2136 | |3;mootools.html;1361.3669643615717;1463.948761793337;1479.563528759016;1612.6210340569971;1774.6805574996495;8605.483670979746;8993.055729148444;9062.912450505948;9308.48803315819;9319.347645664806;9028.322875784326;9125.406848554856;9131;9154.359194856363;9199.77000574986;2024.1599736109497;2329.9301020969315;2417.637354396841;2442.8778561071963;2445.0464318915638;2457.950840983179;2490.9003639854386;2522.9116980905674;2524.3436706456364;2527.75986281303;2391.80865530758;2394.976050239493;2419.2984034629935;2426.8543887366727;2432.1244352033254;2318.5594737000083;2365.5860224460735;2386.7613238675995;2387.928362149147;2406.290144407404;2469.6665950096685;2471.0733474946896;2486.527559763639;2491.4145175883655;2494.0896572751;9163.770905727344;9259.861102083474;9312.394694344914;9320.766980825465;9322.86015709765;5419.918701219485;5552.972235138839;5559.8888022239325;5564.554835613141;5566.888662226774;3435.1412146963257;3447.3622379859808;3478.7912725236315;3508.736844736655;3533.522974398449;1134.1323887226279;1140.4924808460155;1148.236422778851;1158.6871544682972;1167.824826276057;12830.294333811637;13026.739465210738;13084.08411411192;13194;13283.335833208397;4811.7834697438;4865.829695960624;4914.115459217375;5014.774335154927;5032.094223039888;11248.437578121062;11260.718482038015;11260.94369528147;11271.267367621078;11276;5582.49757521825;5583.0787919992745;5585.273914391103;5591.189277554732;5597.216389705444;4354.629856462173;4787.54518320759;4881.170201065827;5024.045431368028;5112.923306150411;4156.397322388237;4256.8297268109545;4268.978655106766;4324.762138082373;4333.133373325284;1352.134633834347;1352.1819299323963;1373.368250604713;1392.526540976073;1409.1545072956144;882.3955590420583;931.3247895276006;957.4973139101888;991.2020823237219;1035.3994683083793;6219.751209951642;6241.625502469867;6243.8126856194385;6366.9681651591445;6455.806325810139;468.12227074235807;474.964377671676;477.76111944027986;478.394830539368;482.68866581055727;4269.701120921506;4363.36731173978;4504.436945381827;4605.332226827091;4622.168009758208;11181.720456988478;11585.536578536932;11625.709357265967;11639.883601164049;11663.416829158508;10757.784844303227;11191.496382662799;11461.54153833854;11463.656090317303;11552.422378881023;8029.839403211903;8188.344932405394;8239;8283;8285.751427457186;6193.225846769154;6258.155149054819;6487;6538.803835884931;6681.732730690913;10583.4708264588;10631.574737010433;10668.253222274676;10940.343579385262;10983.505742241778;10215.23385746087;10700.678979630624;10705;10757.784844302914;10994.505247263733;7382.26177382279;7844.21557844211;7929.960350198212;8002.079760827346;8178.631961561625;8952.418092823946;9103.453792772454;9137.908620913706;9141.908580914373;9143.13140251675;7786.4160187985;7968.362530997622;8100.0279966404405;8178.83642327162;8235.21765432283;7066.57600543969;7442.813929651802;7555.622218889143;7647.502912310682;7698.846023079619;7113.0753002109395;7218;7242.275772422716;7282.198958114497;7285.672144753605;5185.688858668492;5202.947970520247;5230.895382092261;5286.180642000496;5591.161325801162;5166.793328266827;5184.118699821115;5213.035588416155;5275.604329675367;5443.809466668806 03:55:10 INFO - PROCESS | 2136 | |4;prototype.html;328.80002287304495;336.0992539992819;338.37766707397316;349.10454683736197;349.6451102131337;5144.279800827887;5261.8947621047655;5315.760790764415;5338.5462235709965;5358.249845021695;5222.764975576099;5223.791048358071;5226.144718624881;5238.240455134003;5275.920861187085;4209.768462734548;4221.683373746966;4223.282042052859;4229.133027729324;4270.829166833323;3982.721209515335;4148.108156746299;4237.364395340693;4238.554951730071;4240.681948853833;4128.2362762888815;4135.710500264982;4140.461739973799;4142.17156568686;4154.189932963073;4114.177164567083;4124.154548317588;4139.254934111858;4157.3140431828715;4159.292920203573;3638.5088013118157;3660.7254455915645;3669.853205871762;3674.1549443627846;3688.4098544232793;5017.623678224148;5063.8987220255385;5093.592512598983;5094.821681241138;5123.948760512421;4634.582887540138;4679.4618618858585;4680.251159814447;4688.624910007191;4688.953110468886;5323.494268044529;5424.457554244584;5436.048691478975;5437.429069947678;5484.8354549363585;3892.4161375793574;3920.6863450923856;3942.4874766280486;3959.7030222733124;3962.5046869141356;5582.358028826697;5620.269364982526;5630.690312032836;5648.491635752802;5650.898074875401;4044.4135600338373;4077.5922407758985;4082.755034697928;4083.4079058536345;4089.591040895946;3835.386338185877;3990.4213888986515;4013.2174226026227;4018;4131.421600975866;4567.36056952027;4569.702969306984;4571.262920090345;4595.241785105487;4598.218302888517;5448.400675925645;5483.013057649661;5501.174823776466;5530.6128570999645;5537.36320323168;1339.8124262603244;1361.0268657909642;1396.1483495068;1406.4866323791741;1414.2575148047151;915.1809130827871;933.5390114470831;956.7273327101742;964.4165280005636;967.4533888353058;5210.973945130326;5217.191335343028;5219.243209734567;5227.163653815372;5229.50319719626;5442.319710036246;5445.346558413015;5463.754131064112;5479.863003424866;5488.615796894179;5051.146102452103;5156.432792392834;5218.347706536683;5220.1647736362;5265.368155821326;2889.277680579855;2902.6661933877454;2909.88360465579;2917.4602698500844;2934.559816027613;5699.116636921284;5709.8287051388525;5755.7122143893475;5795.681237531892;5817.44734250254;5540.252065971123;5649.745761440745;5673.77304907799;5674.205611214434;5681.38656218136;5737.540996720169;5741.253637027244;5772.769089236467;5792.4497172768515;5809.896119737321;5345.732713364238;5556.305461817273;5568.526675232651;5613.719314034363;5630.549556035426;5460.535854452416;5474.589405794661;5475.479829416199;5566.942280966603;5582.27430434041;5749.540036796962;5825.446582574818;5826.300843898759;5827.184194212899;5829.213056237523;3814.294355544233;4031.2945234583244;4031.9798401007806;4065.329220678555;4071.328230841878;5330.147176451749;5559.27729395176;5566.304211973504;5578.497935185853;5590.972045139748;5369.570434365163;5398.9190162146815;5404.270423492778;5408.5673146149;5447.945520544902;5387.138057910872;5420.127332513774;5423.945760542502;5453.863653408696;5480.780768769205;5235.267062611314;5366.892662146814;5370.758315875873;5389.75746091419;5416.322959630046;5439.456054394529;5446.564274857923;5467.425920278472;5467.4532546745;5474.425185355481;5290.8941821164135;5350.411454739898;5364.329458817648;5397.3523177218985;5403.86490337729 03:55:10 INFO - PROCESS | 2136 | |5;yui.html;655.6164643683445;687.6974131382192;688.538679085013;726.912770467544;734.5152199548297;14056;14836.703265934675;14955.626109347244;14956.626084347883;14982.175980321077;13981.580552583413;14534.418623255056;14545.345459454324;14561;14588;679.894616334469;802.4182467710892;816.60802814649;837.5226121110969;840.4285086141422;837.924586787189;845.9619317130744;852.8038551133243;853.2235665544356;853.3770347646222;868.8262347530488;873.3580818098692;874.2481465939287;879.5470332778624;880.5201165364891;705.6612825843624;839.1147339556766;870.8737233101197;871.3160169267159;871.3551971541077;628.9182406287199;629.7292164369319;631.059721015688;636.6466611030876;636.9076483909854;13918.234497102656;14065.859341406558;14067.507637232648;14068.577942661737;14087.295635218301;12672.6831829205;12988;13390.196588204739;13439.193648381128;13596.252206128658;12126.878731212752;12246.632601021984;12549.1215614907;12562.246265224116;13314.400851961685;3633.218857945528;3712.554493460775;3722.1997270586953;3728.9627103728885;3765.152840610868;70693.64653176753;72677;86530;86649.56675216583;86824.99999999937;11156.721081972853;11383;11391.202615816814;11552.075833933266;11579.478923448296;20520.486987825127;21020.894895525424;21103.68344474834;21114.78885211159;21137.365879023655;7880.84238315242;8314.750557483285;8376.623051962677;8525.57372131391;8894.777630559158;4651.790669419885;4823.898467195619;4842.612590992712;4853.927191092136;4951.579115775199;3109.2537790930014;3225.6290526589273;3226.080567038383;3229.870805167767;3230.144011836865;597.1460811040167;603.3966033966034;605.5428151745404;614.115673430259;625.5996162456032;609.6435431165621;739.7595781371076;754.7320701151123;763.9541627502367;777.8755399136111;9506.152535023892;9668.51241026254;9681.273904457194;9881.456519891331;9912.15746661542;584.9532037436995;721.1922646635802;734.110374138712;753.4161025205509;762.268222506389;4570.159082794467;4644.883877903079;4801.399825021872;4832.420109586802;4857.149998750205;95820;126779;131432;133981.33009334892;135126;101066;103194;103508.48245758723;106059;109588.4520577408;64100.67949660222;73306.63346683233;98265;99771.99999999854;102872.48563757133;8771.298296136167;9079.636814527345;9092.318076144184;9251.583678734607;9320.254379649476;54991.45008550023;57120.143197851234;57635.25370850881;57691.71154144371;58814.41185588261;80326;83026;84785;85484;88334.55832720795;11797.410129493663;11930.522779088738;11982.880171198525;12064.75870482603;12213.389330533615;13136.540221092217;13481.460741570227;13681.79477307861;13728.519501817787;14207.64480887986;12144.392780361124;12438.19151755133;12486.819854769865;12848.550300739429;13311.534096306583;12173.452194651085;12349.93825030869;12536.310502922426;12629.81055284153;12644.494220231456;12186.512539498675;12343.13598048128;12657;12755.48978040905;13061.804072939103;9033.77415564616;9663.371880827724;9853.310268281151;9963.850542241727;10340.741481462723;9658.75853103678;10286.125679317043;10328.277020608486;10422.478876056319;10486.580536778443 03:55:10 INFO - PROCESS | 2136 | __end_tp_report 03:55:10 INFO - PROCESS | 2136 | __start_cc_report 03:55:10 INFO - PROCESS | 2136 | _x_x_mozilla_cycle_collect,1076 03:55:10 INFO - PROCESS | 2136 | __end_cc_report 03:55:10 INFO - PROCESS | 2136 | __startTimestamp1472208910903__endTimestamp 03:55:10 INFO - PROCESS | 2136 | 03:55:10 INFO - PROCESS | 2136 | ------- Summary: start ------- 03:55:10 INFO - PROCESS | 2136 | Number of tests: 6 03:55:10 INFO - PROCESS | 2136 | 03:55:10 INFO - PROCESS | 2136 | [#0] dojo.html Cycles:165 Average:5381.87 Median:5611.41 stddev:612.58 (10.9%) stddev-sans-first:586.84 03:55:10 INFO - PROCESS | 2136 | Values: 3063.3 3067.3 3067.8 3101.6 3123.8 5283.2 5325.1 5370.5 5460.3 5470.4 5433.3 5444.9 5445.7 5449.4 5485.2 4843.0 4855.2 4882.9 4911.6 4928.3 4917.3 4923.6 5036.7 5045.0 5068.1 4913.7 4931.6 4971.6 4983.5 5014.3 4781.3 4842.9 4848.8 4885.0 4887.2 4836.9 4861.7 4862.4 4902.5 4959.9 5384.5 5425.4 5431.6 5471.0 5492.7 5676.9 5695.1 5751.5 5810.0 5819.7 5752.2 5776.9 5812.1 5812.8 5867.8 5396.7 5403.5 5407.4 5408.2 5410.0 5734.1 5836.5 5843.6 5860.9 5890.0 5674.1 5678.4 5679.2 5682.8 5736.3 5766.9 5778.8 5782.5 5786.5 5794.8 5553.6 5642.4 5691.5 5706.1 5709.7 5709.9 5710.9 5714.2 5718.0 5773.0 4417.9 4452.8 4463.7 4471.8 4511.4 3884.5 3949.3 3963.6 3993.3 4004.7 5542.5 5554.9 5555.1 5611.4 5622.8 5828.7 5835.6 5839.6 5845.4 5845.8 5358.8 5460.6 5476.6 5531.7 5546.8 5001.8 5066.7 5087.6 5094.3 5094.6 6000.8 6040.2 6043.3 6048.5 6049.2 5544.2 5791.9 5801.5 5806.4 5808.5 5979.1 6014.2 6036.8 6037.1 6101.0 5700.4 5703.7 5704.7 5721.1 5735.8 5592.7 5798.7 5804.3 5811.8 5815.3 5626.7 5655.0 5664.1 5727.3 5777.2 5668.2 5704.2 5712.6 5723.5 5724.8 5464.9 5624.5 5659.5 5663.7 5677.9 5668.1 5680.3 5710.6 5719.1 5786.0 5598.5 5603.1 5603.9 5604.5 5608.0 03:55:10 INFO - PROCESS | 2136 | 03:55:10 INFO - PROCESS | 2136 | [#1] ext.html Cycles:180 Average:68954.60 Median:21477.04 stddev:153699.49 (715.6%) stddev-sans-first:154044.86 03:55:10 INFO - PROCESS | 2136 | Values: 555.6 573.2 584.1 591.5 615.3 32043.5 35262.1 43502.6 44313.0 44360.3 46120.3 46971.3 47058.5 47082.8 47117.8 8825.3 8885.8 8893.3 8977.0 8985.1 8114.8 8848.3 10271.3 10507.6 10515.9 10801.3 10859.9 10866.8 10868.5 10870.1 10719.4 10786.4 10791.2 10827.4 10892.6 10727.2 10791.2 10799.6 10801.6 10810.7 43633.8 43787.8 43986.1 44006.1 44025.6 3678.7 3698.6 3713.4 3865.3 4289.4 33561.0 33746.8 33995.8 34612.5 34886.3 4128.7 4223.5 4294.4 4295.8 4447.4 369337.0 373061.0 374436.0 374603.0 376904.1 61766.7 62519.0 62589.4 62684.0 62739.0 37013.0 37639.8 37691.6 39450.6 39691.4 17389.5 17535.7 17548.3 17549.9 17556.9 12065.8 13374.3 13469.5 13472.7 13477.3 19315.9 19587.0 20177.3 20398.7 20481.2 7035.9 7182.6 7294.9 7415.9 7459.4 927.3 1023.9 1079.8 1116.1 1122.2 32845.8 32943.2 33164.9 33319.5 33569.2 1053.9 1087.5 1088.2 1147.9 1228.5 16407.6 17445.2 17660.0 17827.8 17885.4 588998.0 835601.0 856885.0 871219.0 871256.0 59275.4 59900.1 59967.7 66652.3 66918.3 1250.2 1357.4 1370.1 1436.1 1451.8 30488.2 34540.5 34827.3 34921.5 34975.5 52926.5 53161.5 53514.5 53543.0 53627.0 423300.0 427394.0 427921.0 428006.0 428551.0 37826.8 44214.0 45697.8 46864.3 47562.8 49945.5 50248.0 51030.7 52265.0 52273.7 39499.4 42249.0 42505.6 42588.6 44376.3 42092.8 42422.2 42456.8 43891.6 44122.1 41905.0 42127.0 42237.6 42418.8 43629.0 35922.6 38058.8 38267.0 38328.0 39088.8 28086.0 28389.4 28417.0 28524.0 28534.9 03:55:10 INFO - PROCESS | 2136 | 03:55:10 INFO - PROCESS | 2136 | [#2] jquery.html Cycles:180 Average:27833.29 Median:2169.65 stddev:77416.93 (3568.2%) stddev-sans-first:77606.70 03:55:10 INFO - PROCESS | 2136 | Values: 397.7 403.7 411.8 411.9 422.4 13265.8 18340.8 20004.7 20016.1 20991.9 18214.5 19027.6 19044.4 19676.5 19845.2 5084.5 5192.7 5203.1 5216.0 5229.1 3941.6 5151.4 5164.3 5199.4 5205.0 5672.4 5863.3 5927.7 5999.8 6000.2 5774.6 5870.1 5932.8 5940.9 5992.3 5749.5 5756.2 5757.4 5764.2 5764.7 14793.8 15748.5 22272.1 23433.6 23491.2 2332.5 2413.4 2806.1 2899.1 2935.5 10595.5 11123.7 11139.1 11182.5 13241.8 1740.7 1825.4 1852.7 1917.7 1937.5 81864.0 84454.6 86017.0 86251.6 86574.1 11186.6 11269.8 11288.2 11354.3 11589.4 15913.4 15926.0 15929.4 15935.7 15940.9 8076.7 8295.0 8521.4 8528.9 8536.4 7689.6 7730.4 7796.4 8056.0 8170.0 4544.9 4660.0 4711.5 4754.3 4947.0 1941.8 1952.0 1973.4 2018.9 2053.9 846.9 948.3 998.4 1009.6 1010.5 17778.2 19610.0 19620.1 19665.0 19994.3 970.8 985.1 1033.6 1034.2 1035.9 10387.1 10764.5 10854.2 10913.5 10920.9 454160.0 460062.0 465720.0 483864.0 487033.0 50640.5 67458.7 76933.8 79388.6 90274.0 962.4 966.7 987.9 990.5 991.8 16640.7 16846.4 17368.4 17397.0 17678.6 31003.8 39999.2 40469.2 41705.4 43317.6 55572.7 57825.0 58461.7 58887.1 58919.1 8109.6 8120.7 8195.5 8281.3 8799.7 12357.8 13369.7 13421.7 13477.0 13711.5 10727.6 11277.8 11342.5 11437.5 11626.7 11305.5 11419.0 11458.8 11502.9 11598.9 10870.6 11148.6 11338.7 11771.4 11983.9 7662.3 8113.1 8208.4 8287.4 8329.3 7705.5 10860.7 11341.1 11447.7 11509.8 03:55:10 INFO - PROCESS | 2136 | 03:55:10 INFO - PROCESS | 2136 | [#3] mootools.html Cycles:180 Average:6055.64 Median:2632.97 stddev:3497.95 (132.9%) stddev-sans-first:3489.97 03:55:10 INFO - PROCESS | 2136 | Values: 1361.4 1463.9 1479.6 1612.6 1774.7 8605.5 8993.1 9062.9 9308.5 9319.3 9028.3 9125.4 9131.0 9154.4 9199.8 2024.2 2329.9 2417.6 2442.9 2445.0 2458.0 2490.9 2522.9 2524.3 2527.8 2391.8 2395.0 2419.3 2426.9 2432.1 2318.6 2365.6 2386.8 2387.9 2406.3 2469.7 2471.1 2486.5 2491.4 2494.1 9163.8 9259.9 9312.4 9320.8 9322.9 5419.9 5553.0 5559.9 5564.6 5566.9 3435.1 3447.4 3478.8 3508.7 3533.5 1134.1 1140.5 1148.2 1158.7 1167.8 12830.3 13026.7 13084.1 13194.0 13283.3 4811.8 4865.8 4914.1 5014.8 5032.1 11248.4 11260.7 11260.9 11271.3 11276.0 5582.5 5583.1 5585.3 5591.2 5597.2 4354.6 4787.5 4881.2 5024.0 5112.9 4156.4 4256.8 4269.0 4324.8 4333.1 1352.1 1352.2 1373.4 1392.5 1409.2 882.4 931.3 957.5 991.2 1035.4 6219.8 6241.6 6243.8 6367.0 6455.8 468.1 475.0 477.8 478.4 482.7 4269.7 4363.4 4504.4 4605.3 4622.2 11181.7 11585.5 11625.7 11639.9 11663.4 10757.8 11191.5 11461.5 11463.7 11552.4 8029.8 8188.3 8239.0 8283.0 8285.8 6193.2 6258.2 6487.0 6538.8 6681.7 10583.5 10631.6 10668.3 10940.3 10983.5 10215.2 10700.7 10705.0 10757.8 10994.5 7382.3 7844.2 7930.0 8002.1 8178.6 8952.4 9103.5 9137.9 9141.9 9143.1 7786.4 7968.4 8100.0 8178.8 8235.2 7066.6 7442.8 7555.6 7647.5 7698.8 7113.1 7218.0 7242.3 7282.2 7285.7 5185.7 5202.9 5230.9 5286.2 5591.2 5166.8 5184.1 5213.0 5275.6 5443.8 03:55:10 INFO - PROCESS | 2136 | 03:55:10 INFO - PROCESS | 2136 | [#4] prototype.html Cycles:180 Average:4605.17 Median:5263.63 stddev:1337.20 (25.4%) stddev-sans-first:1301.86 03:55:10 INFO - PROCESS | 2136 | Values: 328.8 336.1 338.4 349.1 349.6 5144.3 5261.9 5315.8 5338.5 5358.2 5222.8 5223.8 5226.1 5238.2 5275.9 4209.8 4221.7 4223.3 4229.1 4270.8 3982.7 4148.1 4237.4 4238.6 4240.7 4128.2 4135.7 4140.5 4142.2 4154.2 4114.2 4124.2 4139.3 4157.3 4159.3 3638.5 3660.7 3669.9 3674.2 3688.4 5017.6 5063.9 5093.6 5094.8 5123.9 4634.6 4679.5 4680.3 4688.6 4689.0 5323.5 5424.5 5436.0 5437.4 5484.8 3892.4 3920.7 3942.5 3959.7 3962.5 5582.4 5620.3 5630.7 5648.5 5650.9 4044.4 4077.6 4082.8 4083.4 4089.6 3835.4 3990.4 4013.2 4018.0 4131.4 4567.4 4569.7 4571.3 4595.2 4598.2 5448.4 5483.0 5501.2 5530.6 5537.4 1339.8 1361.0 1396.1 1406.5 1414.3 915.2 933.5 956.7 964.4 967.5 5211.0 5217.2 5219.2 5227.2 5229.5 5442.3 5445.3 5463.8 5479.9 5488.6 5051.1 5156.4 5218.3 5220.2 5265.4 2889.3 2902.7 2909.9 2917.5 2934.6 5699.1 5709.8 5755.7 5795.7 5817.4 5540.3 5649.7 5673.8 5674.2 5681.4 5737.5 5741.3 5772.8 5792.4 5809.9 5345.7 5556.3 5568.5 5613.7 5630.5 5460.5 5474.6 5475.5 5566.9 5582.3 5749.5 5825.4 5826.3 5827.2 5829.2 3814.3 4031.3 4032.0 4065.3 4071.3 5330.1 5559.3 5566.3 5578.5 5591.0 5369.6 5398.9 5404.3 5408.6 5447.9 5387.1 5420.1 5423.9 5453.9 5480.8 5235.3 5366.9 5370.8 5389.8 5416.3 5439.5 5446.6 5467.4 5467.5 5474.4 5290.9 5350.4 5364.3 5397.4 5403.9 03:55:10 INFO - PROCESS | 2136 | 03:55:10 INFO - PROCESS | 2136 | [#5] yui.html Cycles:180 Average:21514.24 Median:4837.52 stddev:32499.77 (671.8%) stddev-sans-first:32553.21 03:55:10 INFO - PROCESS | 2136 | Values: 655.6 687.7 688.5 726.9 734.5 14056.0 14836.7 14955.6 14956.6 14982.2 13981.6 14534.4 14545.3 14561.0 14588.0 679.9 802.4 816.6 837.5 840.4 837.9 846.0 852.8 853.2 853.4 868.8 873.4 874.2 879.5 880.5 705.7 839.1 870.9 871.3 871.4 628.9 629.7 631.1 636.6 636.9 13918.2 14065.9 14067.5 14068.6 14087.3 12672.7 12988.0 13390.2 13439.2 13596.3 12126.9 12246.6 12549.1 12562.2 13314.4 3633.2 3712.6 3722.2 3729.0 3765.2 70693.6 72677.0 86530.0 86649.6 86825.0 11156.7 11383.0 11391.2 11552.1 11579.5 20520.5 21020.9 21103.7 21114.8 21137.4 7880.8 8314.8 8376.6 8525.6 8894.8 4651.8 4823.9 4842.6 4853.9 4951.6 3109.3 3225.6 3226.1 3229.9 3230.1 597.1 603.4 605.5 614.1 625.6 609.6 739.8 754.7 764.0 777.9 9506.2 9668.5 9681.3 9881.5 9912.2 585.0 721.2 734.1 753.4 762.3 4570.2 4644.9 4801.4 4832.4 4857.1 95820.0 126779.0 131432.0 133981.3 135126.0 101066.0 103194.0 103508.5 106059.0 109588.5 64100.7 73306.6 98265.0 99772.0 102872.5 8771.3 9079.6 9092.3 9251.6 9320.3 54991.5 57120.1 57635.3 57691.7 58814.4 80326.0 83026.0 84785.0 85484.0 88334.6 11797.4 11930.5 11982.9 12064.8 12213.4 13136.5 13481.5 13681.8 13728.5 14207.6 12144.4 12438.2 12486.8 12848.6 13311.5 12173.5 12349.9 12536.3 12629.8 12644.5 12186.5 12343.1 12657.0 12755.5 13061.8 9033.8 9663.4 9853.3 9963.9 10340.7 9658.8 10286.1 10328.3 10422.5 10486.6 03:55:10 INFO - PROCESS | 2136 | -------- Summary: end -------- 03:55:10 INFO - PROCESS | 2136 | 03:55:11 INFO - TEST-INFO | 2136: exit 0 03:55:11 INFO - TEST-OK | dromaeo_css | took 1116522ms 03:55:11 INFO - TEST-START | kraken 03:55:11 INFO - operating with platform_type : linux_ 03:55:11 INFO - Initialising browser for kraken test... 03:55:11 INFO - TEST-INFO | started process 2531 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp42GqUZ/profile http://localhost:42778/getInfo.html) 03:55:16 INFO - PROCESS | 2531 | __metrics Screen width/height:1600/1200 03:55:16 INFO - PROCESS | 2531 | colorDepth:24 03:55:16 INFO - PROCESS | 2531 | Browser inner width/height: 1024/697 03:55:16 INFO - PROCESS | 2531 | __metrics 03:55:16 INFO - PROCESS | 2531 | 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" 03:55:16 INFO - PROCESS | 2531 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:55:17 INFO - PROCESS | 2531 | console.error: PushService: 03:55:17 INFO - PROCESS | 2531 | stateChangeProcessEnqueue: Error transitioning state 03:55:17 INFO - PROCESS | 2531 | UnknownError 03:55:17 INFO - TEST-INFO | 2531: exit 0 03:55:17 INFO - Browser initialized. 03:55:17 INFO - Running cycle 1/1 for kraken test... 03:55:17 INFO - TEST-INFO | started process 2613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp42GqUZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:55:29 INFO - PROCESS | 2613 | RSS: Main: 180244480 03:55:29 INFO - PROCESS | 2613 | 03:55:32 INFO - PROCESS | 2613 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42778/tests/kraken/driver.html?testName=audio-beat-detection) 03:55:33 INFO - PROCESS | 2613 | RSS: Main: 242331648 03:55:33 INFO - PROCESS | 2613 | 03:55:35 INFO - PROCESS | 2613 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42778/tests/kraken/driver.html?testName=audio-dft) 03:55:36 INFO - PROCESS | 2613 | RSS: Main: 224165888 03:55:36 INFO - PROCESS | 2613 | 03:55:39 INFO - PROCESS | 2613 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42778/tests/kraken/driver.html?testName=audio-fft) 03:55:40 INFO - PROCESS | 2613 | RSS: Main: 302657536 03:55:40 INFO - PROCESS | 2613 | 03:55:42 INFO - PROCESS | 2613 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42778/tests/kraken/driver.html?testName=audio-oscillator) 03:55:43 INFO - PROCESS | 2613 | RSS: Main: 211075072 03:55:43 INFO - PROCESS | 2613 | 03:55:45 INFO - PROCESS | 2613 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42778/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:55:45 INFO - PROCESS | 2613 | RSS: Main: 213307392 03:55:45 INFO - PROCESS | 2613 | 03:55:48 INFO - PROCESS | 2613 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42778/tests/kraken/driver.html?testName=imaging-darkroom) 03:55:49 INFO - PROCESS | 2613 | RSS: Main: 251973632 03:55:49 INFO - PROCESS | 2613 | 03:55:53 INFO - PROCESS | 2613 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42778/tests/kraken/driver.html?testName=imaging-desaturate) 03:55:53 INFO - PROCESS | 2613 | RSS: Main: 251080704 03:55:53 INFO - PROCESS | 2613 | 03:55:56 INFO - PROCESS | 2613 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42778/tests/kraken/driver.html?testName=json-parse-financial) 03:55:57 INFO - PROCESS | 2613 | RSS: Main: 251097088 03:55:57 INFO - PROCESS | 2613 | 03:55:58 INFO - PROCESS | 2613 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42778/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:55:59 INFO - PROCESS | 2613 | RSS: Main: 214003712 03:55:59 INFO - PROCESS | 2613 | 03:56:01 INFO - PROCESS | 2613 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42778/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:56:01 INFO - PROCESS | 2613 | RSS: Main: 220114944 03:56:01 INFO - PROCESS | 2613 | 03:56:03 INFO - PROCESS | 2613 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42778/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:56:04 INFO - PROCESS | 2613 | RSS: Main: 222969856 03:56:04 INFO - PROCESS | 2613 | 03:56:07 INFO - PROCESS | 2613 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42778/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:56:07 INFO - PROCESS | 2613 | RSS: Main: 217174016 03:56:07 INFO - PROCESS | 2613 | 03:56:10 INFO - PROCESS | 2613 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42778/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:56:11 INFO - PROCESS | 2613 | RSS: Main: 220753920 03:56:11 INFO - PROCESS | 2613 | 03:56:12 INFO - PROCESS | 2613 | Cycle 1(1): loaded http://localhost:42778/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42778/tests/kraken/driver.html?testName=ai-astar) 03:56:13 INFO - PROCESS | 2613 | RSS: Main: 271425536 03:56:13 INFO - PROCESS | 2613 | 03:56:13 INFO - PROCESS | 2613 | __start_tp_report 03:56:13 INFO - PROCESS | 2613 | _x_x_mozilla_page_load 03:56:13 INFO - PROCESS | 2613 | _x_x_mozilla_page_load_details 03:56:13 INFO - PROCESS | 2613 | |i|pagename|runs| 03:56:13 INFO - PROCESS | 2613 | |0;ai-astar;114;113;126;111;110;111;111;110;111;112 03:56:13 INFO - PROCESS | 2613 | |1;audio-beat-detection;153;116;151;170;120;145;142;119;175;125 03:56:13 INFO - PROCESS | 2613 | |2;audio-dft;163;162;163;162;162;163;164;161;160;161 03:56:13 INFO - PROCESS | 2613 | |3;audio-fft;76;75;78;175;78;77;76;75;178;76 03:56:13 INFO - PROCESS | 2613 | |4;audio-oscillator;85;85;148;85;86;86;143;85;86;147 03:56:13 INFO - PROCESS | 2613 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;117 03:56:13 INFO - PROCESS | 2613 | |6;imaging-darkroom;145;146;147;147;148;146;146;145;146;146 03:56:13 INFO - PROCESS | 2613 | |7;imaging-desaturate;95;95;95;95;95;94;95;95;95;96 03:56:13 INFO - PROCESS | 2613 | |8;json-parse-financial;50;54;54;57;56;52;51;53;53;52 03:56:13 INFO - PROCESS | 2613 | |9;json-stringify-tinderbox;62;62;63;63;64;62;62;63;62;62 03:56:13 INFO - PROCESS | 2613 | |10;stanford-crypto-aes;77;81;78;79;80;78;77;78;78;79 03:56:13 INFO - PROCESS | 2613 | |11;stanford-crypto-ccm;125;122;119;124;137;123;123;133;153;123 03:56:13 INFO - PROCESS | 2613 | |12;stanford-crypto-pbkdf2;161;165;165;162;166;161;164;161;161;164 03:56:13 INFO - PROCESS | 2613 | |13;stanford-crypto-sha256-iterative;65;64;65;65;65;65;65;65;64;64 03:56:13 INFO - PROCESS | 2613 | __end_tp_report 03:56:13 INFO - PROCESS | 2613 | __start_cc_report 03:56:13 INFO - PROCESS | 2613 | _x_x_mozilla_cycle_collect,1676 03:56:13 INFO - PROCESS | 2613 | __end_cc_report 03:56:13 INFO - PROCESS | 2613 | __startTimestamp1472208973187__endTimestamp 03:56:13 INFO - PROCESS | 2613 | 03:56:13 INFO - PROCESS | 2613 | ------- Summary: start ------- 03:56:13 INFO - PROCESS | 2613 | Number of tests: 14 03:56:13 INFO - PROCESS | 2613 | 03:56:13 INFO - PROCESS | 2613 | [#0] ai-astar Cycles:10 Average:112.90 Median:111.50 stddev:4.77 (4.3%) stddev-sans-first:5.04 03:56:13 INFO - PROCESS | 2613 | Values: 114.0 113.0 126.0 111.0 110.0 111.0 111.0 110.0 111.0 112.0 03:56:13 INFO - PROCESS | 2613 | 03:56:13 INFO - PROCESS | 2613 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:148.00 stddev:21.24 (14.4%) stddev-sans-first:22.12 03:56:13 INFO - PROCESS | 2613 | Values: 153.0 116.0 151.0 170.0 120.0 145.0 142.0 119.0 175.0 125.0 03:56:13 INFO - PROCESS | 2613 | 03:56:13 INFO - PROCESS | 2613 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:1.20 (0.7%) stddev-sans-first:1.22 03:56:13 INFO - PROCESS | 2613 | Values: 163.0 162.0 163.0 162.0 162.0 163.0 164.0 161.0 160.0 161.0 03:56:13 INFO - PROCESS | 2613 | 03:56:13 INFO - PROCESS | 2613 | [#3] audio-fft Cycles:10 Average:96.40 Median:76.00 stddev:42.24 (55.6%) stddev-sans-first:44.15 03:56:13 INFO - PROCESS | 2613 | Values: 76.0 75.0 78.0 175.0 78.0 77.0 76.0 75.0 178.0 76.0 03:56:13 INFO - PROCESS | 2613 | 03:56:13 INFO - PROCESS | 2613 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:85.00 stddev:29.29 (34.5%) stddev-sans-first:30.28 03:56:13 INFO - PROCESS | 2613 | Values: 85.0 85.0 148.0 85.0 86.0 86.0 143.0 85.0 86.0 147.0 03:56:13 INFO - PROCESS | 2613 | 03:56:13 INFO - PROCESS | 2613 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:56:13 INFO - PROCESS | 2613 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 03:56:13 INFO - PROCESS | 2613 | 03:56:13 INFO - PROCESS | 2613 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 03:56:13 INFO - PROCESS | 2613 | Values: 145.0 146.0 147.0 147.0 148.0 146.0 146.0 145.0 146.0 146.0 03:56:13 INFO - PROCESS | 2613 | 03:56:13 INFO - PROCESS | 2613 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 03:56:13 INFO - PROCESS | 2613 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 96.0 03:56:13 INFO - PROCESS | 2613 | 03:56:13 INFO - PROCESS | 2613 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.50 stddev:2.15 (4.0%) stddev-sans-first:1.94 03:56:13 INFO - PROCESS | 2613 | Values: 50.0 54.0 54.0 57.0 56.0 52.0 51.0 53.0 53.0 52.0 03:56:13 INFO - PROCESS | 2613 | 03:56:13 INFO - PROCESS | 2613 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 03:56:13 INFO - PROCESS | 2613 | Values: 62.0 62.0 63.0 63.0 64.0 62.0 62.0 63.0 62.0 62.0 03:56:13 INFO - PROCESS | 2613 | 03:56:13 INFO - PROCESS | 2613 | [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:78.50 stddev:1.27 (1.6%) stddev-sans-first:1.22 03:56:13 INFO - PROCESS | 2613 | Values: 77.0 81.0 78.0 79.0 80.0 78.0 77.0 78.0 78.0 79.0 03:56:13 INFO - PROCESS | 2613 | 03:56:13 INFO - PROCESS | 2613 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:124.50 stddev:10.26 (8.2%) stddev-sans-first:10.82 03:56:13 INFO - PROCESS | 2613 | Values: 125.0 122.0 119.0 124.0 137.0 123.0 123.0 133.0 153.0 123.0 03:56:13 INFO - PROCESS | 2613 | 03:56:13 INFO - PROCESS | 2613 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.00 Median:164.00 stddev:2.00 (1.2%) stddev-sans-first:1.99 03:56:13 INFO - PROCESS | 2613 | Values: 161.0 165.0 165.0 162.0 166.0 161.0 164.0 161.0 161.0 164.0 03:56:13 INFO - PROCESS | 2613 | 03:56:13 INFO - PROCESS | 2613 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 03:56:13 INFO - PROCESS | 2613 | Values: 65.0 64.0 65.0 65.0 65.0 65.0 65.0 65.0 64.0 64.0 03:56:13 INFO - PROCESS | 2613 | -------- Summary: end -------- 03:56:13 INFO - PROCESS | 2613 | 03:56:14 INFO - TEST-INFO | 2613: exit 0 03:56:14 INFO - TEST-OK | kraken | took 62530ms 03:56:14 INFO - SUITE-END | took 1179s 03:56:14 INFO - Completed test suite (00:19:39) 03:56:14 INFO - javascript benchmark 03:56:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3063.2648164440543, 3067.263856674398, 3067.7852550321472, 3101.6122984626923, 3123.8438078096087, 5283.181106928432, 5325.121354976424, 5370.516653501189, 5460.262864513289, 5470.370907345651, 5433.266509021281, 5444.891102177954, 5445.727713614323, 5449.427810079944, 5485.177223416489, 4842.9515704843025, 4855.247436647325, 4882.877928051809, 4911.582515486188, 4928.310036594879, 4917.2869933859565, 4923.6077868198445, 5036.722980236085, 5044.974775126119, 5068.113080210948, 4913.656044076916, 4931.605471562267, 4971.552560269575, 4983.526564976321, 5014.2979982802435, 4781.330613714083, 4842.927356089662, 4848.806047758086, 4884.974155427364, 4887.193613053842, 4836.854894353175, 4861.659683822134, 4862.3922009748785, 4902.534259245366, 4959.851204463872, 5384.461553844584, 5425.430329815352, 5431.565474762009, 5470.99999999996, 5492.697901615409, 5676.858078548028, 5695.088785794294, 5751.511121554673, 5809.970950145223, 5819.6508209507565, 5752.194692743019, 5776.855578610526, 5812.128180772876, 5812.82561523155, 5867.794627188071, 5396.730163491809, 5403.5136837684795, 5407.3781515125875, 5408.215808707715, 5409.972950135224, 5734.05388110957, 5836.533077353802, 5843.590948633555, 5860.912086318709, 5890.0, 5674.06377947634, 5678.432156784371, 5679.204911312419, 5682.801101961411, 5736.311642602831, 5766.913496297559, 5778.797742079007, 5782.508486778587, 5786.508146807569, 5794.82615521535, 5553.611247212737, 5642.4075472075665, 5691.4877661010705, 5706.115552089433, 5709.68596727184, 5709.885802283931, 5710.885782284414, 5714.171445140431, 5717.970765262209, 5772.9711351442975, 4417.911641767147, 4452.799624016927, 4463.732176069446, 4471.754053527022, 4511.436070491189, 3884.4561761353434, 3949.289127956938, 3963.583823698528, 3993.341098718737, 4004.6796256299426, 5542.528885044736, 5554.86112847174, 5555.138953462219, 5611.410801865745, 5622.7750889963945, 5828.6502809831545, 5835.562332825055, 5839.620424672383, 5845.386234445407, 5845.824625261249, 5358.758855851496, 5460.6177567570685, 5476.644018138808, 5531.668099914018, 5546.77812887488, 5001.824936127218, 5066.721330326867, 5087.643864929493, 5094.261332106824, 5094.592432605383, 6000.849978750479, 6040.214772079689, 6043.335233124353, 6048.455638992512, 6049.18336024631, 5544.1960915667805, 5791.884162316645, 5801.477866991822, 5806.390329015392, 5808.477237048686, 5979.073243647242, 6014.1580178775885, 6036.788712395045, 6037.104998936558, 6101.0, 5700.372958974426, 5703.714814259188, 5704.714764261853, 5721.113227449752, 5735.827925162252, 5592.7203639817035, 5798.739056742541, 5804.2744656917885, 5811.82564523065, 5815.273090863642, 5626.746796394254, 5654.971725141348, 5664.0937450007805, 5727.31272247333, 5777.162311464898, 5668.178114173505, 5704.172894930129, 5712.571557133315, 5723.484886360247, 5724.79963201286, 5464.863378415413, 5624.521915637217, 5659.462351076641, 5663.716814159193, 5677.943220567907, 5668.0931051033285, 5680.346760122638, 5710.5717071219, 5719.056355701263, 5786.045302525036, 5598.524125449219, 5603.10350343943, 5603.859903502445, 5604.523615492566, 5608.046632072476], "value": 5339.937294211835, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.5664043429864, 573.1689050876231, 584.1383958660974, 591.52973386158, 615.2616859768276, 32043.51934720978, 35262.1184470388, 43502.56497435029, 44313.0, 44360.334594981105, 46120.308195377096, 46971.29543056857, 47058.529414705845, 47082.76458617711, 47117.76441117798, 8825.293976481882, 8885.822283554326, 8893.28853691703, 8977.0, 8985.101489851028, 8114.756557303291, 8848.336374771885, 10271.332363396356, 10507.63223287185, 10515.947420262926, 10801.297915635498, 10859.891401086006, 10866.836997445005, 10868.510917008754, 10870.076043536308, 10719.410432426213, 10786.352818830817, 10791.24461287714, 10827.350358978409, 10892.564297428173, 10727.249092563447, 10791.244612877103, 10799.5680172793, 10801.5679372825, 10810.729731756768, 43633.78183109096, 43787.78106109481, 43986.120277594586, 44006.11987760259, 44025.55974440279, 3678.668919797231, 3698.556173259199, 3713.405855063177, 3865.265599536079, 4289.356596510548, 33561.0, 33746.83126584376, 33995.83002084974, 34612.48081278783, 34886.302273954636, 4128.710990230685, 4223.514295855985, 4294.355846623001, 4295.763732994684, 4447.355133505656, 369337.0, 373061.0, 374436.0, 374603.0, 376904.1154794236, 61766.69116654388, 62519.0, 62589.37410625927, 62684.0, 62739.0, 37013.0, 37639.81180094137, 37691.62308376881, 39450.605493945266, 39691.40462893059, 17389.47831565055, 17535.736963945295, 17548.29806807739, 17549.912250438665, 17556.912215438842, 12065.758684826254, 13374.33128343579, 13469.528566500125, 13472.730545389037, 13477.326133693472, 19315.90342048281, 19586.96934256948, 20177.293794717407, 20398.69401958972, 20481.180752770022, 7035.92964070363, 7182.604956727326, 7294.927050729425, 7415.925840741524, 7459.403247740168, 927.3230541704594, 1023.923205759571, 1079.8491196990312, 1116.1405717597404, 1122.1639878290725, 32845.835770820995, 32943.188124652894, 33164.85439320085, 33319.50020749691, 33569.16077098043, 1053.89461053894, 1087.532361084741, 1088.2001728729379, 1147.9081673466103, 1228.502456505117, 16407.5898102546, 17445.214965326337, 17660.0, 17827.821721782875, 17885.37401190952, 588998.0, 835601.0, 856885.0, 871219.0, 871256.0, 59275.40724592699, 59900.10149847756, 59967.70016149891, 66652.33347666558, 66918.33081669218, 1250.249850089957, 1357.429879450633, 1370.1299674706634, 1436.0880840666252, 1451.7604595241878, 30488.237794055327, 34540.481892771124, 34827.303453930275, 34921.47617785684, 34975.475367868996, 52926.470735292154, 53161.46838531565, 53514.46485535095, 53543.0, 53627.0, 423300.0, 427394.0, 427921.0, 428006.0, 428551.0, 37826.810865946594, 44214.0, 45697.77151114356, 46864.297035545176, 47562.76218618885, 49945.500544995535, 50248.0, 51030.74484627553, 52265.0, 52273.7386313066, 39499.40750888796, 42249.0, 42505.5749442514, 42588.57411425846, 44376.33435498406, 42092.78953605212, 42422.15155696807, 42456.78771606122, 43891.56108439002, 44122.11755764931, 41905.0, 42127.0, 42237.57762422336, 42418.78790606151, 43629.0, 35922.64077359193, 38058.809705951295, 38267.0, 38328.0, 39088.80455597704, 28086.0, 28389.43221135607, 28417.0, 28524.0, 28534.857325713238], "value": 21250.47881764951, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.7394806401808, 403.68373809157765, 411.78792921645356, 411.9217348703745, 422.3727764270058, 13265.801012984788, 18340.81659183408, 20004.69992950105, 20016.0992755326, 20991.895040524814, 18214.544636384097, 19027.61944761104, 19044.428667139975, 19676.508087297825, 19845.206191752313, 5084.51697088776, 5192.740362981855, 5203.089459344618, 5215.973920130394, 5229.08491014071, 3941.566427692966, 5151.4333423323405, 5164.251183578379, 5199.376074871021, 5205.0, 5672.376038635747, 5863.325717542494, 5927.703614819264, 5999.820005399845, 6000.189974353472, 5774.624649397776, 5870.090136028923, 5932.822015339547, 5940.910886336686, 5992.310884248323, 5749.482546570829, 5756.194132821408, 5757.395473475267, 5764.221830052973, 5764.711764411804, 14793.778093328609, 15748.527544173694, 22272.109115635354, 23433.648495272413, 23491.17780877661, 2332.5101728637005, 2413.3725231439953, 2806.0880213930554, 2899.0578062129894, 2935.544990526472, 10595.523201455953, 11123.666290011313, 11139.108871290277, 11182.496787644575, 13241.801372979413, 1740.6953783088036, 1825.3702472646914, 1852.740616313717, 1917.664408728467, 1937.476881242071, 81864.0, 84454.57772711097, 86017.0, 86251.56874215651, 86574.13425865787, 11186.608468703556, 11269.830952535718, 11288.209825312313, 11354.26197297173, 11589.362585057903, 15913.363465461483, 15926.0, 15929.36282548685, 15935.681286374207, 15940.92029539845, 8076.676932922617, 8295.0, 8521.360897932556, 8528.872066919, 8536.402451828437, 7689.577073261024, 7730.420218483636, 7796.415268854858, 8056.0, 8170.0, 4544.909101817945, 4660.0, 4711.45818230901, 4754.334393184957, 4946.950530494721, 1941.825235728763, 1951.9902400487906, 1973.3783858084657, 2018.9394318170478, 2053.9408744204356, 846.8856704344835, 948.307735353196, 998.4009594243396, 1009.5911155981839, 1010.4745532323298, 17778.199981000886, 19610.0, 19620.117094730773, 19665.0, 19994.30019949324, 970.7864269860619, 985.1478471122427, 1033.5762337441613, 1034.1984961654778, 1035.891231420705, 10387.117095047006, 10764.515596798163, 10854.18593605467, 10913.508892099875, 10920.945395273131, 454160.0, 460062.0, 465720.0, 483864.0, 487033.0, 50640.49359506431, 67458.66270668615, 76933.84599231016, 79388.60305698434, 90274.0, 962.4177372689562, 966.7341481092756, 987.9061489158519, 990.5294984882267, 991.8115558043949, 16640.667186655955, 16846.410375636795, 17368.39210627622, 17397.0, 17678.646427071642, 31003.844980774953, 39999.2000160001, 40469.1906161881, 41705.37441938313, 43317.566824331356, 55572.72213638906, 57825.0, 58461.70769146127, 58887.11669325049, 58919.11621325598, 8109.635066421907, 8120.715774947848, 8195.549244791593, 8281.254687078192, 8799.736007919773, 12357.814632780335, 13369.66575835573, 13421.731565368442, 13477.0, 13711.520096796565, 10727.570897164025, 11277.830832537355, 11342.489587968395, 11437.485313160762, 11626.651200463999, 11305.547778088785, 11419.0, 11458.828117578076, 11502.94248528752, 11598.94200528992, 10870.565177392815, 11148.554057837595, 11338.659840204808, 11771.411429428666, 11983.880161198276, 7662.272084151997, 8113.148119447373, 8208.384371172067, 8287.419880608299, 8329.33413317351, 7705.537667739954, 10860.67417977462, 11341.092712583139, 11447.656570302905, 11509.769804604028], "value": 9073.552945699474, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.3669643615717, 1463.948761793337, 1479.563528759016, 1612.6210340569971, 1774.6805574996495, 8605.483670979746, 8993.055729148444, 9062.912450505948, 9308.48803315819, 9319.347645664806, 9028.322875784326, 9125.406848554856, 9131.0, 9154.359194856363, 9199.77000574986, 2024.1599736109497, 2329.9301020969315, 2417.637354396841, 2442.8778561071963, 2445.0464318915638, 2457.950840983179, 2490.9003639854386, 2522.9116980905674, 2524.3436706456364, 2527.75986281303, 2391.80865530758, 2394.976050239493, 2419.2984034629935, 2426.8543887366727, 2432.1244352033254, 2318.5594737000083, 2365.5860224460735, 2386.7613238675995, 2387.928362149147, 2406.290144407404, 2469.6665950096685, 2471.0733474946896, 2486.527559763639, 2491.4145175883655, 2494.0896572751, 9163.770905727344, 9259.861102083474, 9312.394694344914, 9320.766980825465, 9322.86015709765, 5419.918701219485, 5552.972235138839, 5559.8888022239325, 5564.554835613141, 5566.888662226774, 3435.1412146963257, 3447.3622379859808, 3478.7912725236315, 3508.736844736655, 3533.522974398449, 1134.1323887226279, 1140.4924808460155, 1148.236422778851, 1158.6871544682972, 1167.824826276057, 12830.294333811637, 13026.739465210738, 13084.08411411192, 13194.0, 13283.335833208397, 4811.7834697438, 4865.829695960624, 4914.115459217375, 5014.774335154927, 5032.094223039888, 11248.437578121062, 11260.718482038015, 11260.94369528147, 11271.267367621078, 11276.0, 5582.49757521825, 5583.0787919992745, 5585.273914391103, 5591.189277554732, 5597.216389705444, 4354.629856462173, 4787.54518320759, 4881.170201065827, 5024.045431368028, 5112.923306150411, 4156.397322388237, 4256.8297268109545, 4268.978655106766, 4324.762138082373, 4333.133373325284, 1352.134633834347, 1352.1819299323963, 1373.368250604713, 1392.526540976073, 1409.1545072956144, 882.3955590420583, 931.3247895276006, 957.4973139101888, 991.2020823237219, 1035.3994683083793, 6219.751209951642, 6241.625502469867, 6243.8126856194385, 6366.9681651591445, 6455.806325810139, 468.12227074235807, 474.964377671676, 477.76111944027986, 478.394830539368, 482.68866581055727, 4269.701120921506, 4363.36731173978, 4504.436945381827, 4605.332226827091, 4622.168009758208, 11181.720456988478, 11585.536578536932, 11625.709357265967, 11639.883601164049, 11663.416829158508, 10757.784844303227, 11191.496382662799, 11461.54153833854, 11463.656090317303, 11552.422378881023, 8029.839403211903, 8188.344932405394, 8239.0, 8283.0, 8285.751427457186, 6193.225846769154, 6258.155149054819, 6487.0, 6538.803835884931, 6681.732730690913, 10583.4708264588, 10631.574737010433, 10668.253222274676, 10940.343579385262, 10983.505742241778, 10215.23385746087, 10700.678979630624, 10705.0, 10757.784844302914, 10994.505247263733, 7382.26177382279, 7844.21557844211, 7929.960350198212, 8002.079760827346, 8178.631961561625, 8952.418092823946, 9103.453792772454, 9137.908620913706, 9141.908580914373, 9143.13140251675, 7786.4160187985, 7968.362530997622, 8100.0279966404405, 8178.83642327162, 8235.21765432283, 7066.57600543969, 7442.813929651802, 7555.622218889143, 7647.502912310682, 7698.846023079619, 7113.0753002109395, 7218.0, 7242.275772422716, 7282.198958114497, 7285.672144753605, 5185.688858668492, 5202.947970520247, 5230.895382092261, 5286.180642000496, 5591.161325801162, 5166.793328266827, 5184.118699821115, 5213.035588416155, 5275.604329675367, 5443.809466668806], "value": 4745.313627618342, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.80002287304495, 336.0992539992819, 338.37766707397316, 349.10454683736197, 349.6451102131337, 5144.279800827887, 5261.8947621047655, 5315.760790764415, 5338.5462235709965, 5358.249845021695, 5222.764975576099, 5223.791048358071, 5226.144718624881, 5238.240455134003, 5275.920861187085, 4209.768462734548, 4221.683373746966, 4223.282042052859, 4229.133027729324, 4270.829166833323, 3982.721209515335, 4148.108156746299, 4237.364395340693, 4238.554951730071, 4240.681948853833, 4128.2362762888815, 4135.710500264982, 4140.461739973799, 4142.17156568686, 4154.189932963073, 4114.177164567083, 4124.154548317588, 4139.254934111858, 4157.3140431828715, 4159.292920203573, 3638.5088013118157, 3660.7254455915645, 3669.853205871762, 3674.1549443627846, 3688.4098544232793, 5017.623678224148, 5063.8987220255385, 5093.592512598983, 5094.821681241138, 5123.948760512421, 4634.582887540138, 4679.4618618858585, 4680.251159814447, 4688.624910007191, 4688.953110468886, 5323.494268044529, 5424.457554244584, 5436.048691478975, 5437.429069947678, 5484.8354549363585, 3892.4161375793574, 3920.6863450923856, 3942.4874766280486, 3959.7030222733124, 3962.5046869141356, 5582.358028826697, 5620.269364982526, 5630.690312032836, 5648.491635752802, 5650.898074875401, 4044.4135600338373, 4077.5922407758985, 4082.755034697928, 4083.4079058536345, 4089.591040895946, 3835.386338185877, 3990.4213888986515, 4013.2174226026227, 4018.0, 4131.421600975866, 4567.36056952027, 4569.702969306984, 4571.262920090345, 4595.241785105487, 4598.218302888517, 5448.400675925645, 5483.013057649661, 5501.174823776466, 5530.6128570999645, 5537.36320323168, 1339.8124262603244, 1361.0268657909642, 1396.1483495068, 1406.4866323791741, 1414.2575148047151, 915.1809130827871, 933.5390114470831, 956.7273327101742, 964.4165280005636, 967.4533888353058, 5210.973945130326, 5217.191335343028, 5219.243209734567, 5227.163653815372, 5229.50319719626, 5442.319710036246, 5445.346558413015, 5463.754131064112, 5479.863003424866, 5488.615796894179, 5051.146102452103, 5156.432792392834, 5218.347706536683, 5220.1647736362, 5265.368155821326, 2889.277680579855, 2902.6661933877454, 2909.88360465579, 2917.4602698500844, 2934.559816027613, 5699.116636921284, 5709.8287051388525, 5755.7122143893475, 5795.681237531892, 5817.44734250254, 5540.252065971123, 5649.745761440745, 5673.77304907799, 5674.205611214434, 5681.38656218136, 5737.540996720169, 5741.253637027244, 5772.769089236467, 5792.4497172768515, 5809.896119737321, 5345.732713364238, 5556.305461817273, 5568.526675232651, 5613.719314034363, 5630.549556035426, 5460.535854452416, 5474.589405794661, 5475.479829416199, 5566.942280966603, 5582.27430434041, 5749.540036796962, 5825.446582574818, 5826.300843898759, 5827.184194212899, 5829.213056237523, 3814.294355544233, 4031.2945234583244, 4031.9798401007806, 4065.329220678555, 4071.328230841878, 5330.147176451749, 5559.27729395176, 5566.304211973504, 5578.497935185853, 5590.972045139748, 5369.570434365163, 5398.9190162146815, 5404.270423492778, 5408.5673146149, 5447.945520544902, 5387.138057910872, 5420.127332513774, 5423.945760542502, 5453.863653408696, 5480.780768769205, 5235.267062611314, 5366.892662146814, 5370.758315875873, 5389.75746091419, 5416.322959630046, 5439.456054394529, 5446.564274857923, 5467.425920278472, 5467.4532546745, 5474.425185355481, 5290.8941821164135, 5350.411454739898, 5364.329458817648, 5397.3523177218985, 5403.86490337729], "value": 4181.911419762203, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.6164643683445, 687.6974131382192, 688.538679085013, 726.912770467544, 734.5152199548297, 14056.0, 14836.703265934675, 14955.626109347244, 14956.626084347883, 14982.175980321077, 13981.580552583413, 14534.418623255056, 14545.345459454324, 14561.0, 14588.0, 679.894616334469, 802.4182467710892, 816.60802814649, 837.5226121110969, 840.4285086141422, 837.924586787189, 845.9619317130744, 852.8038551133243, 853.2235665544356, 853.3770347646222, 868.8262347530488, 873.3580818098692, 874.2481465939287, 879.5470332778624, 880.5201165364891, 705.6612825843624, 839.1147339556766, 870.8737233101197, 871.3160169267159, 871.3551971541077, 628.9182406287199, 629.7292164369319, 631.059721015688, 636.6466611030876, 636.9076483909854, 13918.234497102656, 14065.859341406558, 14067.507637232648, 14068.577942661737, 14087.295635218301, 12672.6831829205, 12988.0, 13390.196588204739, 13439.193648381128, 13596.252206128658, 12126.878731212752, 12246.632601021984, 12549.1215614907, 12562.246265224116, 13314.400851961685, 3633.218857945528, 3712.554493460775, 3722.1997270586953, 3728.9627103728885, 3765.152840610868, 70693.64653176753, 72677.0, 86530.0, 86649.56675216583, 86824.99999999937, 11156.721081972853, 11383.0, 11391.202615816814, 11552.075833933266, 11579.478923448296, 20520.486987825127, 21020.894895525424, 21103.68344474834, 21114.78885211159, 21137.365879023655, 7880.84238315242, 8314.750557483285, 8376.623051962677, 8525.57372131391, 8894.777630559158, 4651.790669419885, 4823.898467195619, 4842.612590992712, 4853.927191092136, 4951.579115775199, 3109.2537790930014, 3225.6290526589273, 3226.080567038383, 3229.870805167767, 3230.144011836865, 597.1460811040167, 603.3966033966034, 605.5428151745404, 614.115673430259, 625.5996162456032, 609.6435431165621, 739.7595781371076, 754.7320701151123, 763.9541627502367, 777.8755399136111, 9506.152535023892, 9668.51241026254, 9681.273904457194, 9881.456519891331, 9912.15746661542, 584.9532037436995, 721.1922646635802, 734.110374138712, 753.4161025205509, 762.268222506389, 4570.159082794467, 4644.883877903079, 4801.399825021872, 4832.420109586802, 4857.149998750205, 95820.0, 126779.0, 131432.0, 133981.33009334892, 135126.0, 101066.0, 103194.0, 103508.48245758723, 106059.0, 109588.4520577408, 64100.67949660222, 73306.63346683233, 98265.0, 99771.99999999854, 102872.48563757133, 8771.298296136167, 9079.636814527345, 9092.318076144184, 9251.583678734607, 9320.254379649476, 54991.45008550023, 57120.143197851234, 57635.25370850881, 57691.71154144371, 58814.41185588261, 80326.0, 83026.0, 84785.0, 85484.0, 88334.55832720795, 11797.410129493663, 11930.522779088738, 11982.880171198525, 12064.75870482603, 12213.389330533615, 13136.540221092217, 13481.460741570227, 13681.79477307861, 13728.519501817787, 14207.64480887986, 12144.392780361124, 12438.19151755133, 12486.819854769865, 12848.550300739429, 13311.534096306583, 12173.452194651085, 12349.93825030869, 12536.310502922426, 12629.81055284153, 12644.494220231456, 12186.512539498675, 12343.13598048128, 12657.0, 12755.48978040905, 13061.804072939103, 9033.77415564616, 9663.371880827724, 9853.310268281151, 9963.850542241727, 10340.741481462723, 9658.75853103678, 10286.125679317043, 10328.277020608486, 10422.478876056319, 10486.580536778443], "value": 7443.382373275987, "unit": "score"}], "name": "dromaeo_css", "value": 7306.171063179196, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 126.0, 111.0, 110.0, 111.0, 111.0, 110.0, 111.0, 112.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 116.0, 151.0, 170.0, 120.0, 145.0, 142.0, 119.0, 175.0, 125.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 162.0, 162.0, 163.0, 164.0, 161.0, 160.0, 161.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 78.0, 175.0, 78.0, 77.0, 76.0, 75.0, 178.0, 76.0], "value": 96.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 148.0, 85.0, 86.0, 86.0, 143.0, 85.0, 86.0, 147.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 147.0, 147.0, 148.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 54.0, 54.0, 57.0, 56.0, 52.0, 51.0, 53.0, 53.0, 52.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 63.0, 64.0, 62.0, 62.0, 63.0, 62.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 81.0, 78.0, 79.0, 80.0, 78.0, 77.0, 78.0, 78.0, 79.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 122.0, 119.0, 124.0, 137.0, 123.0, 123.0, 133.0, 153.0, 123.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 165.0, 165.0, 162.0, 166.0, 161.0, 164.0, 161.0, 161.0, 164.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 64.0], "value": 64.7, "unit": "score"}], "name": "kraken", "value": 1524.8000000000002, "alertThreshold": 2.0}]} 03:56:14 INFO - Return code: 0 03:56:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:56:14 INFO - # TBPL SUCCESS # 03:56:14 INFO - Running post-action listener: _resource_record_post_action 03:56:14 INFO - [mozharness: 2016-08-26 10:56:14.969020Z] Finished run-tests step (success) 03:56:14 INFO - Running post-run listener: _resource_record_post_run 03:56:15 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 406581248; Read time: 16; Write time: 282712 03:56:15 INFO - TinderboxPrint: CPU usage
13.3% 03:56:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 03:56:15 INFO - TinderboxPrint: I/O write bytes / time
406,581,248 / 282,712 03:56:15 INFO - TinderboxPrint: CPU idle
8,283.3 (86.7%) 03:56:15 INFO - TinderboxPrint: CPU user
1,201.4 (12.6%) 03:56:15 INFO - TinderboxPrint: Swap in / out
0 / 0 03:56:15 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 117387264; Read time: 0; Write time: 80352 03:56:15 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288231424; Read time: 0; Write time: 202336 03:56:15 INFO - Running post-run listener: _upload_blobber_files 03:56:15 INFO - Blob upload gear active. 03:56:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:56:15 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 03:56:15 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:56:15 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:56:15 INFO - (blobuploader) - INFO - Open directory for files ... 03:56:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:56:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:56:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:56:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:56:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:56:17 INFO - (blobuploader) - INFO - Done attempting. 03:56:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:56:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:56:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:56:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:56:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:56:21 INFO - (blobuploader) - INFO - Done attempting. 03:56:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:56:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:56:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:56:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:56:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:56:22 INFO - (blobuploader) - INFO - Done attempting. 03:56:22 INFO - (blobuploader) - INFO - Iteration through files over. 03:56:22 INFO - Return code: 0 03:56:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:56:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:56:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e9cbba89dc13d7c362ab2f7da43ec2b0e28c17857fd068ab2f8b7912d3ea1daa0d5306ce6c475f457553f2423b357d9eebbcdf67c1a6b8ed3ccafd05efe7839", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f08a176d0af4b357dfdf94598bc4d61996a3f494ad746a1b77c29fbed61f37d44b2e282914f2080fd663455cd9c95738210f6aec3406080b9561477d369e748d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/706ac12dcb5be1362a277402d13ad755463c4d2d01e7b7bea89658b68ca9197bbebc3bc3ffb70b46b0a0e2ec2a3294c21319cb8980987ab60bd361c1c99edd1e"} 03:56:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:56:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:56:22 INFO - Contents: 03:56:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e9cbba89dc13d7c362ab2f7da43ec2b0e28c17857fd068ab2f8b7912d3ea1daa0d5306ce6c475f457553f2423b357d9eebbcdf67c1a6b8ed3ccafd05efe7839", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f08a176d0af4b357dfdf94598bc4d61996a3f494ad746a1b77c29fbed61f37d44b2e282914f2080fd663455cd9c95738210f6aec3406080b9561477d369e748d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/706ac12dcb5be1362a277402d13ad755463c4d2d01e7b7bea89658b68ca9197bbebc3bc3ffb70b46b0a0e2ec2a3294c21319cb8980987ab60bd361c1c99edd1e"} 03:56:22 INFO - Running post-run listener: copy_logs_to_upload_dir 03:56:22 INFO - Copying logs to upload dir... 03:56:22 INFO - mkdir: /builds/slave/test/build/upload/logs 03:56:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.373362 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-26 03:56:22.060681) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 03:56:22.064137) ========= 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=6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428 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/sha512/1e9cbba89dc13d7c362ab2f7da43ec2b0e28c17857fd068ab2f8b7912d3ea1daa0d5306ce6c475f457553f2423b357d9eebbcdf67c1a6b8ed3ccafd05efe7839", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f08a176d0af4b357dfdf94598bc4d61996a3f494ad746a1b77c29fbed61f37d44b2e282914f2080fd663455cd9c95738210f6aec3406080b9561477d369e748d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/706ac12dcb5be1362a277402d13ad755463c4d2d01e7b7bea89658b68ca9197bbebc3bc3ffb70b46b0a0e2ec2a3294c21319cb8980987ab60bd361c1c99edd1e"} build_url:https://queue.taskcluster.net/v1/task/O44f-lOSQ2KnBFVTrdFA_g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011271 build_url: 'https://queue.taskcluster.net/v1/task/O44f-lOSQ2KnBFVTrdFA_g/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/sha512/1e9cbba89dc13d7c362ab2f7da43ec2b0e28c17857fd068ab2f8b7912d3ea1daa0d5306ce6c475f457553f2423b357d9eebbcdf67c1a6b8ed3ccafd05efe7839", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f08a176d0af4b357dfdf94598bc4d61996a3f494ad746a1b77c29fbed61f37d44b2e282914f2080fd663455cd9c95738210f6aec3406080b9561477d369e748d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/706ac12dcb5be1362a277402d13ad755463c4d2d01e7b7bea89658b68ca9197bbebc3bc3ffb70b46b0a0e2ec2a3294c21319cb8980987ab60bd361c1c99edd1e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 03:56:22.089622) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 03:56:22.089952) ========= 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=6dbc10da6d83fee962c624be000001a8-1472207738.904145-492150428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 03:56:22.175462) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 03:56:22.175779) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 03:56:22.176066) ========= ========= Total master_lag: 0.16 =========