builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1470388839.82 results: success (0) buildid: 20160805002454 builduid: 78b296ce1c82438c8e4c5e7569e8da66 revision: a32b3e3c6b34 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 02:20:39.815742) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 02:20:39.816218) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-08-05 02:20:39.816537) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-08-05 02:20:41.593504) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 02:20:41.593806) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-05 02:20:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 96.0M=0s 2016-08-05 02:20:43 (96.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085914 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 02:20:41.699808) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 02:20:41.700217) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015954 ========= master_lag: 0.29 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 02:20:42.003630) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 02:20:42.003979) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a32b3e3c6b34 --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 a32b3e3c6b34 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-05 02:20:43,660 Setting DEBUG logging. 2016-08-05 02:20:43,660 attempt 1/10 2016-08-05 02:20:43,660 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a32b3e3c6b34?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 02:20:43,980 unpacking tar archive at: fx-team-a32b3e3c6b34/testing/mozharness/ program finished with exit code 0 elapsedTime=0.666658 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 02:20:42.690465) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 02:20:42.690830) ========= script_repo_revision: a32b3e3c6b34 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 02:20:42.691273) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 02:20:42.691700) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 02:20:42.704812) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-08-05 02:20:42.705151) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:20:44 INFO - MultiFileLogger online at 20160805 02:20:44 in /builds/slave/test 02:20:44 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 02:20:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:20:44 INFO - {'append_to_log': False, 02:20:44 INFO - 'base_work_dir': '/builds/slave/test', 02:20:44 INFO - 'blob_upload_branch': 'Fx-Team', 02:20:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:20:44 INFO - 'branch': 'Fx-Team', 02:20:44 INFO - 'buildbot_json_path': 'buildprops.json', 02:20:44 INFO - 'config_files': ('talos/linux_config.py',), 02:20:44 INFO - 'default_actions': ('clobber', 02:20:44 INFO - 'read-buildbot-config', 02:20:44 INFO - 'download-and-extract', 02:20:44 INFO - 'populate-webroot', 02:20:44 INFO - 'create-virtualenv', 02:20:44 INFO - 'install', 02:20:44 INFO - 'run-tests'), 02:20:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:20:44 INFO - 'download_minidump_stackwalk': True, 02:20:44 INFO - 'download_symbols': 'ondemand', 02:20:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:20:44 INFO - 'tooltool.py': '/tools/tooltool.py', 02:20:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:20:44 INFO - '/tools/misc-python/virtualenv.py')}, 02:20:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:20:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:20:44 INFO - 'installer_path': 'installer.exe', 02:20:44 INFO - 'log_level': 'info', 02:20:44 INFO - 'log_name': 'talos', 02:20:44 INFO - 'log_to_console': True, 02:20:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:20:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:20:44 INFO - 'opt_config_files': (), 02:20:44 INFO - 'pip_index': False, 02:20:44 INFO - 'sps_profile': False, 02:20:44 INFO - 'sps_profile_interval': 0, 02:20:44 INFO - 'suite': 'dromaeojs', 02:20:44 INFO - 'system_bits': '32', 02:20:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:20:44 INFO - 'title': 'talos-linux64-ix-068', 02:20:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:20:44 INFO - 'use_talos_json': True, 02:20:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:20:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:20:44 INFO - 'work_dir': 'build'} 02:20:44 INFO - [mozharness: 2016-08-05 09:20:44.453970Z] Running clobber step. 02:20:44 INFO - Running pre-action listener: _resource_record_pre_action 02:20:44 INFO - Running main action method: clobber 02:20:44 INFO - rmtree: /builds/slave/test/build 02:20:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:20:44 INFO - Running post-action listener: _resource_record_post_action 02:20:44 INFO - [mozharness: 2016-08-05 09:20:44.914292Z] Finished clobber step (success) 02:20:44 INFO - [mozharness: 2016-08-05 09:20:44.914396Z] Running read-buildbot-config step. 02:20:44 INFO - Running pre-action listener: _resource_record_pre_action 02:20:44 INFO - Running main action method: read_buildbot_config 02:20:44 INFO - Using buildbot properties: 02:20:44 INFO - { 02:20:44 INFO - "project": "", 02:20:44 INFO - "product": "firefox", 02:20:44 INFO - "script_repo_revision": "production", 02:20:44 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:20:44 INFO - "repository": "", 02:20:44 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:20:44 INFO - "buildid": "20160805002454", 02:20:44 INFO - "pgo_build": "True", 02:20:44 INFO - "basedir": "/builds/slave/test", 02:20:44 INFO - "buildnumber": 338, 02:20:44 INFO - "slavename": "talos-linux64-ix-068", 02:20:44 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:20:44 INFO - "platform": "ubuntu64_hw", 02:20:44 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:20:44 INFO - "branch": "fx-team", 02:20:44 INFO - "repo_path": "integration/fx-team", 02:20:44 INFO - "revision": "a32b3e3c6b34", 02:20:44 INFO - "stage_platform": "linux64-pgo", 02:20:44 INFO - "builduid": "78b296ce1c82438c8e4c5e7569e8da66", 02:20:44 INFO - "slavebuilddir": "test" 02:20:44 INFO - } 02:20:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/NSLAre5IQraplH4aSYX9rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 02:20:44 INFO - Running post-action listener: _resource_record_post_action 02:20:44 INFO - [mozharness: 2016-08-05 09:20:44.916865Z] Finished read-buildbot-config step (success) 02:20:44 INFO - [mozharness: 2016-08-05 09:20:44.916955Z] Running download-and-extract step. 02:20:44 INFO - Running pre-action listener: _resource_record_pre_action 02:20:44 INFO - Running main action method: download_and_extract 02:20:44 INFO - mkdir: /builds/slave/test/build/tests 02:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:44 INFO - trying https://queue.taskcluster.net/v1/task/NSLAre5IQraplH4aSYX9rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:20:44 INFO - Downloading https://queue.taskcluster.net/v1/task/NSLAre5IQraplH4aSYX9rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:20:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NSLAre5IQraplH4aSYX9rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:20:45 INFO - Downloaded 1361 bytes. 02:20:45 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:20:45 INFO - Using the following test package requirements: 02:20:45 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:20:45 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:45 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:20:45 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:45 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:20:45 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:45 INFO - u'jsshell-linux-x86_64.zip'], 02:20:45 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:45 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:20:45 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:20:45 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:45 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:20:45 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:45 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:20:45 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:45 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:20:45 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:45 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:20:45 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:45 INFO - trying https://queue.taskcluster.net/v1/task/NSLAre5IQraplH4aSYX9rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:20:45 INFO - Downloading https://queue.taskcluster.net/v1/task/NSLAre5IQraplH4aSYX9rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:20:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NSLAre5IQraplH4aSYX9rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:20:46 INFO - Downloaded 21820805 bytes. 02:20:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:20:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:20:47 INFO - Return code: 0 02:20: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 02:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:47 INFO - trying https://queue.taskcluster.net/v1/task/NSLAre5IQraplH4aSYX9rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:20:47 INFO - Downloading https://queue.taskcluster.net/v1/task/NSLAre5IQraplH4aSYX9rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:20:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NSLAre5IQraplH4aSYX9rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:20:48 INFO - Downloaded 21820805 bytes. 02:20:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:20:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:20:49 INFO - Return code: 0 02:20:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:49 INFO - trying https://queue.taskcluster.net/v1/task/NSLAre5IQraplH4aSYX9rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 02:20:49 INFO - Downloading https://queue.taskcluster.net/v1/task/NSLAre5IQraplH4aSYX9rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 02:20:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NSLAre5IQraplH4aSYX9rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:20:50 INFO - Downloaded 14413723 bytes. 02:20:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:20:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:20:50 INFO - Return code: 0 02:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:50 INFO - trying https://queue.taskcluster.net/v1/task/NSLAre5IQraplH4aSYX9rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:20:50 INFO - Downloading https://queue.taskcluster.net/v1/task/NSLAre5IQraplH4aSYX9rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:20:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NSLAre5IQraplH4aSYX9rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:20:52 INFO - Downloaded 59342870 bytes. 02:20:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NSLAre5IQraplH4aSYX9rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:20:52 INFO - mkdir: /builds/slave/test/properties 02:20:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:20:52 INFO - Writing to file /builds/slave/test/properties/build_url 02:20:52 INFO - Contents: 02:20:52 INFO - build_url:https://queue.taskcluster.net/v1/task/NSLAre5IQraplH4aSYX9rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:20:52 INFO - Running post-action listener: _resource_record_post_action 02:20:52 INFO - Running post-action listener: set_extra_try_arguments 02:20:52 INFO - [mozharness: 2016-08-05 09:20:52.935376Z] Finished download-and-extract step (success) 02:20:52 INFO - [mozharness: 2016-08-05 09:20:52.935612Z] Running populate-webroot step. 02:20:52 INFO - Running pre-action listener: _resource_record_pre_action 02:20:52 INFO - Running main action method: populate_webroot 02:20:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:20:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:20:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:20:52 INFO - '--tppagecycles', 02:20:52 INFO - '7'], 02:20:52 INFO - 'tests': ['tsvgm']}}, 02:20:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:20:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:20:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:20:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:20:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:20:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:20:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:52 INFO - 'talos_options': ['--disable-e10s'], 02:20:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:20:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:20:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:52 INFO - 'talos_options': ['--disable-e10s'], 02:20:52 INFO - 'tests': ['damp', 'tps']}, 02:20:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:52 INFO - 'tests': ['damp', 'tps']}, 02:20:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:20:52 INFO - 'tests': ['dromaeo_dom']}, 02:20:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:20:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:20:52 INFO - 'tests': ['basic_compositor_video']}, 02:20:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:20:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:20:52 INFO - 'tests': ['a11yr', 02:20:52 INFO - 'ts_paint', 02:20:52 INFO - 'tpaint', 02:20:52 INFO - 'sessionrestore', 02:20:52 INFO - 'sessionrestore_no_auto_restore', 02:20:52 INFO - 'tabpaint']}, 02:20:52 INFO - 'other-e10s': {'tests': ['a11yr', 02:20:52 INFO - 'ts_paint', 02:20:52 INFO - 'tpaint', 02:20:52 INFO - 'sessionrestore', 02:20:52 INFO - 'sessionrestore_no_auto_restore', 02:20:52 INFO - 'tabpaint']}, 02:20:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:20:52 INFO - 'ts_paint', 02:20:52 INFO - 'tpaint', 02:20:52 INFO - 'sessionrestore', 02:20:52 INFO - 'sessionrestore_no_auto_restore', 02:20:52 INFO - 'tabpaint']}, 02:20:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:20:52 INFO - 'ts_paint', 02:20:52 INFO - 'tpaint', 02:20:52 INFO - 'sessionrestore', 02:20:52 INFO - 'sessionrestore_no_auto_restore', 02:20:52 INFO - 'tabpaint']}, 02:20:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:20:52 INFO - 'tests': ['a11yr', 02:20:52 INFO - 'ts_paint', 02:20:52 INFO - 'tpaint', 02:20:52 INFO - 'sessionrestore', 02:20:52 INFO - 'sessionrestore_no_auto_restore', 02:20:52 INFO - 'tabpaint']}, 02:20:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:20:52 INFO - 'tests': ['a11yr', 02:20:52 INFO - 'ts_paint', 02:20:52 INFO - 'tpaint', 02:20:52 INFO - 'sessionrestore', 02:20:52 INFO - 'sessionrestore_no_auto_restore', 02:20:52 INFO - 'tabpaint']}, 02:20:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:20:52 INFO - 'tests': ['tsvgx', 02:20:52 INFO - 'tsvgr_opacity', 02:20:52 INFO - 'tart', 02:20:52 INFO - 'tscrollx', 02:20:52 INFO - 'cart']}, 02:20:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:20:52 INFO - 'tsvgr_opacity', 02:20:52 INFO - 'tart', 02:20:52 INFO - 'tscrollx', 02:20:52 INFO - 'cart']}, 02:20:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:52 INFO - 'talos_options': ['--disable-e10s'], 02:20:52 INFO - 'tests': ['tp5o']}, 02:20:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:52 INFO - 'tests': ['tp5o']}, 02:20:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:52 INFO - 'talos_options': ['--disable-e10s', 02:20:52 INFO - '--xperf_path', 02:20:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:20:52 INFO - 'tests': ['tp5n']}, 02:20:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:52 INFO - 'talos_options': ['--xperf_path', 02:20:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:20:52 INFO - 'tests': ['tp5n']}}, 02:20:52 INFO - 'talos.zip': {'path': '', 02:20:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:20:52 INFO - Running post-action listener: _resource_record_post_action 02:20:52 INFO - [mozharness: 2016-08-05 09:20:52.957734Z] Finished populate-webroot step (success) 02:20:52 INFO - [mozharness: 2016-08-05 09:20:52.957825Z] Running create-virtualenv step. 02:20:52 INFO - Running pre-action listener: _resource_record_pre_action 02:20:52 INFO - Running main action method: create_virtualenv 02:20:52 INFO - Creating virtualenv /builds/slave/test/build/venv 02:20:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:20:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:20:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:20:53 INFO - Using real prefix '/usr' 02:20:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:20:53 INFO - Installing distribute.............................................................................................................................................................................................done. 02:20:55 INFO - Installing pip.................done. 02:20:55 INFO - Return code: 0 02:20:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dc3b0>, '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 0x15dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:20:55 INFO - Using env: {'DISPLAY': ':0', 02:20:55 INFO - 'HOME': '/home/cltbld', 02:20:55 INFO - 'LANG': 'en_US.UTF-8', 02:20:55 INFO - 'LANGUAGE': 'en_US:en', 02:20:55 INFO - 'LOGNAME': 'cltbld', 02:20:55 INFO - 'MAIL': '/var/mail/cltbld', 02:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:55 INFO - 'MOZ_NO_REMOTE': '1', 02:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:55 INFO - 'NO_EM_RESTART': '1', 02:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:55 INFO - 'PWD': '/builds/slave/test', 02:20:55 INFO - 'SHELL': '/bin/bash', 02:20:55 INFO - 'SHLVL': '1', 02:20:55 INFO - 'TERM': 'linux', 02:20:55 INFO - 'TMOUT': '86400', 02:20:55 INFO - 'USER': 'cltbld', 02:20:55 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996', 02:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:55 INFO - '_': '/tools/buildbot/bin/python'} 02:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:20:55 INFO - Cleaning up... 02:20:55 INFO - Return code: 0 02:20:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x131d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dc3b0>, '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 0x15dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:20:55 INFO - Using env: {'DISPLAY': ':0', 02:20:55 INFO - 'HOME': '/home/cltbld', 02:20:55 INFO - 'LANG': 'en_US.UTF-8', 02:20:55 INFO - 'LANGUAGE': 'en_US:en', 02:20:55 INFO - 'LOGNAME': 'cltbld', 02:20:55 INFO - 'MAIL': '/var/mail/cltbld', 02:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:55 INFO - 'MOZ_NO_REMOTE': '1', 02:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:55 INFO - 'NO_EM_RESTART': '1', 02:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:55 INFO - 'PWD': '/builds/slave/test', 02:20:55 INFO - 'SHELL': '/bin/bash', 02:20:55 INFO - 'SHLVL': '1', 02:20:55 INFO - 'TERM': 'linux', 02:20:55 INFO - 'TMOUT': '86400', 02:20:55 INFO - 'USER': 'cltbld', 02:20:55 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996', 02:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:55 INFO - '_': '/tools/buildbot/bin/python'} 02:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:55 INFO - Downloading/unpacking psutil>=3.1.1 02:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:20:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:20:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:20:57 INFO - Installing collected packages: psutil 02:20:57 INFO - Running setup.py install for psutil 02:20:58 INFO - building 'psutil._psutil_linux' extension 02:20:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:20:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:20:58 INFO - building 'psutil._psutil_posix' extension 02:20:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:20:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:20:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:20:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:20:58 INFO - Successfully installed psutil 02:20:58 INFO - Cleaning up... 02:20:58 INFO - Return code: 0 02:20:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:20: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')]} 02:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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')]} 02:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dc3b0>, '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 0x15dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:20: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 mozsystemmonitor==0.3 02:20:58 INFO - Using env: {'DISPLAY': ':0', 02:20:58 INFO - 'HOME': '/home/cltbld', 02:20:58 INFO - 'LANG': 'en_US.UTF-8', 02:20:58 INFO - 'LANGUAGE': 'en_US:en', 02:20:58 INFO - 'LOGNAME': 'cltbld', 02:20:58 INFO - 'MAIL': '/var/mail/cltbld', 02:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:58 INFO - 'MOZ_NO_REMOTE': '1', 02:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:58 INFO - 'NO_EM_RESTART': '1', 02:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:58 INFO - 'PWD': '/builds/slave/test', 02:20:58 INFO - 'SHELL': '/bin/bash', 02:20:58 INFO - 'SHLVL': '1', 02:20:58 INFO - 'TERM': 'linux', 02:20:58 INFO - 'TMOUT': '86400', 02:20:58 INFO - 'USER': 'cltbld', 02:20:58 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996', 02:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:58 INFO - '_': '/tools/buildbot/bin/python'} 02:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:21:00 INFO - Installing collected packages: mozsystemmonitor 02:21:00 INFO - Running setup.py install for mozsystemmonitor 02:21:00 INFO - Successfully installed mozsystemmonitor 02:21:00 INFO - Cleaning up... 02:21:00 INFO - Return code: 0 02:21:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:00 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 0x131d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dc3b0>, '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 0x15dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:21:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:21:00 INFO - Using env: {'DISPLAY': ':0', 02:21:00 INFO - 'HOME': '/home/cltbld', 02:21:00 INFO - 'LANG': 'en_US.UTF-8', 02:21:00 INFO - 'LANGUAGE': 'en_US:en', 02:21:00 INFO - 'LOGNAME': 'cltbld', 02:21:00 INFO - 'MAIL': '/var/mail/cltbld', 02:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:00 INFO - 'MOZ_NO_REMOTE': '1', 02:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:00 INFO - 'NO_EM_RESTART': '1', 02:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:00 INFO - 'PWD': '/builds/slave/test', 02:21:00 INFO - 'SHELL': '/bin/bash', 02:21:00 INFO - 'SHLVL': '1', 02:21:00 INFO - 'TERM': 'linux', 02:21:00 INFO - 'TMOUT': '86400', 02:21:00 INFO - 'USER': 'cltbld', 02:21:00 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996', 02:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:00 INFO - '_': '/tools/buildbot/bin/python'} 02:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:01 INFO - Downloading/unpacking jsonschema==2.5.1 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:21:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:03 INFO - Downloading functools32-3.2.3-2.tar.gz 02:21:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:21:03 INFO - warning: no files found matching '*.txt' 02:21:03 INFO - no previously-included directories found matching 'build' 02:21:03 INFO - no previously-included directories found matching 'dist' 02:21:03 INFO - no previously-included directories found matching '.git*' 02:21:03 INFO - Installing collected packages: jsonschema, functools32 02:21:03 INFO - Running setup.py install for functools32 02:21:03 INFO - warning: no files found matching '*.txt' 02:21:03 INFO - no previously-included directories found matching 'build' 02:21:03 INFO - no previously-included directories found matching 'dist' 02:21:03 INFO - no previously-included directories found matching '.git*' 02:21:03 INFO - Successfully installed jsonschema functools32 02:21:03 INFO - Cleaning up... 02:21:03 INFO - Return code: 0 02:21:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:03 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 0x131d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dc3b0>, '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 0x15dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:21:03 INFO - Using env: {'DISPLAY': ':0', 02:21:03 INFO - 'HOME': '/home/cltbld', 02:21:03 INFO - 'LANG': 'en_US.UTF-8', 02:21:03 INFO - 'LANGUAGE': 'en_US:en', 02:21:03 INFO - 'LOGNAME': 'cltbld', 02:21:03 INFO - 'MAIL': '/var/mail/cltbld', 02:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:03 INFO - 'MOZ_NO_REMOTE': '1', 02:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:03 INFO - 'NO_EM_RESTART': '1', 02:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:03 INFO - 'PWD': '/builds/slave/test', 02:21:03 INFO - 'SHELL': '/bin/bash', 02:21:03 INFO - 'SHLVL': '1', 02:21:03 INFO - 'TERM': 'linux', 02:21:03 INFO - 'TMOUT': '86400', 02:21:03 INFO - 'USER': 'cltbld', 02:21:03 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996', 02:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:03 INFO - '_': '/tools/buildbot/bin/python'} 02:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:21:03 INFO - Cleaning up... 02:21:03 INFO - Return code: 0 02:21:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:03 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 0x131d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dc3b0>, '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 0x15dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:21:03 INFO - Using env: {'DISPLAY': ':0', 02:21:03 INFO - 'HOME': '/home/cltbld', 02:21:03 INFO - 'LANG': 'en_US.UTF-8', 02:21:03 INFO - 'LANGUAGE': 'en_US:en', 02:21:03 INFO - 'LOGNAME': 'cltbld', 02:21:03 INFO - 'MAIL': '/var/mail/cltbld', 02:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:03 INFO - 'MOZ_NO_REMOTE': '1', 02:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:03 INFO - 'NO_EM_RESTART': '1', 02:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:03 INFO - 'PWD': '/builds/slave/test', 02:21:03 INFO - 'SHELL': '/bin/bash', 02:21:03 INFO - 'SHLVL': '1', 02:21:03 INFO - 'TERM': 'linux', 02:21:03 INFO - 'TMOUT': '86400', 02:21:03 INFO - 'USER': 'cltbld', 02:21:03 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996', 02:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:03 INFO - '_': '/tools/buildbot/bin/python'} 02:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:03 INFO - Downloading/unpacking blobuploader==1.2.4 02:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:05 INFO - Downloading blobuploader-1.2.4.tar.gz 02:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:21:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:21:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21:06 INFO - Downloading docopt-0.6.1.tar.gz 02:21:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:21:06 INFO - Installing collected packages: blobuploader, requests, docopt 02:21:06 INFO - Running setup.py install for blobuploader 02:21:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:21:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:21:06 INFO - Running setup.py install for requests 02:21:06 INFO - Running setup.py install for docopt 02:21:07 INFO - Successfully installed blobuploader requests docopt 02:21:07 INFO - Cleaning up... 02:21:07 INFO - Return code: 0 02:21:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:07 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 0x131d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dc3b0>, '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 0x15dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:21:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:21:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:21:07 INFO - Using env: {'DISPLAY': ':0', 02:21:07 INFO - 'HOME': '/home/cltbld', 02:21:07 INFO - 'LANG': 'en_US.UTF-8', 02:21:07 INFO - 'LANGUAGE': 'en_US:en', 02:21:07 INFO - 'LOGNAME': 'cltbld', 02:21:07 INFO - 'MAIL': '/var/mail/cltbld', 02:21:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:07 INFO - 'MOZ_NO_REMOTE': '1', 02:21:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:07 INFO - 'NO_EM_RESTART': '1', 02:21:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:07 INFO - 'PWD': '/builds/slave/test', 02:21:07 INFO - 'SHELL': '/bin/bash', 02:21:07 INFO - 'SHLVL': '1', 02:21:07 INFO - 'TERM': 'linux', 02:21:07 INFO - 'TMOUT': '86400', 02:21:07 INFO - 'USER': 'cltbld', 02:21:07 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996', 02:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:07 INFO - '_': '/tools/buildbot/bin/python'} 02:21:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:21:07 INFO - Running setup.py (path:/tmp/pip-bQu71b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:21:07 INFO - Running setup.py (path:/tmp/pip-0RTQM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:21:07 INFO - Running setup.py (path:/tmp/pip-wfdBCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:21:07 INFO - Running setup.py (path:/tmp/pip-0rS3BI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:21:07 INFO - Running setup.py (path:/tmp/pip-dAS4j1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:21:07 INFO - Running setup.py (path:/tmp/pip-DLbkrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:21:07 INFO - Running setup.py (path:/tmp/pip-5TV_iu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:21:07 INFO - Running setup.py (path:/tmp/pip-Cn2Qpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:21:07 INFO - Running setup.py (path:/tmp/pip-ZsHotr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:21:07 INFO - Running setup.py (path:/tmp/pip-ncHoAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:21:08 INFO - Running setup.py (path:/tmp/pip-CEKsC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:21:08 INFO - Running setup.py (path:/tmp/pip-wYXhjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:21:08 INFO - Running setup.py (path:/tmp/pip-I7W4wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:21:08 INFO - Running setup.py (path:/tmp/pip-fBrDrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:08 INFO - Running setup.py (path:/tmp/pip-7Y3qNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:21:08 INFO - Running setup.py (path:/tmp/pip-0TWIj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:21:08 INFO - Running setup.py (path:/tmp/pip-Aj1e8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:21:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:21:08 INFO - Running setup.py install for manifestparser 02:21:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:21:08 INFO - Running setup.py install for mozcrash 02:21:08 INFO - Running setup.py install for mozdebug 02:21:08 INFO - Running setup.py install for mozdevice 02:21:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:21:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:21:08 INFO - Running setup.py install for mozfile 02:21:09 INFO - Running setup.py install for mozhttpd 02:21:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:21:09 INFO - Running setup.py install for mozinfo 02:21:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:21:09 INFO - Running setup.py install for mozInstall 02:21:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:21:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:21:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:21:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:21:09 INFO - Running setup.py install for mozleak 02:21:09 INFO - Running setup.py install for mozlog 02:21:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:21:09 INFO - Running setup.py install for moznetwork 02:21:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:21:09 INFO - Running setup.py install for mozprocess 02:21:09 INFO - Running setup.py install for mozprofile 02:21:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:21:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:21:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:21:09 INFO - Running setup.py install for mozrunner 02:21:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:21:10 INFO - Running setup.py install for mozscreenshot 02:21:10 INFO - Running setup.py install for moztest 02:21:10 INFO - Running setup.py install for mozversion 02:21:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:21:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:21:10 INFO - Cleaning up... 02:21:10 INFO - Return code: 0 02:21:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:21: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')]} 02:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21: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')]} 02:21:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:10 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 0x131d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dc3b0>, '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 0x15dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:21:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:21:10 INFO - Using env: {'DISPLAY': ':0', 02:21:10 INFO - 'HOME': '/home/cltbld', 02:21:10 INFO - 'LANG': 'en_US.UTF-8', 02:21:10 INFO - 'LANGUAGE': 'en_US:en', 02:21:10 INFO - 'LOGNAME': 'cltbld', 02:21:10 INFO - 'MAIL': '/var/mail/cltbld', 02:21:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:10 INFO - 'MOZ_NO_REMOTE': '1', 02:21:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:10 INFO - 'NO_EM_RESTART': '1', 02:21:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:10 INFO - 'PWD': '/builds/slave/test', 02:21:10 INFO - 'SHELL': '/bin/bash', 02:21:10 INFO - 'SHLVL': '1', 02:21:10 INFO - 'TERM': 'linux', 02:21:10 INFO - 'TMOUT': '86400', 02:21:10 INFO - 'USER': 'cltbld', 02:21:10 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996', 02:21:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:10 INFO - '_': '/tools/buildbot/bin/python'} 02:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:21:10 INFO - Running setup.py (path:/tmp/pip-32TBwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:21:10 INFO - Running setup.py (path:/tmp/pip-QPU327-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:21:10 INFO - Running setup.py (path:/tmp/pip-tBayNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:21:10 INFO - Running setup.py (path:/tmp/pip-_aRVrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:21:10 INFO - Running setup.py (path:/tmp/pip-__lUrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:21:10 INFO - Running setup.py (path:/tmp/pip-78GMTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:21:11 INFO - Running setup.py (path:/tmp/pip-4ps2k2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:21:11 INFO - Running setup.py (path:/tmp/pip-Xpevt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:21:11 INFO - Running setup.py (path:/tmp/pip-DWzdZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:21:11 INFO - Running setup.py (path:/tmp/pip-6AIrDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:21:11 INFO - Running setup.py (path:/tmp/pip-W37Rfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:21:11 INFO - Running setup.py (path:/tmp/pip-ftGMmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:21:11 INFO - Running setup.py (path:/tmp/pip-KBed4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:21:11 INFO - Running setup.py (path:/tmp/pip-3ZEZsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:11 INFO - Running setup.py (path:/tmp/pip-dMvZ0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:21:11 INFO - Running setup.py (path:/tmp/pip-MhzAxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:21:11 INFO - Running setup.py (path:/tmp/pip-h90zJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:21:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:13 INFO - Downloading blessings-1.6.tar.gz 02:21:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:21:13 INFO - Installing collected packages: blessings 02:21:13 INFO - Running setup.py install for blessings 02:21:13 INFO - Successfully installed blessings 02:21:13 INFO - Cleaning up... 02:21:13 INFO - Return code: 0 02:21:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:21:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:21:14 INFO - Reading from file tmpfile_stdout 02:21:14 INFO - Current package versions: 02:21:14 INFO - argparse == 1.2.1 02:21:14 INFO - blessings == 1.6 02:21:14 INFO - blobuploader == 1.2.4 02:21:14 INFO - docopt == 0.6.1 02:21:14 INFO - functools32 == 3.2.3-2 02:21:14 INFO - jsonschema == 2.5.1 02:21:14 INFO - manifestparser == 1.1 02:21:14 INFO - mozInstall == 1.12 02:21:14 INFO - mozcrash == 0.17 02:21:14 INFO - mozdebug == 0.1 02:21:14 INFO - mozdevice == 0.48 02:21:14 INFO - mozfile == 1.2 02:21:14 INFO - mozhttpd == 0.7 02:21:14 INFO - mozinfo == 0.9 02:21:14 INFO - mozleak == 0.1 02:21:14 INFO - mozlog == 3.3 02:21:14 INFO - moznetwork == 0.27 02:21:14 INFO - mozprocess == 0.23 02:21:14 INFO - mozprofile == 0.28 02:21:14 INFO - mozrunner == 6.12 02:21:14 INFO - mozscreenshot == 0.1 02:21:14 INFO - mozsystemmonitor == 0.3 02:21:14 INFO - moztest == 0.7 02:21:14 INFO - mozversion == 1.4 02:21:14 INFO - psutil == 3.1.1 02:21:14 INFO - requests == 1.2.3 02:21:14 INFO - wsgiref == 0.1.2 02:21:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:14 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 0x131d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dc3b0>, '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 0x15dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:21:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:21:14 INFO - Using env: {'DISPLAY': ':0', 02:21:14 INFO - 'HOME': '/home/cltbld', 02:21:14 INFO - 'LANG': 'en_US.UTF-8', 02:21:14 INFO - 'LANGUAGE': 'en_US:en', 02:21:14 INFO - 'LOGNAME': 'cltbld', 02:21:14 INFO - 'MAIL': '/var/mail/cltbld', 02:21:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:14 INFO - 'MOZ_NO_REMOTE': '1', 02:21:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:14 INFO - 'NO_EM_RESTART': '1', 02:21:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:14 INFO - 'PWD': '/builds/slave/test', 02:21:14 INFO - 'SHELL': '/bin/bash', 02:21:14 INFO - 'SHLVL': '1', 02:21:14 INFO - 'TERM': 'linux', 02:21:14 INFO - 'TMOUT': '86400', 02:21:14 INFO - 'USER': 'cltbld', 02:21:14 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996', 02:21:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:14 INFO - '_': '/tools/buildbot/bin/python'} 02:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:21:14 INFO - Cleaning up... 02:21:14 INFO - Return code: 0 02:21:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:14 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 0x131d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dc3b0>, '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 0x15dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:21:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:21:14 INFO - Using env: {'DISPLAY': ':0', 02:21:14 INFO - 'HOME': '/home/cltbld', 02:21:14 INFO - 'LANG': 'en_US.UTF-8', 02:21:14 INFO - 'LANGUAGE': 'en_US:en', 02:21:14 INFO - 'LOGNAME': 'cltbld', 02:21:14 INFO - 'MAIL': '/var/mail/cltbld', 02:21:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:14 INFO - 'MOZ_NO_REMOTE': '1', 02:21:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:14 INFO - 'NO_EM_RESTART': '1', 02:21:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:14 INFO - 'PWD': '/builds/slave/test', 02:21:14 INFO - 'SHELL': '/bin/bash', 02:21:14 INFO - 'SHLVL': '1', 02:21:14 INFO - 'TERM': 'linux', 02:21:14 INFO - 'TMOUT': '86400', 02:21:14 INFO - 'USER': 'cltbld', 02:21:14 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996', 02:21:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:14 INFO - '_': '/tools/buildbot/bin/python'} 02:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:21:14 INFO - Cleaning up... 02:21:14 INFO - Return code: 0 02:21:14 INFO - Running post-action listener: _resource_record_post_action 02:21:14 INFO - Running post-action listener: _start_resource_monitoring 02:21:14 INFO - Starting resource monitoring. 02:21:14 INFO - [mozharness: 2016-08-05 09:21:14.682251Z] Finished create-virtualenv step (success) 02:21:14 INFO - [mozharness: 2016-08-05 09:21:14.682697Z] Running install step. 02:21:14 INFO - Running pre-action listener: _resource_record_pre_action 02:21:14 INFO - Running main action method: install 02:21:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:21:14 INFO - Reading from file tmpfile_stdout 02:21:14 INFO - Detecting whether we're running mozinstall >=1.0... 02:21:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:21:14 INFO - Reading from file tmpfile_stdout 02:21:14 INFO - Output received: 02:21:14 INFO - Usage: mozinstall [options] installer 02:21:14 INFO - Options: 02:21:14 INFO - -h, --help show this help message and exit 02:21:14 INFO - -d DEST, --destination=DEST 02:21:14 INFO - Directory to install application into. [default: 02:21:14 INFO - "/builds/slave/test"] 02:21:14 INFO - --app=APP Application being installed. [default: firefox] 02:21:14 INFO - mkdir: /builds/slave/test/build/application 02:21:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:21:32 INFO - Reading from file tmpfile_stdout 02:21:32 INFO - Output received: 02:21:32 INFO - /builds/slave/test/build/application/firefox/firefox 02:21:32 INFO - Running post-action listener: _resource_record_post_action 02:21:32 INFO - [mozharness: 2016-08-05 09:21:32.649374Z] Finished install step (success) 02:21:32 INFO - [mozharness: 2016-08-05 09:21:32.649679Z] Running run-tests step. 02:21:32 INFO - Running pre-action listener: _resource_record_pre_action 02:21:32 INFO - Running main action method: run_tests 02:21:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:21:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:21:32 INFO - Python 2.7.3 02:21:32 INFO - Return code: 0 02:21:32 INFO - grabbing minidump binary from tooltool 02:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:32 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 0x15dc3b0>, '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 0x15dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:21:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:21:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:21:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:21:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:21:32 INFO - Return code: 0 02:21:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:21:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:21:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:21:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:21:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:21:32 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/NSLAre5IQraplH4aSYX9rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:21:32 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/NSLAre5IQraplH4aSYX9rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:21:32 INFO - Using env: {'DISPLAY': ':0', 02:21:32 INFO - 'HOME': '/home/cltbld', 02:21:32 INFO - 'LANG': 'en_US.UTF-8', 02:21:32 INFO - 'LANGUAGE': 'en_US:en', 02:21:32 INFO - 'LOGNAME': 'cltbld', 02:21:32 INFO - 'MAIL': '/var/mail/cltbld', 02:21:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:21:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:32 INFO - 'MOZ_NO_REMOTE': '1', 02:21:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:32 INFO - 'NO_EM_RESTART': '1', 02:21:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:32 INFO - 'PWD': '/builds/slave/test', 02:21:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:21:32 INFO - 'SHELL': '/bin/bash', 02:21:32 INFO - 'SHLVL': '1', 02:21:32 INFO - 'TERM': 'linux', 02:21:32 INFO - 'TMOUT': '86400', 02:21:32 INFO - 'USER': 'cltbld', 02:21:32 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996', 02:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:32 INFO - '_': '/tools/buildbot/bin/python'} 02:21:32 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/NSLAre5IQraplH4aSYX9rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:21:32 INFO - mozversion application_buildid: 20160805002454 02:21:32 INFO - mozversion application_changeset: a32b3e3c6b34d28e5e1d4f484f0fa6ef74a458cd 02:21:32 INFO - mozversion application_display_name: Nightly 02:21:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:21:32 INFO - mozversion application_name: Firefox 02:21:32 INFO - mozversion application_remotingname: firefox 02:21:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:21:32 INFO - mozversion application_vendor: Mozilla 02:21:32 INFO - mozversion application_version: 51.0a1 02:21:32 INFO - mozversion platform_buildid: 20160805002454 02:21:32 INFO - mozversion platform_changeset: a32b3e3c6b34d28e5e1d4f484f0fa6ef74a458cd 02:21:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:21:32 INFO - mozversion platform_version: 51.0a1 02:21:32 INFO - using testdate: 1470388892 02:21:32 INFO - actual date: 1470388892 02:21:32 INFO - starting webserver on 'localhost:33779' 02:21:32 INFO - SUITE-START | Running 2 tests 02:21:32 INFO - TEST-START | dromaeo_css 02:21:32 INFO - operating with platform_type : linux_ 02:21:32 INFO - Initialising browser for dromaeo_css test... 02:21:32 INFO - TEST-INFO | started process 28757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2Bj0Cu/profile http://localhost:33779/getInfo.html) 02:21:37 INFO - PROCESS | 28757 | __metrics Screen width/height:1600/1200 02:21:37 INFO - PROCESS | 28757 | colorDepth:24 02:21:37 INFO - PROCESS | 28757 | Browser inner width/height: 1024/697 02:21:37 INFO - PROCESS | 28757 | __metrics 02:21:37 INFO - PROCESS | 28757 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:21:37 INFO - PROCESS | 28757 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:21:38 INFO - TEST-INFO | 28757: exit 0 02:21:38 INFO - Browser initialized. 02:21:38 INFO - Running cycle 1/1 for dromaeo_css test... 02:21:38 INFO - TEST-INFO | started process 28837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2Bj0Cu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:21:50 INFO - PROCESS | 28837 | RSS: Main: 156508160 02:21:50 INFO - PROCESS | 28837 | 02:22:42 INFO - PROCESS | 28837 | 1470388962254 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:24:51 INFO - PROCESS | 28837 | Cycle 1(1): loaded http://localhost:33779/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33779/tests/dromaeo/cssquery-ext.html) 02:24:52 INFO - PROCESS | 28837 | RSS: Main: 285024256 02:24:52 INFO - PROCESS | 28837 | 02:27:55 INFO - PROCESS | 28837 | Cycle 1(1): loaded http://localhost:33779/tests/dromaeo/cssquery-ext.html (next: http://localhost:33779/tests/dromaeo/cssquery-jquery.html) 02:27:55 INFO - PROCESS | 28837 | RSS: Main: 250216448 02:27:55 INFO - PROCESS | 28837 | 02:30:57 INFO - PROCESS | 28837 | Cycle 1(1): loaded http://localhost:33779/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33779/tests/dromaeo/cssquery-mootools.html) 02:30:58 INFO - PROCESS | 28837 | RSS: Main: 219389952 02:30:58 INFO - PROCESS | 28837 | 02:34:00 INFO - PROCESS | 28837 | Cycle 1(1): loaded http://localhost:33779/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33779/tests/dromaeo/cssquery-prototype.html) 02:34:00 INFO - PROCESS | 28837 | RSS: Main: 200994816 02:34:00 INFO - PROCESS | 28837 | 02:37:03 INFO - PROCESS | 28837 | Cycle 1(1): loaded http://localhost:33779/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33779/tests/dromaeo/cssquery-yui.html) 02:37:04 INFO - PROCESS | 28837 | RSS: Main: 184348672 02:37:04 INFO - PROCESS | 28837 | 02:40:06 INFO - PROCESS | 28837 | Cycle 1(1): loaded http://localhost:33779/tests/dromaeo/cssquery-yui.html (next: http://localhost:33779/tests/dromaeo/cssquery-dojo.html) 02:40:07 INFO - PROCESS | 28837 | RSS: Main: 275288064 02:40:07 INFO - PROCESS | 28837 | 02:40:07 INFO - PROCESS | 28837 | __start_tp_report 02:40:07 INFO - PROCESS | 28837 | _x_x_mozilla_page_load 02:40:07 INFO - PROCESS | 28837 | _x_x_mozilla_page_load_details 02:40:07 INFO - PROCESS | 28837 | |i|pagename|runs| 02:40:07 INFO - PROCESS | 28837 | |0;dojo.html;2945.5876177335163;2976.2410585300745;2989.5964044853945;2995;3007.473692103881;5085.923711144335;5111.897762044757;5182.637215394924;5206.895862082761;5228.451012643674;5157.226416037596;5241.187615919529;5250.7112108834;5280.260763493114;5307.044731948247;4701.459332176801;4745.928811067837;4803.975980120094;4808.855734327975;4950.6287028472825;4881.048195601859;4900.852974410755;4915.655904086715;4932.235503496964;4938.38270216223;4642.210824159884;4671.205894997858;4709.646776491777;4761.928571071437;4829.299751536025;4758.785854636515;4759;4762.357081793948;4836.081144582553;4871.805127794884;4753.049390121955;4791.928121078186;4798.376211092571;4827.686200396963;4863.465018847924;5092.643514953955;5129.794808207667;5135.563477104451;5284.630075894689;5366.70483123428;5459.972700136474;5490.368607610096;5530.557555395559;5542.168674698787;5552.472515111058;5545.251391062196;5573.5819813514145;5592.972035139839;5593.776248950037;5596.4123767004285;5137.3064636274;5154.871128221749;5196.896062078775;5200.66195697286;5202;5741.799037033684;5743.224664670216;5751.424857514299;5758.424157584292;5758.942410575841;5504.339479262514;5506.752196151183;5535.474129957647;5544.16837474374;5548.278723765885;5430.294061771944;5466.535344495683;5475.4524547544925;5489.176623506506;5609.831705048855;5512.724363781875;5514.6691198528215;5515.806946756844;5520.641158324696;5555.527780138734;5500.642458240201;5511.669299842022;5523.033469142884;5527.198556209327;5560.805371811967;4117.114820313587;4126.855560055384;4160.625543701021;4210.494740631144;4278.251306021434;3779.168582911755;3796.3166630006313;3800.8289626966853;3801.9429708554394;3802.8478860845808;5063.063333283354;5120.846374608767;5162.896742065138;5308.124159513714;5318.65428747138;5616.213730077792;5633.8168984512895;5645.125005624135;5685.744141513642;5689.7724091036725;5282.445343238982;5294.7617357219015;5303.0719624066405;5307.2569840222395;5308.309919710413;4356.08522210333;4721.6458765592715;4851.466338702739;4909.582685471775;4915.238138088602;5814.244148260699;5866.618669786536;5871.794487192928;5890.9410905891245;5925.940740592625;5555.805546805843;5634.605577609528;5637.548996080386;5644.774209031592;5663.546916246608;5569.526590239875;5683.23276357703;5722.055860783091;5895.823125306248;5900.1149827526215;5445;5463.31708536433;5468.015757163748;5470.452954704498;5507.807226747044;5529.419410961791;5531.695756733418;5536.501714845684;5538.252335934597;5547.528460080938;5255.6058295628745;5413.269208656781;5470.452954704657;5472.179173124063;5510.504054635102;5548.306461692288;5561.1658251261015;5564.137558678412;5595.160725891149;5597.776088956396;5441.537469314994;5474.945250547444;5478.589105817159;5485.040117979258;5505.394406615189;5355.116405793001;5466.726663666721;5492.340919089735;5622.437756224344;5628.409017053151;5444.455554444524;5446.128619420873;5479.0959491683425;5488.807891723771;5492.588055895744 02:40:07 INFO - PROCESS | 28837 | |1;ext.html;582.7319433060792;612.9325774164843;631.3844002097958;633.5501793726454;644.1432894250642;42563.57436425635;44533;44769.10461790762;47495.52504474954;47609.285860712116;45574.54425455745;46089;46089.30866037012;46140;46204.53795462053;9018.86471702925;9145.817083658323;9156.587953542074;9157.725268241964;9159.404638698497;9067.501287429188;9130.908690913073;9160.175584197454;9163.266938644892;9164.541772911327;9180.678676246333;9191.95404022979;9224.769380765467;9233.49215793131;9237.584308706124;9110.681126160585;9121.087891210893;9134.314926380548;9148.17666410023;9148.817023659556;8915.73252802417;8963.55182240892;8990.505522196276;8992.8651070234;8994.325425593106;42759.57240427587;43137.78431107824;43187;43410.13179736387;43791;3645.927081458356;3801.7148713846573;3967.543732470774;4019.6382325590544;4153.958460415418;33019.917298070985;33035.66964330374;33220.66779332224;34476.48285275723;34510.65489345099;4311.719738217006;4389.297712366006;4393.758343291118;4395.318725597537;4430.446194225722;370817;373024.99999999726;375559;376277;376966;57265.568360791316;57581.136282954954;57715;57746.422535774946;57806.421935780105;53624;61066.38933610607;61150;61232.38767612356;61404.69297653483;15797.68404631901;16365.345386184657;16431.1784410779;16795.076270805224;16843.07363095017;11403.144764142722;11525.366104864313;11546.59586914454;11560.768784624428;11561.248518846249;16303.83696163047;16310.429134980455;16358.182090895407;16365.918170409072;16443.177841107896;5069.188929771219;5991.880162396727;6200.410960958701;6243.37566243372;6264.277323735918;958.3195930889146;997.7256254529917;1026.5791025679437;1103.4593049405732;1131.2477202660139;32332.35335293328;32475.35624266898;32698.67301327004;33179;33455.498167527505;1096.3202814255212;1097.13874608432;1133.971650708739;1134.359087115777;1144.1761931409371;16846.578835528966;17105.572360691083;17277.785209296395;17295.308187672603;17478.65042699139;555529;557163;558323;567280;571275;58083.12875306874;58343.416565833795;58408.4159158403;58435;58553;1243.6517775023008;1341.6578772412972;1344.8184495093037;1385.245041452431;1387.5213051497217;30314.39371212519;33718.831405842815;34616.826915866266;34705.30589388248;35156.296874062886;57233;59683.403165967786;59843.40156598378;64501;64534.5785234704;503773;512664;512988;513923;515450;43147.56852431561;44543.777281113384;45034.54965450303;47196.7640161797;48035.519644803106;48877.75561122171;48892;49424.25863612121;50044;50239.24641130459;40658.18683626252;42969.14061718686;43285.56714432815;43592.34611480767;43695.78152109219;43061;43121.78439107785;43122.353164703185;43135.35296970611;43799.56200437955;42203.788981054895;43253;43256.35115473333;43634.56365436305;46995.29507057329;33758;37212;37767.62232377751;37889.2422151561;38324.425133623576;28749;29462;29588;29688;29763.851180743957 02:40:07 INFO - PROCESS | 28837 | |2;jquery.html;371.93677074897266;383.62979724565787;391.77081407376676;397.9224051309995;414.2378024435039;16877.57806054849;19277;19287.132079056424;19459.372984647067;20353.898230508865;19676.409707708757;19959.201631934706;20117.497062573442;20250.39248822534;20410;5396.731768034509;5651.208830763686;5845.444682755153;5919.644821310713;5954.166416701665;5873.1190321451695;5908.084246941731;5945.970270148643;5950.404959504058;5964.761409543613;5708.486236238738;5875.324337701177;5899.410058994088;5901.409859014086;5938.406159384071;5639.802606908779;5825.417458254183;5829.446202610745;5863.941360586382;5865.794697185599;5158.458361871987;5192.350956130484;5203.7398130093725;5204.557612602934;5205.531502164823;23856.7614323858;24216.394590135213;24392.39019024521;24394.634080488806;24414.755852441427;2393.126508824284;2408.6146216605257;2514.6353778701987;2656.468706258756;2797.1888152435768;14238.928805355907;14722;14768.335424905905;15086.321115549827;15487.303071361815;1890.3194849854042;1892.933747318851;1912.4071537823181;1924.9230030798751;1968.8326492248177;82643.58678206631;83768;84103.5794821022;84342;85565.14434855634;10443.373397596017;10470.267081304235;10722.195835312383;10852.837207441895;11167.38579378142;14855.10869347821;14868.851311486964;14883.70232595342;14891.627709307353;14894;7927.643256053491;8151.429399941947;8157.918420815835;8318.750437486886;8357.122502137188;7751.689932402754;7799;7835.177306382861;8019.879701804478;8020.759377218693;6577.638229897306;6631.535792494576;6638.336166383419;6687.297833727389;6880.311968803079;1744.6074633207427;1787.2378642956648;1851.3612803582741;1854.4343975087459;1883.990580047091;995.7261753017978;1012.8176928152856;1028.3161697471098;1058.031900810765;1084.4902895639036;20096;20582.588348232952;20623.659462134914;20713.89643051775;20927.37217883466;1002.2433063037506;1042.421456091861;1069.588208539718;1083.111848284415;1120.7142178744532;10838.512266948006;11621.01633106078;11694.649160525198;11813.054955603531;11835;466500;505094;510537;518472;520131;44317.113657726666;47822;48780.512194878305;55686.72156639272;81848.18151818524;1019.5870672377699;1042.4735508568124;1045.7908418316367;1083.8970297821695;1085.0560012788924;12743.362831858556;17613.559661008065;19241.90379048096;19265.422037338903;19291.324803631807;27037.729622703522;27511.17466476009;30643.54034689437;34814;39530.2093958125;48033.75983120062;48744;49238;50067.248991265886;50719.49280507147;7902.802429939067;8087.63605637736;8226.794330141794;8338.957630296212;8363.330933525182;11111.555537778399;11972.58095966637;12041.458134383798;12207.816882746944;12649.87350126487;10853.186011049045;11120.443977800916;11141.331520108819;11503.137264705014;11613.535458581562;10422.530986105492;10560.471976401303;10586.68239952772;10653.753026634395;10844.945775271073;10388.948055259676;10652.733681658021;10733.946330268298;11111.222214444912;11155.83266251023;8714.956425217833;8742.082081381363;8767.517786521803;8849;8965.193132618097;9609.423434593667;10278.856056404715;10832.133429325477;10885;10923.750012457482 02:40:07 INFO - PROCESS | 28837 | |3;mootools.html;1457.271364317841;1505.081900040975;1586.5399034280051;1761.4539492757237;1765.7792775903004;8562.871556926644;9222.031686672886;9225.677101301455;9228.492432916195;9229.215516681083;7936.92063079369;8185.754427367174;8314.833703325945;8656.740297791077;9053.547322633875;2338.988305058481;2393.617021276596;2394.473215892501;2395.3532546212514;2400.3759022654062;2385.0340612052146;2395.532871090138;2440.5362981033636;2441.9877900610472;2445.8287919845616;2396.4607963208227;2404.0624156578947;2407.434252950555;2441.59713647248;2442.072012635205;2303.1248125712204;2315.733690625574;2317.8377513574055;2339.1345202275265;2406.2179791567637;2377.2511658827416;2393.401649587603;2400.9879950600134;2403.795677367426;2404.723456802473;8804.559772011375;8970.192682658591;8972.730818075468;8978.50618215998;8986.14631609996;5413.729313534347;5522.061249587579;5522.199281104217;5529.944700552983;5539.778408863641;3508.105433114565;3611.6207798181076;3686.7234957378037;3691.8338674759702;3697.4453831925157;1198.5265820001139;1222.6576558563615;1222.7309991801878;1238.0405185980846;1239.21929184614;12218.144729868913;12553.93723031379;12575.811362829565;12611.873881261161;12641.999999999907;4729.337892695025;4776.188048031843;4863.878403039882;4919.532644398776;4960.528749768839;10633.415162166155;10635;10647;10647.627333043307;10652.201084918663;5505.532029777513;5516.889662206733;5521.089020311603;5521.668699878021;5526.585506086979;4471.597556219956;4839.564439200489;4934.1611925972675;4958.826441074545;5021.372328458942;3998.760074395487;4024.959750402517;4092.5249573898222;4111.157212771374;4142.813573389205;1241.1684171605045;1249.7562975219744;1250.3123282194756;1279.9296038717773;1285.7685616589104;878.5958459108754;973.2165606686685;975.6536429567543;977;987.5062468765617;5936.317323507852;5991.55063370249;5992.820215393545;6054.485368743706;6241.407066328691;464.579555502271;464.61669122973683;473.29715372672246;474.553919315842;480.53388213432913;4173.394857745609;4180.143070670505;4247.787610619456;4263.8081286342185;4280.379344994958;10525.736856578493;10649.414282214553;10676.359418434919;10752.677419677422;10805.783884322427;10328.380297182193;10749.247552671395;10755.56977720898;10776.137908967265;10797.190210734227;8053.234942680436;8419.284360829275;8419.95790021046;8422.115677853859;8422.873656895152;6044;6158.476529495043;6333.778317758856;6448.322926092693;6545.541812073109;9348.158665720119;9667.951660241653;10193.286469947328;10205;10216.284860059724;9933.65232216869;9949.303548751517;9950.154236889946;10051.195904327782;10058.949705251427;6994.5803251805055;7692.42306826979;7711.151773305044;7874.606269686607;8026.83946321082;8748.300135989233;8845.159709827556;8854.335924805537;8858.557072146496;8860;7774.766756997299;7831.608419578884;7964.920350796418;8075.313598344206;8108.513489190667;7527.698892044257;7625.923740762521;7656.081270247606;7707.499012564165;7749.690012399441;6660.800175994728;6761.154855643044;6764.154480689914;6769.864602708017;6770.763023294161;5301.310829592283;5370.677759334452;5404.189371594292;5449.400565937823;5494.615376923737;5130.769115389742;5174.223866420067;5249.370075590953;5254.842354729364;5266.920996185137 02:40:07 INFO - PROCESS | 28837 | |4;prototype.html;328.40722495894914;335.7431564852888;340.6117026589688;342.691577580178;343.1541250816736;5073.23901414788;5093.923591146136;5103.744812759361;5114.335136432259;5151.175811870102;4897.951020489794;4957.182064959286;5060.139776238039;5086.542211200991;5105.310783044288;4062.9187416251657;4064.7764372959477;4071.2061148076064;4079.8980025499304;4088.9182216355657;4078.163976384834;4098.631123198911;4102.507699076115;4113.362428823537;4114.053767633446;3861.4593956846065;3871.477350557667;4014.7189696721243;4019.1358857845557;4080.3675430308203;4037.1521980384155;4037.394390841368;4044.4944381952255;4053.3312003519386;4063.4717486726686;3608.170120872188;3621.7102631789394;3623.420252759572;3625.1843335249623;3630.709543236535;4791.736454495001;5006.822032415875;5014.197728363444;5028.296038554606;5037.798488060474;4574.4510658721165;4580.473245576768;4611.570413171928;4622.976885115587;4628.953710462886;5328.520433161034;5332.9334133173525;5341;5341.706206158659;5360.892782144335;3777.622237776228;3893.5133108361456;3900.8829735107993;3915.882523524299;3916.3733802591732;5409.891802163935;5555.694436805974;5566.137248726453;5587.100385868825;5594.440555944454;3974.821133048962;3975.4235635832642;3983.661388781928;3990;3996.100877302642;4048.2713111640187;4053.2704113259897;4069.491313585802;4069.694772892045;4071.9796401017807;4387.561243875651;4587.334836448763;4597.862064138081;4599.632029437637;4610.354550362952;5398.6220964532895;5405.675659460445;5408.107662235766;5408.215808707715;5440.3135028141405;1394.623451668044;1399.9020068595305;1401.1663060479;1407.7677183264852;1416.9372970272295;890.692711014699;901.5582364641278;946.9005754395689;958.7363475044418;974.3325821812082;5124.308218390544;5156.535911767959;5170.250313704567;5178.275041494194;5215.600823621101;5414.214938833847;5476.91784623231;5497.670139791625;5508.366537848199;5552.333719953632;4917.557419832232;5084.872878178076;5089.491050894881;5232.39827419844;5272.2355258487305;2923.9122826315242;2939.882844519112;2945.926351841178;2946.4107178563945;2950.333061820065;5611.494965453129;5780.16187652788;5794.884102318014;5820.70896455184;5827.619980411351;5590.077637189818;5612.326520817446;5616.719164041781;5623.240862483594;5634.492895639412;5671.546276297886;5694.743736531783;5722.914156287659;5733.168690539848;5743.224664670383;5326.866828329323;5442.972785136049;5476.809276289516;5485.780568777204;5516.310461192351;5414.35027796667;5442.945570544244;5445.373782015119;5447.4824891635235;5469.288992430958;5697.800576979786;5715.799947001835;5764.279465066867;5776.036147709799;5776.768929242783;3793.7670257167083;3958.386450100239;3961.2473630010204;4011.1147760552494;4042.818073186655;5372.5433338166695;5398.2442458056685;5534.39121696605;5542.556595472433;5610.803621873215;5394.67830381559;5399.271098401822;5438.483344082306;5462.945370546244;5508.366537848199;5219.9217011744095;5338.786448542171;5352.464753524617;5403.432639572946;5408.405075441777;5292.5501332387175;5307.708076055854;5310.575153987749;5318.760655770577;5322.4677532248015;5398.1902714593125;5410.458954104715;5424.566034717134;5461.918071228855;5497.433231528995;5037.571806396498;5272.261883336259;5309.946900530946;5312.760925758427;5313.495217954288 02:40:07 INFO - PROCESS | 28837 | |5;yui.html;817.7669364231194;835.5237514616667;840.5335039053323;857.0829212742366;883.8585826267798;15829.287682054306;16868.49394518163;16897.23962421691;16928.4075057373;16951.40670076546;14932;14944.626384340398;15040.924795376035;15057.698846023073;15209.315580798862;799.9680012799481;831.8253166834971;835.5863847395548;843.4812590257009;844.4215712237137;669.926308106108;831.0401486283353;834.3617132893341;834.4159088637947;835.1898658301438;842.1494290766309;846.9449485783435;849.3884403229665;877.2017464107663;880.0363601855958;868.7524055644143;871.8125602995323;872.2672954718035;872.9039805621377;873.6418068591911;511.7773768410716;638.6934271549682;639.1212083385345;640.362838975218;640.6508452893185;12578.937105314506;13086.86913130866;14280.500182493666;14884.776728349083;14925.2537373132;14459.927700361432;15210.695786084327;15763.68472630541;16184.19079046043;16588.83411165885;12433.197734705192;12467.875321246762;12632.936835315857;12689.492420303177;12736.17214881039;3972.682185425159;3995.4606128172613;4051.9594804051876;4210.305299625558;4221.577842215785;80951;82448.58775706083;83261.58369208175;83469.58265208696;83542.58228708818;11856.644300670821;12096.69758256033;12452.31512266834;12452.564160254347;12548.81176782349;23207.3037808866;23570.292891213292;23578.174763883526;23603.409914751926;24423.511529769305;9080.455172689528;9104.8634270486;9127.726168214964;9402.623895044122;9501.667441639509;4700.318453824177;4740.762961851894;4760.785764640599;4783.904321913542;4811.831585894477;3675.3751862182958;3714.257148570297;3790.128270497801;3794.9430758538642;3800.790956497364;607.8206928955968;629.7040391016216;635.7965451055618;646.9676516174172;651.1697585578426;711.989320160198;718.7735863203075;735.385210035732;735.6542425060213;751.8158051277472;9823.115919567274;10079.848802267972;10109.44398058099;10162.4918754062;11031.22781405294;656.297761395312;715.9355657990702;742.4060751398968;745.4558172534081;757.6666266842572;4502.302143167814;4904.681195722266;4940.925886111711;4945.4312754033745;5055.848324550269;102117;105072.93468371575;107880.46059769651;119322;127468.36265818797;106766;109880;110852.89147108587;111577.09480168317;112996;84269.15730842613;90681.54659226662;92821.53589232145;100687;100782.99999999853;10051.447170405405;10161.745956351151;10194.439305837954;10202.38785672862;10307.639232626821;34369;38959.61040389673;47635.52364476311;48025.519744802106;49274.50725492842;69299.65350173217;69895.65052174707;73038.63480682562;74521.62739186487;76428.2357176421;13657.726845463234;13706.65733356674;13916.234607096301;13947.30263486842;14334.354954027302;15152.621184470036;15466.226688665747;15653.765193522335;15756.527304180434;15976.760348594547;14169.433222670978;14592.197429141499;14763.409463621334;14847.109173449628;15179.772303415679;14310.427582896984;14360.353784079532;14704.525728456292;14805.925970370079;14919.477818276308;14589.343479543233;14734.484293049692;14878.851211487747;14963.40146394132;15737.68524629524;11725;11823.349715765715;11839.82240266414;11945.641630751092;11962.162648614862;10560.940791247054;10598.417087059977;10809.135269178603;10982.62717160355;11819.645410637695 02:40:07 INFO - PROCESS | 28837 | __end_tp_report 02:40:07 INFO - PROCESS | 28837 | __start_cc_report 02:40:07 INFO - PROCESS | 28837 | _x_x_mozilla_cycle_collect,1075 02:40:07 INFO - PROCESS | 28837 | __end_cc_report 02:40:07 INFO - PROCESS | 28837 | __startTimestamp1470390007165__endTimestamp 02:40:07 INFO - PROCESS | 28837 | 02:40:07 INFO - PROCESS | 28837 | ------- Summary: start ------- 02:40:07 INFO - PROCESS | 28837 | Number of tests: 6 02:40:07 INFO - PROCESS | 28837 | 02:40:07 INFO - PROCESS | 28837 | [#0] dojo.html Cycles:165 Average:5191.76 Median:5446.13 stddev:599.58 (11.0%) stddev-sans-first:574.94 02:40:07 INFO - PROCESS | 28837 | Values: 2945.6 2976.2 2989.6 2995.0 3007.5 5085.9 5111.9 5182.6 5206.9 5228.5 5157.2 5241.2 5250.7 5280.3 5307.0 4701.5 4745.9 4804.0 4808.9 4950.6 4881.0 4900.9 4915.7 4932.2 4938.4 4642.2 4671.2 4709.6 4761.9 4829.3 4758.8 4759.0 4762.4 4836.1 4871.8 4753.0 4791.9 4798.4 4827.7 4863.5 5092.6 5129.8 5135.6 5284.6 5366.7 5460.0 5490.4 5530.6 5542.2 5552.5 5545.3 5573.6 5593.0 5593.8 5596.4 5137.3 5154.9 5196.9 5200.7 5202.0 5741.8 5743.2 5751.4 5758.4 5758.9 5504.3 5506.8 5535.5 5544.2 5548.3 5430.3 5466.5 5475.5 5489.2 5609.8 5512.7 5514.7 5515.8 5520.6 5555.5 5500.6 5511.7 5523.0 5527.2 5560.8 4117.1 4126.9 4160.6 4210.5 4278.3 3779.2 3796.3 3800.8 3801.9 3802.8 5063.1 5120.8 5162.9 5308.1 5318.7 5616.2 5633.8 5645.1 5685.7 5689.8 5282.4 5294.8 5303.1 5307.3 5308.3 4356.1 4721.6 4851.5 4909.6 4915.2 5814.2 5866.6 5871.8 5890.9 5925.9 5555.8 5634.6 5637.5 5644.8 5663.5 5569.5 5683.2 5722.1 5895.8 5900.1 5445.0 5463.3 5468.0 5470.5 5507.8 5529.4 5531.7 5536.5 5538.3 5547.5 5255.6 5413.3 5470.5 5472.2 5510.5 5548.3 5561.2 5564.1 5595.2 5597.8 5441.5 5474.9 5478.6 5485.0 5505.4 5355.1 5466.7 5492.3 5622.4 5628.4 5444.5 5446.1 5479.1 5488.8 5492.6 02:40:07 INFO - PROCESS | 28837 | 02:40:07 INFO - PROCESS | 28837 | [#1] ext.html Cycles:180 Average:64913.06 Median:4391.53 stddev:129847.10 (2956.8%) stddev-sans-first:130121.52 02:40:07 INFO - PROCESS | 28837 | Values: 582.7 612.9 631.4 633.6 644.1 42563.6 44533.0 44769.1 47495.5 47609.3 45574.5 46089.0 46089.3 46140.0 46204.5 9018.9 9145.8 9156.6 9157.7 9159.4 9067.5 9130.9 9160.2 9163.3 9164.5 9180.7 9192.0 9224.8 9233.5 9237.6 9110.7 9121.1 9134.3 9148.2 9148.8 8915.7 8963.6 8990.5 8992.9 8994.3 42759.6 43137.8 43187.0 43410.1 43791.0 3645.9 3801.7 3967.5 4019.6 4154.0 33019.9 33035.7 33220.7 34476.5 34510.7 4311.7 4389.3 4393.8 4395.3 4430.4 370817.0 373025.0 375559.0 376277.0 376966.0 57265.6 57581.1 57715.0 57746.4 57806.4 53624.0 61066.4 61150.0 61232.4 61404.7 15797.7 16365.3 16431.2 16795.1 16843.1 11403.1 11525.4 11546.6 11560.8 11561.2 16303.8 16310.4 16358.2 16365.9 16443.2 5069.2 5991.9 6200.4 6243.4 6264.3 958.3 997.7 1026.6 1103.5 1131.2 32332.4 32475.4 32698.7 33179.0 33455.5 1096.3 1097.1 1134.0 1134.4 1144.2 16846.6 17105.6 17277.8 17295.3 17478.7 555529.0 557163.0 558323.0 567280.0 571275.0 58083.1 58343.4 58408.4 58435.0 58553.0 1243.7 1341.7 1344.8 1385.2 1387.5 30314.4 33718.8 34616.8 34705.3 35156.3 57233.0 59683.4 59843.4 64501.0 64534.6 503773.0 512664.0 512988.0 513923.0 515450.0 43147.6 44543.8 45034.5 47196.8 48035.5 48877.8 48892.0 49424.3 50044.0 50239.2 40658.2 42969.1 43285.6 43592.3 43695.8 43061.0 43121.8 43122.4 43135.4 43799.6 42203.8 43253.0 43256.4 43634.6 46995.3 33758.0 37212.0 37767.6 37889.2 38324.4 28749.0 29462.0 29588.0 29688.0 29763.9 02:40:07 INFO - PROCESS | 28837 | 02:40:07 INFO - PROCESS | 28837 | [#2] jquery.html Cycles:180 Average:28114.73 Median:13312.50 stddev:82527.37 (619.9%) stddev-sans-first:82732.59 02:40:07 INFO - PROCESS | 28837 | Values: 371.9 383.6 391.8 397.9 414.2 16877.6 19277.0 19287.1 19459.4 20353.9 19676.4 19959.2 20117.5 20250.4 20410.0 5396.7 5651.2 5845.4 5919.6 5954.2 5873.1 5908.1 5946.0 5950.4 5964.8 5708.5 5875.3 5899.4 5901.4 5938.4 5639.8 5825.4 5829.4 5863.9 5865.8 5158.5 5192.4 5203.7 5204.6 5205.5 23856.8 24216.4 24392.4 24394.6 24414.8 2393.1 2408.6 2514.6 2656.5 2797.2 14238.9 14722.0 14768.3 15086.3 15487.3 1890.3 1892.9 1912.4 1924.9 1968.8 82643.6 83768.0 84103.6 84342.0 85565.1 10443.4 10470.3 10722.2 10852.8 11167.4 14855.1 14868.9 14883.7 14891.6 14894.0 7927.6 8151.4 8157.9 8318.8 8357.1 7751.7 7799.0 7835.2 8019.9 8020.8 6577.6 6631.5 6638.3 6687.3 6880.3 1744.6 1787.2 1851.4 1854.4 1884.0 995.7 1012.8 1028.3 1058.0 1084.5 20096.0 20582.6 20623.7 20713.9 20927.4 1002.2 1042.4 1069.6 1083.1 1120.7 10838.5 11621.0 11694.6 11813.1 11835.0 466500.0 505094.0 510537.0 518472.0 520131.0 44317.1 47822.0 48780.5 55686.7 81848.2 1019.6 1042.5 1045.8 1083.9 1085.1 12743.4 17613.6 19241.9 19265.4 19291.3 27037.7 27511.2 30643.5 34814.0 39530.2 48033.8 48744.0 49238.0 50067.2 50719.5 7902.8 8087.6 8226.8 8339.0 8363.3 11111.6 11972.6 12041.5 12207.8 12649.9 10853.2 11120.4 11141.3 11503.1 11613.5 10422.5 10560.5 10586.7 10653.8 10844.9 10388.9 10652.7 10733.9 11111.2 11155.8 8715.0 8742.1 8767.5 8849.0 8965.2 9609.4 10278.9 10832.1 10885.0 10923.8 02:40:07 INFO - PROCESS | 28837 | 02:40:07 INFO - PROCESS | 28837 | [#3] mootools.html Cycles:180 Average:5867.09 Median:4926.85 stddev:3296.55 (66.9%) stddev-sans-first:3289.13 02:40:07 INFO - PROCESS | 28837 | Values: 1457.3 1505.1 1586.5 1761.5 1765.8 8562.9 9222.0 9225.7 9228.5 9229.2 7936.9 8185.8 8314.8 8656.7 9053.5 2339.0 2393.6 2394.5 2395.4 2400.4 2385.0 2395.5 2440.5 2442.0 2445.8 2396.5 2404.1 2407.4 2441.6 2442.1 2303.1 2315.7 2317.8 2339.1 2406.2 2377.3 2393.4 2401.0 2403.8 2404.7 8804.6 8970.2 8972.7 8978.5 8986.1 5413.7 5522.1 5522.2 5529.9 5539.8 3508.1 3611.6 3686.7 3691.8 3697.4 1198.5 1222.7 1222.7 1238.0 1239.2 12218.1 12553.9 12575.8 12611.9 12642.0 4729.3 4776.2 4863.9 4919.5 4960.5 10633.4 10635.0 10647.0 10647.6 10652.2 5505.5 5516.9 5521.1 5521.7 5526.6 4471.6 4839.6 4934.2 4958.8 5021.4 3998.8 4025.0 4092.5 4111.2 4142.8 1241.2 1249.8 1250.3 1279.9 1285.8 878.6 973.2 975.7 977.0 987.5 5936.3 5991.6 5992.8 6054.5 6241.4 464.6 464.6 473.3 474.6 480.5 4173.4 4180.1 4247.8 4263.8 4280.4 10525.7 10649.4 10676.4 10752.7 10805.8 10328.4 10749.2 10755.6 10776.1 10797.2 8053.2 8419.3 8420.0 8422.1 8422.9 6044.0 6158.5 6333.8 6448.3 6545.5 9348.2 9668.0 10193.3 10205.0 10216.3 9933.7 9949.3 9950.2 10051.2 10058.9 6994.6 7692.4 7711.2 7874.6 8026.8 8748.3 8845.2 8854.3 8858.6 8860.0 7774.8 7831.6 7964.9 8075.3 8108.5 7527.7 7625.9 7656.1 7707.5 7749.7 6660.8 6761.2 6764.2 6769.9 6770.8 5301.3 5370.7 5404.2 5449.4 5494.6 5130.8 5174.2 5249.4 5254.8 5266.9 02:40:07 INFO - PROCESS | 28837 | 02:40:07 INFO - PROCESS | 28837 | [#4] prototype.html Cycles:180 Average:4546.15 Median:5163.39 stddev:1321.11 (25.6%) stddev-sans-first:1286.33 02:40:07 INFO - PROCESS | 28837 | Values: 328.4 335.7 340.6 342.7 343.2 5073.2 5093.9 5103.7 5114.3 5151.2 4898.0 4957.2 5060.1 5086.5 5105.3 4062.9 4064.8 4071.2 4079.9 4088.9 4078.2 4098.6 4102.5 4113.4 4114.1 3861.5 3871.5 4014.7 4019.1 4080.4 4037.2 4037.4 4044.5 4053.3 4063.5 3608.2 3621.7 3623.4 3625.2 3630.7 4791.7 5006.8 5014.2 5028.3 5037.8 4574.5 4580.5 4611.6 4623.0 4629.0 5328.5 5332.9 5341.0 5341.7 5360.9 3777.6 3893.5 3900.9 3915.9 3916.4 5409.9 5555.7 5566.1 5587.1 5594.4 3974.8 3975.4 3983.7 3990.0 3996.1 4048.3 4053.3 4069.5 4069.7 4072.0 4387.6 4587.3 4597.9 4599.6 4610.4 5398.6 5405.7 5408.1 5408.2 5440.3 1394.6 1399.9 1401.2 1407.8 1416.9 890.7 901.6 946.9 958.7 974.3 5124.3 5156.5 5170.3 5178.3 5215.6 5414.2 5476.9 5497.7 5508.4 5552.3 4917.6 5084.9 5089.5 5232.4 5272.2 2923.9 2939.9 2945.9 2946.4 2950.3 5611.5 5780.2 5794.9 5820.7 5827.6 5590.1 5612.3 5616.7 5623.2 5634.5 5671.5 5694.7 5722.9 5733.2 5743.2 5326.9 5443.0 5476.8 5485.8 5516.3 5414.4 5442.9 5445.4 5447.5 5469.3 5697.8 5715.8 5764.3 5776.0 5776.8 3793.8 3958.4 3961.2 4011.1 4042.8 5372.5 5398.2 5534.4 5542.6 5610.8 5394.7 5399.3 5438.5 5462.9 5508.4 5219.9 5338.8 5352.5 5403.4 5408.4 5292.6 5307.7 5310.6 5318.8 5322.5 5398.2 5410.5 5424.6 5461.9 5497.4 5037.6 5272.3 5309.9 5312.8 5313.5 02:40:07 INFO - PROCESS | 28837 | 02:40:07 INFO - PROCESS | 28837 | [#5] yui.html Cycles:180 Average:21561.88 Median:29396.26 stddev:31106.22 (105.8%) stddev-sans-first:31154.48 02:40:07 INFO - PROCESS | 28837 | Values: 817.8 835.5 840.5 857.1 883.9 15829.3 16868.5 16897.2 16928.4 16951.4 14932.0 14944.6 15040.9 15057.7 15209.3 800.0 831.8 835.6 843.5 844.4 669.9 831.0 834.4 834.4 835.2 842.1 846.9 849.4 877.2 880.0 868.8 871.8 872.3 872.9 873.6 511.8 638.7 639.1 640.4 640.7 12578.9 13086.9 14280.5 14884.8 14925.3 14459.9 15210.7 15763.7 16184.2 16588.8 12433.2 12467.9 12632.9 12689.5 12736.2 3972.7 3995.5 4052.0 4210.3 4221.6 80951.0 82448.6 83261.6 83469.6 83542.6 11856.6 12096.7 12452.3 12452.6 12548.8 23207.3 23570.3 23578.2 23603.4 24423.5 9080.5 9104.9 9127.7 9402.6 9501.7 4700.3 4740.8 4760.8 4783.9 4811.8 3675.4 3714.3 3790.1 3794.9 3800.8 607.8 629.7 635.8 647.0 651.2 712.0 718.8 735.4 735.7 751.8 9823.1 10079.8 10109.4 10162.5 11031.2 656.3 715.9 742.4 745.5 757.7 4502.3 4904.7 4940.9 4945.4 5055.8 102117.0 105072.9 107880.5 119322.0 127468.4 106766.0 109880.0 110852.9 111577.1 112996.0 84269.2 90681.5 92821.5 100687.0 100783.0 10051.4 10161.7 10194.4 10202.4 10307.6 34369.0 38959.6 47635.5 48025.5 49274.5 69299.7 69895.7 73038.6 74521.6 76428.2 13657.7 13706.7 13916.2 13947.3 14334.4 15152.6 15466.2 15653.8 15756.5 15976.8 14169.4 14592.2 14763.4 14847.1 15179.8 14310.4 14360.4 14704.5 14805.9 14919.5 14589.3 14734.5 14878.9 14963.4 15737.7 11725.0 11823.3 11839.8 11945.6 11962.2 10560.9 10598.4 10809.1 10982.6 11819.6 02:40:07 INFO - PROCESS | 28837 | -------- Summary: end -------- 02:40:07 INFO - PROCESS | 28837 | 02:40:07 INFO - TEST-INFO | 28837: exit 0 02:40:08 INFO - TEST-OK | dromaeo_css | took 1115080ms 02:40:08 INFO - TEST-START | kraken 02:40:08 INFO - operating with platform_type : linux_ 02:40:08 INFO - Initialising browser for kraken test... 02:40:08 INFO - TEST-INFO | started process 29030 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBuL0wC/profile http://localhost:33779/getInfo.html) 02:40:11 INFO - PROCESS | 29030 | __metrics Screen width/height:1600/1200 02:40:11 INFO - PROCESS | 29030 | colorDepth:24 02:40:11 INFO - PROCESS | 29030 | Browser inner width/height: 1024/697 02:40:11 INFO - PROCESS | 29030 | __metrics 02:40:12 INFO - PROCESS | 29030 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:40:12 INFO - PROCESS | 29030 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:40:13 INFO - TEST-INFO | 29030: exit 0 02:40:13 INFO - Browser initialized. 02:40:13 INFO - Running cycle 1/1 for kraken test... 02:40:13 INFO - TEST-INFO | started process 29111 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBuL0wC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:40:25 INFO - PROCESS | 29111 | RSS: Main: 156860416 02:40:25 INFO - PROCESS | 29111 | 02:40:28 INFO - PROCESS | 29111 | Cycle 1(1): loaded http://localhost:33779/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33779/tests/kraken/driver.html?testName=audio-beat-detection) 02:40:28 INFO - PROCESS | 29111 | RSS: Main: 213508096 02:40:28 INFO - PROCESS | 29111 | 02:40:31 INFO - PROCESS | 29111 | Cycle 1(1): loaded http://localhost:33779/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33779/tests/kraken/driver.html?testName=audio-dft) 02:40:32 INFO - PROCESS | 29111 | RSS: Main: 186191872 02:40:32 INFO - PROCESS | 29111 | 02:40:35 INFO - PROCESS | 29111 | Cycle 1(1): loaded http://localhost:33779/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33779/tests/kraken/driver.html?testName=audio-fft) 02:40:35 INFO - PROCESS | 29111 | RSS: Main: 269840384 02:40:35 INFO - PROCESS | 29111 | 02:40:38 INFO - PROCESS | 29111 | Cycle 1(1): loaded http://localhost:33779/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33779/tests/kraken/driver.html?testName=audio-oscillator) 02:40:38 INFO - PROCESS | 29111 | RSS: Main: 180871168 02:40:38 INFO - PROCESS | 29111 | 02:40:40 INFO - PROCESS | 29111 | Cycle 1(1): loaded http://localhost:33779/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33779/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:40:41 INFO - PROCESS | 29111 | RSS: Main: 184639488 02:40:41 INFO - PROCESS | 29111 | 02:40:44 INFO - PROCESS | 29111 | Cycle 1(1): loaded http://localhost:33779/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33779/tests/kraken/driver.html?testName=imaging-darkroom) 02:40:45 INFO - PROCESS | 29111 | RSS: Main: 219443200 02:40:45 INFO - PROCESS | 29111 | 02:40:48 INFO - PROCESS | 29111 | Cycle 1(1): loaded http://localhost:33779/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33779/tests/kraken/driver.html?testName=imaging-desaturate) 02:40:49 INFO - PROCESS | 29111 | RSS: Main: 220004352 02:40:49 INFO - PROCESS | 29111 | 02:40:51 INFO - PROCESS | 29111 | Cycle 1(1): loaded http://localhost:33779/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33779/tests/kraken/driver.html?testName=json-parse-financial) 02:40:52 INFO - PROCESS | 29111 | RSS: Main: 220176384 02:40:52 INFO - PROCESS | 29111 | 02:40:53 INFO - PROCESS | 29111 | Cycle 1(1): loaded http://localhost:33779/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33779/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:40:54 INFO - PROCESS | 29111 | RSS: Main: 184791040 02:40:54 INFO - PROCESS | 29111 | 02:40:56 INFO - PROCESS | 29111 | Cycle 1(1): loaded http://localhost:33779/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33779/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:40:56 INFO - PROCESS | 29111 | RSS: Main: 189964288 02:40:56 INFO - PROCESS | 29111 | 02:40:58 INFO - PROCESS | 29111 | Cycle 1(1): loaded http://localhost:33779/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33779/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:40:59 INFO - PROCESS | 29111 | RSS: Main: 194682880 02:40:59 INFO - PROCESS | 29111 | 02:41:02 INFO - PROCESS | 29111 | Cycle 1(1): loaded http://localhost:33779/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33779/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:41:02 INFO - PROCESS | 29111 | RSS: Main: 188493824 02:41:02 INFO - PROCESS | 29111 | 02:41:05 INFO - PROCESS | 29111 | Cycle 1(1): loaded http://localhost:33779/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33779/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:41:06 INFO - PROCESS | 29111 | RSS: Main: 193077248 02:41:06 INFO - PROCESS | 29111 | 02:41:07 INFO - PROCESS | 29111 | Cycle 1(1): loaded http://localhost:33779/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33779/tests/kraken/driver.html?testName=ai-astar) 02:41:07 INFO - PROCESS | 29111 | RSS: Main: 243814400 02:41:07 INFO - PROCESS | 29111 | 02:41:07 INFO - PROCESS | 29111 | __start_tp_report 02:41:07 INFO - PROCESS | 29111 | _x_x_mozilla_page_load 02:41:07 INFO - PROCESS | 29111 | _x_x_mozilla_page_load_details 02:41:07 INFO - PROCESS | 29111 | |i|pagename|runs| 02:41:07 INFO - PROCESS | 29111 | |0;ai-astar;104;114;111;113;112;112;112;111;113;112 02:41:07 INFO - PROCESS | 29111 | |1;audio-beat-detection;152;123;148;158;122;122;144;117;166;121 02:41:07 INFO - PROCESS | 29111 | |2;audio-dft;160;160;159;162;161;161;162;159;166;162 02:41:07 INFO - PROCESS | 29111 | |3;audio-fft;74;75;75;113;75;77;74;75;111;75 02:41:07 INFO - PROCESS | 29111 | |4;audio-oscillator;84;84;127;84;84;86;129;85;85;129 02:41:07 INFO - PROCESS | 29111 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;116;116 02:41:07 INFO - PROCESS | 29111 | |6;imaging-darkroom;145;147;146;146;146;145;146;145;145;145 02:41:07 INFO - PROCESS | 29111 | |7;imaging-desaturate;94;96;94;95;95;95;94;94;95;95 02:41:07 INFO - PROCESS | 29111 | |8;json-parse-financial;50;50;50;49;48;50;52;50;49;49 02:41:07 INFO - PROCESS | 29111 | |9;json-stringify-tinderbox;60;62;61;61;61;60;61;61;60;61 02:41:07 INFO - PROCESS | 29111 | |10;stanford-crypto-aes;77;82;76;75;75;75;76;76;83;80 02:41:07 INFO - PROCESS | 29111 | |11;stanford-crypto-ccm;121;122;120;130;121;129;131;121;157;124 02:41:07 INFO - PROCESS | 29111 | |12;stanford-crypto-pbkdf2;162;161;160;163;164;163;168;159;160;160 02:41:07 INFO - PROCESS | 29111 | |13;stanford-crypto-sha256-iterative;67;64;64;64;65;66;63;63;62;64 02:41:07 INFO - PROCESS | 29111 | __end_tp_report 02:41:07 INFO - PROCESS | 29111 | __start_cc_report 02:41:07 INFO - PROCESS | 29111 | _x_x_mozilla_cycle_collect,1700 02:41:07 INFO - PROCESS | 29111 | __end_cc_report 02:41:07 INFO - PROCESS | 29111 | __startTimestamp1470390067930__endTimestamp 02:41:07 INFO - PROCESS | 29111 | 02:41:07 INFO - PROCESS | 29111 | ------- Summary: start ------- 02:41:07 INFO - PROCESS | 29111 | Number of tests: 14 02:41:07 INFO - PROCESS | 29111 | 02:41:07 INFO - PROCESS | 29111 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:2.76 (2.5%) stddev-sans-first:0.97 02:41:07 INFO - PROCESS | 29111 | Values: 104.0 114.0 111.0 113.0 112.0 112.0 112.0 111.0 113.0 112.0 02:41:07 INFO - PROCESS | 29111 | 02:41:07 INFO - PROCESS | 29111 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:146.00 stddev:18.19 (12.5%) stddev-sans-first:18.50 02:41:07 INFO - PROCESS | 29111 | Values: 152.0 123.0 148.0 158.0 122.0 122.0 144.0 117.0 166.0 121.0 02:41:07 INFO - PROCESS | 29111 | 02:41:07 INFO - PROCESS | 29111 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:2.04 (1.3%) stddev-sans-first:2.12 02:41:07 INFO - PROCESS | 29111 | Values: 160.0 160.0 159.0 162.0 161.0 161.0 162.0 159.0 166.0 162.0 02:41:07 INFO - PROCESS | 29111 | 02:41:07 INFO - PROCESS | 29111 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:15.63 (20.8%) stddev-sans-first:16.28 02:41:07 INFO - PROCESS | 29111 | Values: 74.0 75.0 75.0 113.0 75.0 77.0 74.0 75.0 111.0 75.0 02:41:07 INFO - PROCESS | 29111 | 02:41:07 INFO - PROCESS | 29111 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:84.00 stddev:21.16 (25.2%) stddev-sans-first:21.85 02:41:07 INFO - PROCESS | 29111 | Values: 84.0 84.0 127.0 84.0 84.0 86.0 129.0 85.0 85.0 129.0 02:41:07 INFO - PROCESS | 29111 | 02:41:07 INFO - PROCESS | 29111 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 02:41:07 INFO - PROCESS | 29111 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 02:41:07 INFO - PROCESS | 29111 | 02:41:07 INFO - PROCESS | 29111 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 02:41:07 INFO - PROCESS | 29111 | Values: 145.0 147.0 146.0 146.0 146.0 145.0 146.0 145.0 145.0 145.0 02:41:07 INFO - PROCESS | 29111 | 02:41:07 INFO - PROCESS | 29111 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 02:41:07 INFO - PROCESS | 29111 | Values: 94.0 96.0 94.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 02:41:07 INFO - PROCESS | 29111 | 02:41:07 INFO - PROCESS | 29111 | [#8] json-parse-financial Cycles:10 Average:49.70 Median:50.00 stddev:1.06 (2.1%) stddev-sans-first:1.12 02:41:07 INFO - PROCESS | 29111 | Values: 50.0 50.0 50.0 49.0 48.0 50.0 52.0 50.0 49.0 49.0 02:41:07 INFO - PROCESS | 29111 | 02:41:07 INFO - PROCESS | 29111 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 02:41:07 INFO - PROCESS | 29111 | Values: 60.0 62.0 61.0 61.0 61.0 60.0 61.0 61.0 60.0 61.0 02:41:07 INFO - PROCESS | 29111 | 02:41:07 INFO - PROCESS | 29111 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:76.50 stddev:3.03 (4.0%) stddev-sans-first:3.21 02:41:07 INFO - PROCESS | 29111 | Values: 77.0 82.0 76.0 75.0 75.0 75.0 76.0 76.0 83.0 80.0 02:41:07 INFO - PROCESS | 29111 | 02:41:07 INFO - PROCESS | 29111 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:126.50 stddev:11.14 (8.8%) stddev-sans-first:11.55 02:41:07 INFO - PROCESS | 29111 | Values: 121.0 122.0 120.0 130.0 121.0 129.0 131.0 121.0 157.0 124.0 02:41:07 INFO - PROCESS | 29111 | 02:41:07 INFO - PROCESS | 29111 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.00 Median:162.50 stddev:2.67 (1.6%) stddev-sans-first:2.83 02:41:07 INFO - PROCESS | 29111 | Values: 162.0 161.0 160.0 163.0 164.0 163.0 168.0 159.0 160.0 160.0 02:41:07 INFO - PROCESS | 29111 | 02:41:07 INFO - PROCESS | 29111 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:1.48 (2.3%) stddev-sans-first:1.17 02:41:07 INFO - PROCESS | 29111 | Values: 67.0 64.0 64.0 64.0 65.0 66.0 63.0 63.0 62.0 64.0 02:41:07 INFO - PROCESS | 29111 | -------- Summary: end -------- 02:41:07 INFO - PROCESS | 29111 | 02:41:08 INFO - TEST-INFO | 29111: exit 0 02:41:08 INFO - TEST-OK | kraken | took 60935ms 02:41:08 INFO - SUITE-END | took 1176s 02:41:09 INFO - Completed test suite (00:19:36) 02:41:09 INFO - javascript benchmark 02:41:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2945.5876177335163, 2976.2410585300745, 2989.5964044853945, 2995.0, 3007.473692103881, 5085.923711144335, 5111.897762044757, 5182.637215394924, 5206.895862082761, 5228.451012643674, 5157.226416037596, 5241.187615919529, 5250.7112108834, 5280.260763493114, 5307.044731948247, 4701.459332176801, 4745.928811067837, 4803.975980120094, 4808.855734327975, 4950.6287028472825, 4881.048195601859, 4900.852974410755, 4915.655904086715, 4932.235503496964, 4938.38270216223, 4642.210824159884, 4671.205894997858, 4709.646776491777, 4761.928571071437, 4829.299751536025, 4758.785854636515, 4759.0, 4762.357081793948, 4836.081144582553, 4871.805127794884, 4753.049390121955, 4791.928121078186, 4798.376211092571, 4827.686200396963, 4863.465018847924, 5092.643514953955, 5129.794808207667, 5135.563477104451, 5284.630075894689, 5366.70483123428, 5459.972700136474, 5490.368607610096, 5530.557555395559, 5542.168674698787, 5552.472515111058, 5545.251391062196, 5573.5819813514145, 5592.972035139839, 5593.776248950037, 5596.4123767004285, 5137.3064636274, 5154.871128221749, 5196.896062078775, 5200.66195697286, 5202.0, 5741.799037033684, 5743.224664670216, 5751.424857514299, 5758.424157584292, 5758.942410575841, 5504.339479262514, 5506.752196151183, 5535.474129957647, 5544.16837474374, 5548.278723765885, 5430.294061771944, 5466.535344495683, 5475.4524547544925, 5489.176623506506, 5609.831705048855, 5512.724363781875, 5514.6691198528215, 5515.806946756844, 5520.641158324696, 5555.527780138734, 5500.642458240201, 5511.669299842022, 5523.033469142884, 5527.198556209327, 5560.805371811967, 4117.114820313587, 4126.855560055384, 4160.625543701021, 4210.494740631144, 4278.251306021434, 3779.168582911755, 3796.3166630006313, 3800.8289626966853, 3801.9429708554394, 3802.8478860845808, 5063.063333283354, 5120.846374608767, 5162.896742065138, 5308.124159513714, 5318.65428747138, 5616.213730077792, 5633.8168984512895, 5645.125005624135, 5685.744141513642, 5689.7724091036725, 5282.445343238982, 5294.7617357219015, 5303.0719624066405, 5307.2569840222395, 5308.309919710413, 4356.08522210333, 4721.6458765592715, 4851.466338702739, 4909.582685471775, 4915.238138088602, 5814.244148260699, 5866.618669786536, 5871.794487192928, 5890.9410905891245, 5925.940740592625, 5555.805546805843, 5634.605577609528, 5637.548996080386, 5644.774209031592, 5663.546916246608, 5569.526590239875, 5683.23276357703, 5722.055860783091, 5895.823125306248, 5900.1149827526215, 5445.0, 5463.31708536433, 5468.015757163748, 5470.452954704498, 5507.807226747044, 5529.419410961791, 5531.695756733418, 5536.501714845684, 5538.252335934597, 5547.528460080938, 5255.6058295628745, 5413.269208656781, 5470.452954704657, 5472.179173124063, 5510.504054635102, 5548.306461692288, 5561.1658251261015, 5564.137558678412, 5595.160725891149, 5597.776088956396, 5441.537469314994, 5474.945250547444, 5478.589105817159, 5485.040117979258, 5505.394406615189, 5355.116405793001, 5466.726663666721, 5492.340919089735, 5622.437756224344, 5628.409017053151, 5444.455554444524, 5446.128619420873, 5479.0959491683425, 5488.807891723771, 5492.588055895744], "value": 5150.47377612762, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.7319433060792, 612.9325774164843, 631.3844002097958, 633.5501793726454, 644.1432894250642, 42563.57436425635, 44533.0, 44769.10461790762, 47495.52504474954, 47609.285860712116, 45574.54425455745, 46089.0, 46089.30866037012, 46140.0, 46204.53795462053, 9018.86471702925, 9145.817083658323, 9156.587953542074, 9157.725268241964, 9159.404638698497, 9067.501287429188, 9130.908690913073, 9160.175584197454, 9163.266938644892, 9164.541772911327, 9180.678676246333, 9191.95404022979, 9224.769380765467, 9233.49215793131, 9237.584308706124, 9110.681126160585, 9121.087891210893, 9134.314926380548, 9148.17666410023, 9148.817023659556, 8915.73252802417, 8963.55182240892, 8990.505522196276, 8992.8651070234, 8994.325425593106, 42759.57240427587, 43137.78431107824, 43187.0, 43410.13179736387, 43791.0, 3645.927081458356, 3801.7148713846573, 3967.543732470774, 4019.6382325590544, 4153.958460415418, 33019.917298070985, 33035.66964330374, 33220.66779332224, 34476.48285275723, 34510.65489345099, 4311.719738217006, 4389.297712366006, 4393.758343291118, 4395.318725597537, 4430.446194225722, 370817.0, 373024.99999999726, 375559.0, 376277.0, 376966.0, 57265.568360791316, 57581.136282954954, 57715.0, 57746.422535774946, 57806.421935780105, 53624.0, 61066.38933610607, 61150.0, 61232.38767612356, 61404.69297653483, 15797.68404631901, 16365.345386184657, 16431.1784410779, 16795.076270805224, 16843.07363095017, 11403.144764142722, 11525.366104864313, 11546.59586914454, 11560.768784624428, 11561.248518846249, 16303.83696163047, 16310.429134980455, 16358.182090895407, 16365.918170409072, 16443.177841107896, 5069.188929771219, 5991.880162396727, 6200.410960958701, 6243.37566243372, 6264.277323735918, 958.3195930889146, 997.7256254529917, 1026.5791025679437, 1103.4593049405732, 1131.2477202660139, 32332.35335293328, 32475.35624266898, 32698.67301327004, 33179.0, 33455.498167527505, 1096.3202814255212, 1097.13874608432, 1133.971650708739, 1134.359087115777, 1144.1761931409371, 16846.578835528966, 17105.572360691083, 17277.785209296395, 17295.308187672603, 17478.65042699139, 555529.0, 557163.0, 558323.0, 567280.0, 571275.0, 58083.12875306874, 58343.416565833795, 58408.4159158403, 58435.0, 58553.0, 1243.6517775023008, 1341.6578772412972, 1344.8184495093037, 1385.245041452431, 1387.5213051497217, 30314.39371212519, 33718.831405842815, 34616.826915866266, 34705.30589388248, 35156.296874062886, 57233.0, 59683.403165967786, 59843.40156598378, 64501.0, 64534.5785234704, 503773.0, 512664.0, 512988.0, 513923.0, 515450.0, 43147.56852431561, 44543.777281113384, 45034.54965450303, 47196.7640161797, 48035.519644803106, 48877.75561122171, 48892.0, 49424.25863612121, 50044.0, 50239.24641130459, 40658.18683626252, 42969.14061718686, 43285.56714432815, 43592.34611480767, 43695.78152109219, 43061.0, 43121.78439107785, 43122.353164703185, 43135.35296970611, 43799.56200437955, 42203.788981054895, 43253.0, 43256.35115473333, 43634.56365436305, 46995.29507057329, 33758.0, 37212.0, 37767.62232377751, 37889.2422151561, 38324.425133623576, 28749.0, 29462.0, 29588.0, 29688.0, 29763.851180743957], "value": 20832.649733173537, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.93677074897266, 383.62979724565787, 391.77081407376676, 397.9224051309995, 414.2378024435039, 16877.57806054849, 19277.0, 19287.132079056424, 19459.372984647067, 20353.898230508865, 19676.409707708757, 19959.201631934706, 20117.497062573442, 20250.39248822534, 20410.0, 5396.731768034509, 5651.208830763686, 5845.444682755153, 5919.644821310713, 5954.166416701665, 5873.1190321451695, 5908.084246941731, 5945.970270148643, 5950.404959504058, 5964.761409543613, 5708.486236238738, 5875.324337701177, 5899.410058994088, 5901.409859014086, 5938.406159384071, 5639.802606908779, 5825.417458254183, 5829.446202610745, 5863.941360586382, 5865.794697185599, 5158.458361871987, 5192.350956130484, 5203.7398130093725, 5204.557612602934, 5205.531502164823, 23856.7614323858, 24216.394590135213, 24392.39019024521, 24394.634080488806, 24414.755852441427, 2393.126508824284, 2408.6146216605257, 2514.6353778701987, 2656.468706258756, 2797.1888152435768, 14238.928805355907, 14722.0, 14768.335424905905, 15086.321115549827, 15487.303071361815, 1890.3194849854042, 1892.933747318851, 1912.4071537823181, 1924.9230030798751, 1968.8326492248177, 82643.58678206631, 83768.0, 84103.5794821022, 84342.0, 85565.14434855634, 10443.373397596017, 10470.267081304235, 10722.195835312383, 10852.837207441895, 11167.38579378142, 14855.10869347821, 14868.851311486964, 14883.70232595342, 14891.627709307353, 14894.0, 7927.643256053491, 8151.429399941947, 8157.918420815835, 8318.750437486886, 8357.122502137188, 7751.689932402754, 7799.0, 7835.177306382861, 8019.879701804478, 8020.759377218693, 6577.638229897306, 6631.535792494576, 6638.336166383419, 6687.297833727389, 6880.311968803079, 1744.6074633207427, 1787.2378642956648, 1851.3612803582741, 1854.4343975087459, 1883.990580047091, 995.7261753017978, 1012.8176928152856, 1028.3161697471098, 1058.031900810765, 1084.4902895639036, 20096.0, 20582.588348232952, 20623.659462134914, 20713.89643051775, 20927.37217883466, 1002.2433063037506, 1042.421456091861, 1069.588208539718, 1083.111848284415, 1120.7142178744532, 10838.512266948006, 11621.01633106078, 11694.649160525198, 11813.054955603531, 11835.0, 466500.0, 505094.0, 510537.0, 518472.0, 520131.0, 44317.113657726666, 47822.0, 48780.512194878305, 55686.72156639272, 81848.18151818524, 1019.5870672377699, 1042.4735508568124, 1045.7908418316367, 1083.8970297821695, 1085.0560012788924, 12743.362831858556, 17613.559661008065, 19241.90379048096, 19265.422037338903, 19291.324803631807, 27037.729622703522, 27511.17466476009, 30643.54034689437, 34814.0, 39530.2093958125, 48033.75983120062, 48744.0, 49238.0, 50067.248991265886, 50719.49280507147, 7902.802429939067, 8087.63605637736, 8226.794330141794, 8338.957630296212, 8363.330933525182, 11111.555537778399, 11972.58095966637, 12041.458134383798, 12207.816882746944, 12649.87350126487, 10853.186011049045, 11120.443977800916, 11141.331520108819, 11503.137264705014, 11613.535458581562, 10422.530986105492, 10560.471976401303, 10586.68239952772, 10653.753026634395, 10844.945775271073, 10388.948055259676, 10652.733681658021, 10733.946330268298, 11111.222214444912, 11155.83266251023, 8714.956425217833, 8742.082081381363, 8767.517786521803, 8849.0, 8965.193132618097, 9609.423434593667, 10278.856056404715, 10832.133429325477, 10885.0, 10923.750012457482], "value": 9162.309285546762, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1457.271364317841, 1505.081900040975, 1586.5399034280051, 1761.4539492757237, 1765.7792775903004, 8562.871556926644, 9222.031686672886, 9225.677101301455, 9228.492432916195, 9229.215516681083, 7936.92063079369, 8185.754427367174, 8314.833703325945, 8656.740297791077, 9053.547322633875, 2338.988305058481, 2393.617021276596, 2394.473215892501, 2395.3532546212514, 2400.3759022654062, 2385.0340612052146, 2395.532871090138, 2440.5362981033636, 2441.9877900610472, 2445.8287919845616, 2396.4607963208227, 2404.0624156578947, 2407.434252950555, 2441.59713647248, 2442.072012635205, 2303.1248125712204, 2315.733690625574, 2317.8377513574055, 2339.1345202275265, 2406.2179791567637, 2377.2511658827416, 2393.401649587603, 2400.9879950600134, 2403.795677367426, 2404.723456802473, 8804.559772011375, 8970.192682658591, 8972.730818075468, 8978.50618215998, 8986.14631609996, 5413.729313534347, 5522.061249587579, 5522.199281104217, 5529.944700552983, 5539.778408863641, 3508.105433114565, 3611.6207798181076, 3686.7234957378037, 3691.8338674759702, 3697.4453831925157, 1198.5265820001139, 1222.6576558563615, 1222.7309991801878, 1238.0405185980846, 1239.21929184614, 12218.144729868913, 12553.93723031379, 12575.811362829565, 12611.873881261161, 12641.999999999907, 4729.337892695025, 4776.188048031843, 4863.878403039882, 4919.532644398776, 4960.528749768839, 10633.415162166155, 10635.0, 10647.0, 10647.627333043307, 10652.201084918663, 5505.532029777513, 5516.889662206733, 5521.089020311603, 5521.668699878021, 5526.585506086979, 4471.597556219956, 4839.564439200489, 4934.1611925972675, 4958.826441074545, 5021.372328458942, 3998.760074395487, 4024.959750402517, 4092.5249573898222, 4111.157212771374, 4142.813573389205, 1241.1684171605045, 1249.7562975219744, 1250.3123282194756, 1279.9296038717773, 1285.7685616589104, 878.5958459108754, 973.2165606686685, 975.6536429567543, 977.0, 987.5062468765617, 5936.317323507852, 5991.55063370249, 5992.820215393545, 6054.485368743706, 6241.407066328691, 464.579555502271, 464.61669122973683, 473.29715372672246, 474.553919315842, 480.53388213432913, 4173.394857745609, 4180.143070670505, 4247.787610619456, 4263.8081286342185, 4280.379344994958, 10525.736856578493, 10649.414282214553, 10676.359418434919, 10752.677419677422, 10805.783884322427, 10328.380297182193, 10749.247552671395, 10755.56977720898, 10776.137908967265, 10797.190210734227, 8053.234942680436, 8419.284360829275, 8419.95790021046, 8422.115677853859, 8422.873656895152, 6044.0, 6158.476529495043, 6333.778317758856, 6448.322926092693, 6545.541812073109, 9348.158665720119, 9667.951660241653, 10193.286469947328, 10205.0, 10216.284860059724, 9933.65232216869, 9949.303548751517, 9950.154236889946, 10051.195904327782, 10058.949705251427, 6994.5803251805055, 7692.42306826979, 7711.151773305044, 7874.606269686607, 8026.83946321082, 8748.300135989233, 8845.159709827556, 8854.335924805537, 8858.557072146496, 8860.0, 7774.766756997299, 7831.608419578884, 7964.920350796418, 8075.313598344206, 8108.513489190667, 7527.698892044257, 7625.923740762521, 7656.081270247606, 7707.499012564165, 7749.690012399441, 6660.800175994728, 6761.154855643044, 6764.154480689914, 6769.864602708017, 6770.763023294161, 5301.310829592283, 5370.677759334452, 5404.189371594292, 5449.400565937823, 5494.615376923737, 5130.769115389742, 5174.223866420067, 5249.370075590953, 5254.842354729364, 5266.920996185137], "value": 4643.974369670345, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.40722495894914, 335.7431564852888, 340.6117026589688, 342.691577580178, 343.1541250816736, 5073.23901414788, 5093.923591146136, 5103.744812759361, 5114.335136432259, 5151.175811870102, 4897.951020489794, 4957.182064959286, 5060.139776238039, 5086.542211200991, 5105.310783044288, 4062.9187416251657, 4064.7764372959477, 4071.2061148076064, 4079.8980025499304, 4088.9182216355657, 4078.163976384834, 4098.631123198911, 4102.507699076115, 4113.362428823537, 4114.053767633446, 3861.4593956846065, 3871.477350557667, 4014.7189696721243, 4019.1358857845557, 4080.3675430308203, 4037.1521980384155, 4037.394390841368, 4044.4944381952255, 4053.3312003519386, 4063.4717486726686, 3608.170120872188, 3621.7102631789394, 3623.420252759572, 3625.1843335249623, 3630.709543236535, 4791.736454495001, 5006.822032415875, 5014.197728363444, 5028.296038554606, 5037.798488060474, 4574.4510658721165, 4580.473245576768, 4611.570413171928, 4622.976885115587, 4628.953710462886, 5328.520433161034, 5332.9334133173525, 5341.0, 5341.706206158659, 5360.892782144335, 3777.622237776228, 3893.5133108361456, 3900.8829735107993, 3915.882523524299, 3916.3733802591732, 5409.891802163935, 5555.694436805974, 5566.137248726453, 5587.100385868825, 5594.440555944454, 3974.821133048962, 3975.4235635832642, 3983.661388781928, 3990.0, 3996.100877302642, 4048.2713111640187, 4053.2704113259897, 4069.491313585802, 4069.694772892045, 4071.9796401017807, 4387.561243875651, 4587.334836448763, 4597.862064138081, 4599.632029437637, 4610.354550362952, 5398.6220964532895, 5405.675659460445, 5408.107662235766, 5408.215808707715, 5440.3135028141405, 1394.623451668044, 1399.9020068595305, 1401.1663060479, 1407.7677183264852, 1416.9372970272295, 890.692711014699, 901.5582364641278, 946.9005754395689, 958.7363475044418, 974.3325821812082, 5124.308218390544, 5156.535911767959, 5170.250313704567, 5178.275041494194, 5215.600823621101, 5414.214938833847, 5476.91784623231, 5497.670139791625, 5508.366537848199, 5552.333719953632, 4917.557419832232, 5084.872878178076, 5089.491050894881, 5232.39827419844, 5272.2355258487305, 2923.9122826315242, 2939.882844519112, 2945.926351841178, 2946.4107178563945, 2950.333061820065, 5611.494965453129, 5780.16187652788, 5794.884102318014, 5820.70896455184, 5827.619980411351, 5590.077637189818, 5612.326520817446, 5616.719164041781, 5623.240862483594, 5634.492895639412, 5671.546276297886, 5694.743736531783, 5722.914156287659, 5733.168690539848, 5743.224664670383, 5326.866828329323, 5442.972785136049, 5476.809276289516, 5485.780568777204, 5516.310461192351, 5414.35027796667, 5442.945570544244, 5445.373782015119, 5447.4824891635235, 5469.288992430958, 5697.800576979786, 5715.799947001835, 5764.279465066867, 5776.036147709799, 5776.768929242783, 3793.7670257167083, 3958.386450100239, 3961.2473630010204, 4011.1147760552494, 4042.818073186655, 5372.5433338166695, 5398.2442458056685, 5534.39121696605, 5542.556595472433, 5610.803621873215, 5394.67830381559, 5399.271098401822, 5438.483344082306, 5462.945370546244, 5508.366537848199, 5219.9217011744095, 5338.786448542171, 5352.464753524617, 5403.432639572946, 5408.405075441777, 5292.5501332387175, 5307.708076055854, 5310.575153987749, 5318.760655770577, 5322.4677532248015, 5398.1902714593125, 5410.458954104715, 5424.566034717134, 5461.918071228855, 5497.433231528995, 5037.571806396498, 5272.261883336259, 5309.946900530946, 5312.760925758427, 5313.495217954288], "value": 4130.722469800317, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [817.7669364231194, 835.5237514616667, 840.5335039053323, 857.0829212742366, 883.8585826267798, 15829.287682054306, 16868.49394518163, 16897.23962421691, 16928.4075057373, 16951.40670076546, 14932.0, 14944.626384340398, 15040.924795376035, 15057.698846023073, 15209.315580798862, 799.9680012799481, 831.8253166834971, 835.5863847395548, 843.4812590257009, 844.4215712237137, 669.926308106108, 831.0401486283353, 834.3617132893341, 834.4159088637947, 835.1898658301438, 842.1494290766309, 846.9449485783435, 849.3884403229665, 877.2017464107663, 880.0363601855958, 868.7524055644143, 871.8125602995323, 872.2672954718035, 872.9039805621377, 873.6418068591911, 511.7773768410716, 638.6934271549682, 639.1212083385345, 640.362838975218, 640.6508452893185, 12578.937105314506, 13086.86913130866, 14280.500182493666, 14884.776728349083, 14925.2537373132, 14459.927700361432, 15210.695786084327, 15763.68472630541, 16184.19079046043, 16588.83411165885, 12433.197734705192, 12467.875321246762, 12632.936835315857, 12689.492420303177, 12736.17214881039, 3972.682185425159, 3995.4606128172613, 4051.9594804051876, 4210.305299625558, 4221.577842215785, 80951.0, 82448.58775706083, 83261.58369208175, 83469.58265208696, 83542.58228708818, 11856.644300670821, 12096.69758256033, 12452.31512266834, 12452.564160254347, 12548.81176782349, 23207.3037808866, 23570.292891213292, 23578.174763883526, 23603.409914751926, 24423.511529769305, 9080.455172689528, 9104.8634270486, 9127.726168214964, 9402.623895044122, 9501.667441639509, 4700.318453824177, 4740.762961851894, 4760.785764640599, 4783.904321913542, 4811.831585894477, 3675.3751862182958, 3714.257148570297, 3790.128270497801, 3794.9430758538642, 3800.790956497364, 607.8206928955968, 629.7040391016216, 635.7965451055618, 646.9676516174172, 651.1697585578426, 711.989320160198, 718.7735863203075, 735.385210035732, 735.6542425060213, 751.8158051277472, 9823.115919567274, 10079.848802267972, 10109.44398058099, 10162.4918754062, 11031.22781405294, 656.297761395312, 715.9355657990702, 742.4060751398968, 745.4558172534081, 757.6666266842572, 4502.302143167814, 4904.681195722266, 4940.925886111711, 4945.4312754033745, 5055.848324550269, 102117.0, 105072.93468371575, 107880.46059769651, 119322.0, 127468.36265818797, 106766.0, 109880.0, 110852.89147108587, 111577.09480168317, 112996.0, 84269.15730842613, 90681.54659226662, 92821.53589232145, 100687.0, 100782.99999999853, 10051.447170405405, 10161.745956351151, 10194.439305837954, 10202.38785672862, 10307.639232626821, 34369.0, 38959.61040389673, 47635.52364476311, 48025.519744802106, 49274.50725492842, 69299.65350173217, 69895.65052174707, 73038.63480682562, 74521.62739186487, 76428.2357176421, 13657.726845463234, 13706.65733356674, 13916.234607096301, 13947.30263486842, 14334.354954027302, 15152.621184470036, 15466.226688665747, 15653.765193522335, 15756.527304180434, 15976.760348594547, 14169.433222670978, 14592.197429141499, 14763.409463621334, 14847.109173449628, 15179.772303415679, 14310.427582896984, 14360.353784079532, 14704.525728456292, 14805.925970370079, 14919.477818276308, 14589.343479543233, 14734.484293049692, 14878.851211487747, 14963.40146394132, 15737.68524629524, 11725.0, 11823.349715765715, 11839.82240266414, 11945.641630751092, 11962.162648614862, 10560.940791247054, 10598.417087059977, 10809.135269178603, 10982.62717160355, 11819.645410637695], "value": 7854.710044178157, "unit": "score"}], "name": "dromaeo_css", "value": 7274.142723205744, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 111.0, 113.0, 112.0, 112.0, 112.0, 111.0, 113.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 123.0, 148.0, 158.0, 122.0, 122.0, 144.0, 117.0, 166.0, 121.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 159.0, 162.0, 161.0, 161.0, 162.0, 159.0, 166.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 113.0, 75.0, 77.0, 74.0, 75.0, 111.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 127.0, 84.0, 84.0, 86.0, 129.0, 85.0, 85.0, 129.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 49.0, 48.0, 50.0, 52.0, 50.0, 49.0, 49.0], "value": 49.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 61.0, 61.0, 60.0, 61.0, 61.0, 60.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 82.0, 76.0, 75.0, 75.0, 75.0, 76.0, 76.0, 83.0, 80.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 122.0, 120.0, 130.0, 121.0, 129.0, 131.0, 121.0, 157.0, 124.0], "value": 127.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 163.0, 164.0, 163.0, 168.0, 159.0, 160.0, 160.0], "value": 162.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 64.0, 64.0, 65.0, 66.0, 63.0, 63.0, 62.0, 64.0], "value": 64.2, "unit": "score"}], "name": "kraken", "value": 1488.8000000000002, "alertThreshold": 2.0}]} 02:41:09 INFO - Return code: 0 02:41:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:41:09 INFO - # TBPL SUCCESS # 02:41:09 INFO - Running post-action listener: _resource_record_post_action 02:41:09 INFO - [mozharness: 2016-08-05 09:41:09.246776Z] Finished run-tests step (success) 02:41:09 INFO - Running post-run listener: _resource_record_post_run 02:41:09 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549646336; Read time: 16; Write time: 657540 02:41:09 INFO - TinderboxPrint: CPU usage
13.0% 02:41:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 02:41:09 INFO - TinderboxPrint: I/O write bytes / time
549,646,336 / 657,540 02:41:09 INFO - TinderboxPrint: CPU idle
8,293.3 (87.0%) 02:41:09 INFO - TinderboxPrint: CPU user
1,187.4 (12.5%) 02:41:09 INFO - TinderboxPrint: Swap in / out
0 / 0 02:41:09 INFO - install - Wall time: 18s; CPU: 15.0%; Read bytes: 0; Write bytes: 258551808; Read time: 0; Write time: 401236 02:41:09 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291094528; Read time: 16; Write time: 256304 02:41:09 INFO - Running post-run listener: _upload_blobber_files 02:41:09 INFO - Blob upload gear active. 02:41:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:41:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:41:09 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'] 02:41:09 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 02:41:10 INFO - (blobuploader) - INFO - Open directory for files ... 02:41:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:41:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:41:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:15 INFO - (blobuploader) - INFO - Done attempting. 02:41:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:41:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:41:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:15 INFO - (blobuploader) - INFO - Done attempting. 02:41:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:41:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:41:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:16 INFO - (blobuploader) - INFO - Done attempting. 02:41:16 INFO - (blobuploader) - INFO - Iteration through files over. 02:41:16 INFO - Return code: 0 02:41:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:41:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:41:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cae01320dd88f63515a9f3188d28ac5abc6b0553a3f96bccf39508b753c357ed4f0c01364c1112ca4b719f8746830d1a8e32912137414775f869c36d240a9085", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cce8f5a33c9821ca8fe01a3e4bfecf58d8c3b0b28531aafea2005e077c7cff3495887261bb4354571880864b052fd21e9027df274707631481ba73c256b23b6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3d2796156c260398765fb94e81a27ccbbd1e2077d46719d7de0253fef183901b96c70a3bcdb0d7d63e96a77c80b878b23b040c4b6c29953a9360d627bac4578"} 02:41:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:41:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:41:16 INFO - Contents: 02:41:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cae01320dd88f63515a9f3188d28ac5abc6b0553a3f96bccf39508b753c357ed4f0c01364c1112ca4b719f8746830d1a8e32912137414775f869c36d240a9085", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cce8f5a33c9821ca8fe01a3e4bfecf58d8c3b0b28531aafea2005e077c7cff3495887261bb4354571880864b052fd21e9027df274707631481ba73c256b23b6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3d2796156c260398765fb94e81a27ccbbd1e2077d46719d7de0253fef183901b96c70a3bcdb0d7d63e96a77c80b878b23b040c4b6c29953a9360d627bac4578"} 02:41:16 INFO - Running post-run listener: copy_logs_to_upload_dir 02:41:16 INFO - Copying logs to upload dir... 02:41:16 INFO - mkdir: /builds/slave/test/build/upload/logs 02:41:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.421004 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-08-05 02:41:15.126485) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 02:41:15.129800) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996 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/cae01320dd88f63515a9f3188d28ac5abc6b0553a3f96bccf39508b753c357ed4f0c01364c1112ca4b719f8746830d1a8e32912137414775f869c36d240a9085", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cce8f5a33c9821ca8fe01a3e4bfecf58d8c3b0b28531aafea2005e077c7cff3495887261bb4354571880864b052fd21e9027df274707631481ba73c256b23b6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3d2796156c260398765fb94e81a27ccbbd1e2077d46719d7de0253fef183901b96c70a3bcdb0d7d63e96a77c80b878b23b040c4b6c29953a9360d627bac4578"} build_url:https://queue.taskcluster.net/v1/task/NSLAre5IQraplH4aSYX9rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011335 build_url: 'https://queue.taskcluster.net/v1/task/NSLAre5IQraplH4aSYX9rg/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/cae01320dd88f63515a9f3188d28ac5abc6b0553a3f96bccf39508b753c357ed4f0c01364c1112ca4b719f8746830d1a8e32912137414775f869c36d240a9085", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cce8f5a33c9821ca8fe01a3e4bfecf58d8c3b0b28531aafea2005e077c7cff3495887261bb4354571880864b052fd21e9027df274707631481ba73c256b23b6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3d2796156c260398765fb94e81a27ccbbd1e2077d46719d7de0253fef183901b96c70a3bcdb0d7d63e96a77c80b878b23b040c4b6c29953a9360d627bac4578"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 02:41:15.156450) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 02:41:15.156860) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1470388447.609551-1387990996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004407 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 02:41:15.241430) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 02:41:15.241845) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 02:41:15.242328) ========= ========= Total master_lag: 0.42 =========