builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-049 starttime: 1470885470.61 results: success (0) buildid: 20160810173002 builduid: 456109daf319450bb6fde18e8cb67c8c revision: c4a79e57209adab8f38ca9ea9da8317bf748235a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 20:17:50.610525) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 20:17:50.611007) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 20:17:50.611330) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 20:17:50.667880) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 20:17:50.668300) ========= 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=db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-10 20:17:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 31.5M=0s 2016-08-10 20:17:51 (31.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118596 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 20:17:50.800961) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 20:17:50.801357) ========= 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=db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020102 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 20:17:50.863111) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-10 20:17:50.866583) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c4a79e57209adab8f38ca9ea9da8317bf748235a --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 c4a79e57209adab8f38ca9ea9da8317bf748235a --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=db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-10 20:17:51,561 truncating revision to first 12 chars 2016-08-10 20:17:51,561 Setting DEBUG logging. 2016-08-10 20:17:51,562 attempt 1/10 2016-08-10 20:17:51,562 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c4a79e57209a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-10 20:17:51,867 unpacking tar archive at: fx-team-c4a79e57209a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.639966 ========= master_lag: 1.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-10 20:17:52.531449) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 20:17:52.531718) ========= script_repo_revision: c4a79e57209adab8f38ca9ea9da8317bf748235a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 20:17:52.532078) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 20:17:52.532356) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 20:17:52.989177) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-08-10 20:17:52.989452) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:17:53 INFO - MultiFileLogger online at 20160810 20:17:53 in /builds/slave/test 20:17:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:17:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:17:53 INFO - {'append_to_log': False, 20:17:53 INFO - 'base_work_dir': '/builds/slave/test', 20:17:53 INFO - 'blob_upload_branch': 'Fx-Team', 20:17:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:17:53 INFO - 'branch': 'Fx-Team', 20:17:53 INFO - 'buildbot_json_path': 'buildprops.json', 20:17:53 INFO - 'config_files': ('talos/linux_config.py',), 20:17:53 INFO - 'default_actions': ('clobber', 20:17:53 INFO - 'read-buildbot-config', 20:17:53 INFO - 'download-and-extract', 20:17:53 INFO - 'populate-webroot', 20:17:53 INFO - 'create-virtualenv', 20:17:53 INFO - 'install', 20:17:53 INFO - 'run-tests'), 20:17:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:17:53 INFO - 'download_minidump_stackwalk': True, 20:17:53 INFO - 'download_symbols': 'ondemand', 20:17:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:17:53 INFO - 'tooltool.py': '/tools/tooltool.py', 20:17:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:17:53 INFO - '/tools/misc-python/virtualenv.py')}, 20:17:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:17:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:17:53 INFO - 'installer_path': 'installer.exe', 20:17:53 INFO - 'log_level': 'info', 20:17:53 INFO - 'log_name': 'talos', 20:17:53 INFO - 'log_to_console': True, 20:17:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:17:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:17:53 INFO - 'opt_config_files': (), 20:17:53 INFO - 'pip_index': False, 20:17:53 INFO - 'sps_profile': False, 20:17:53 INFO - 'sps_profile_interval': 0, 20:17:53 INFO - 'suite': 'dromaeojs-e10s', 20:17:53 INFO - 'system_bits': '32', 20:17:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:17:53 INFO - 'title': 'talos-linux64-ix-049', 20:17:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:17:53 INFO - 'use_talos_json': True, 20:17:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:17:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:17:53 INFO - 'work_dir': 'build'} 20:17:53 INFO - [mozharness: 2016-08-11 03:17:53.787804Z] Running clobber step. 20:17:53 INFO - Running pre-action listener: _resource_record_pre_action 20:17:53 INFO - Running main action method: clobber 20:17:53 INFO - rmtree: /builds/slave/test/build 20:17:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:17:54 INFO - Running post-action listener: _resource_record_post_action 20:17:54 INFO - [mozharness: 2016-08-11 03:17:54.760294Z] Finished clobber step (success) 20:17:54 INFO - [mozharness: 2016-08-11 03:17:54.760393Z] Running read-buildbot-config step. 20:17:54 INFO - Running pre-action listener: _resource_record_pre_action 20:17:54 INFO - Running main action method: read_buildbot_config 20:17:54 INFO - Using buildbot properties: 20:17:54 INFO - { 20:17:54 INFO - "project": "", 20:17:54 INFO - "product": "firefox", 20:17:54 INFO - "script_repo_revision": "production", 20:17:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:17:54 INFO - "repository": "", 20:17:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:17:54 INFO - "buildid": "20160810173002", 20:17:54 INFO - "pgo_build": "True", 20:17:54 INFO - "basedir": "/builds/slave/test", 20:17:54 INFO - "buildnumber": 665, 20:17:54 INFO - "slavename": "talos-linux64-ix-049", 20:17:54 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:17:54 INFO - "platform": "ubuntu64_hw", 20:17:54 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:17:54 INFO - "branch": "fx-team", 20:17:54 INFO - "repo_path": "integration/fx-team", 20:17:54 INFO - "revision": "c4a79e57209adab8f38ca9ea9da8317bf748235a", 20:17:54 INFO - "stage_platform": "linux64-pgo", 20:17:54 INFO - "builduid": "456109daf319450bb6fde18e8cb67c8c", 20:17:54 INFO - "slavebuilddir": "test" 20:17:54 INFO - } 20:17:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 20:17:54 INFO - Running post-action listener: _resource_record_post_action 20:17:54 INFO - [mozharness: 2016-08-11 03:17:54.763045Z] Finished read-buildbot-config step (success) 20:17:54 INFO - [mozharness: 2016-08-11 03:17:54.763133Z] Running download-and-extract step. 20:17:54 INFO - Running pre-action listener: _resource_record_pre_action 20:17:54 INFO - Running main action method: download_and_extract 20:17:54 INFO - mkdir: /builds/slave/test/build/tests 20:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:17:54 INFO - trying https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:17:54 INFO - Downloading https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/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 20:17:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/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 20:17:55 INFO - Downloaded 1361 bytes. 20:17:55 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:17:55 INFO - Using the following test package requirements: 20:17:55 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:17:55 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:17:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:17:55 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:17:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:17:55 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:17:55 INFO - u'jsshell-linux-x86_64.zip'], 20:17:55 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:17:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:17:55 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:17:55 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:17:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:17:55 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:17:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:17:55 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:17:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:17:55 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:17:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:17:55 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:17: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')]} 20:17:55 INFO - trying https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:17:55 INFO - Downloading https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/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 20:17:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/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 20:17:56 INFO - Downloaded 21832512 bytes. 20:17:56 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'] 20:17:56 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 20:17:57 INFO - Return code: 0 20:17:57 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 20:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:17:57 INFO - trying https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:17:57 INFO - Downloading https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/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 20:17:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/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 20:17:58 INFO - Downloaded 21832512 bytes. 20:17:58 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'] 20:17:58 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 20:17:59 INFO - Return code: 0 20:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:17:59 INFO - trying https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:17:59 INFO - Downloading https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/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 20:17:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/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 20:18:01 INFO - Downloaded 14413719 bytes. 20:18:01 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'] 20:18:01 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 20:18:01 INFO - Return code: 0 20:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:18:01 INFO - trying https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:18:01 INFO - Downloading https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/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 20:18:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/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 20:18:03 INFO - Downloaded 59338728 bytes. 20:18:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:18:03 INFO - mkdir: /builds/slave/test/properties 20:18:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:18:03 INFO - Writing to file /builds/slave/test/properties/build_url 20:18:03 INFO - Contents: 20:18:03 INFO - build_url:https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:18:04 INFO - Running post-action listener: _resource_record_post_action 20:18:04 INFO - Running post-action listener: set_extra_try_arguments 20:18:04 INFO - [mozharness: 2016-08-11 03:18:04.370151Z] Finished download-and-extract step (success) 20:18:04 INFO - [mozharness: 2016-08-11 03:18:04.370383Z] Running populate-webroot step. 20:18:04 INFO - Running pre-action listener: _resource_record_pre_action 20:18:04 INFO - Running main action method: populate_webroot 20:18:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:18:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:18:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:18:04 INFO - '--tppagecycles', 20:18:04 INFO - '7'], 20:18:04 INFO - 'tests': ['tsvgm']}}, 20:18:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:18:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:18:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:18:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:18:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:18:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:18:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:04 INFO - 'talos_options': ['--disable-e10s'], 20:18:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:18:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:18:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:04 INFO - 'talos_options': ['--disable-e10s'], 20:18:04 INFO - 'tests': ['damp', 'tps']}, 20:18:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:04 INFO - 'tests': ['damp', 'tps']}, 20:18:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:18:04 INFO - 'tests': ['dromaeo_dom']}, 20:18:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:18:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:18:04 INFO - 'tests': ['basic_compositor_video']}, 20:18:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:18:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:18:04 INFO - 'tests': ['a11yr', 20:18:04 INFO - 'ts_paint', 20:18:04 INFO - 'tpaint', 20:18:04 INFO - 'sessionrestore', 20:18:04 INFO - 'sessionrestore_no_auto_restore', 20:18:04 INFO - 'tabpaint']}, 20:18:04 INFO - 'other-e10s': {'tests': ['a11yr', 20:18:04 INFO - 'ts_paint', 20:18:04 INFO - 'tpaint', 20:18:04 INFO - 'sessionrestore', 20:18:04 INFO - 'sessionrestore_no_auto_restore', 20:18:04 INFO - 'tabpaint']}, 20:18:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:18:04 INFO - 'ts_paint', 20:18:04 INFO - 'tpaint', 20:18:04 INFO - 'sessionrestore', 20:18:04 INFO - 'sessionrestore_no_auto_restore', 20:18:04 INFO - 'tabpaint']}, 20:18:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:18:04 INFO - 'ts_paint', 20:18:04 INFO - 'tpaint', 20:18:04 INFO - 'sessionrestore', 20:18:04 INFO - 'sessionrestore_no_auto_restore', 20:18:04 INFO - 'tabpaint']}, 20:18:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:18:04 INFO - 'tests': ['a11yr', 20:18:04 INFO - 'ts_paint', 20:18:04 INFO - 'tpaint', 20:18:04 INFO - 'sessionrestore', 20:18:04 INFO - 'sessionrestore_no_auto_restore', 20:18:04 INFO - 'tabpaint']}, 20:18:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:18:04 INFO - 'tests': ['a11yr', 20:18:04 INFO - 'ts_paint', 20:18:04 INFO - 'tpaint', 20:18:04 INFO - 'sessionrestore', 20:18:04 INFO - 'sessionrestore_no_auto_restore', 20:18:04 INFO - 'tabpaint']}, 20:18:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:18:04 INFO - 'tests': ['tsvgx', 20:18:04 INFO - 'tsvgr_opacity', 20:18:04 INFO - 'tart', 20:18:04 INFO - 'tscrollx', 20:18:04 INFO - 'cart']}, 20:18:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:18:04 INFO - 'tsvgr_opacity', 20:18:04 INFO - 'tart', 20:18:04 INFO - 'tscrollx', 20:18:04 INFO - 'cart']}, 20:18:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:04 INFO - 'talos_options': ['--disable-e10s'], 20:18:04 INFO - 'tests': ['tp5o']}, 20:18:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:04 INFO - 'tests': ['tp5o']}, 20:18:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:04 INFO - 'talos_options': ['--disable-e10s', 20:18:04 INFO - '--xperf_path', 20:18:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:18:04 INFO - 'tests': ['tp5n']}, 20:18:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:04 INFO - 'talos_options': ['--xperf_path', 20:18:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:18:04 INFO - 'tests': ['tp5n']}}, 20:18:04 INFO - 'talos.zip': {'path': '', 20:18:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:18:04 INFO - Running post-action listener: _resource_record_post_action 20:18:04 INFO - [mozharness: 2016-08-11 03:18:04.388052Z] Finished populate-webroot step (success) 20:18:04 INFO - [mozharness: 2016-08-11 03:18:04.388140Z] Running create-virtualenv step. 20:18:04 INFO - Running pre-action listener: _resource_record_pre_action 20:18:04 INFO - Running main action method: create_virtualenv 20:18:04 INFO - Creating virtualenv /builds/slave/test/build/venv 20:18:04 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 20:18:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:18:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:18:04 INFO - Using real prefix '/usr' 20:18:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:18:04 INFO - Installing distribute.............................................................................................................................................................................................done. 20:18:06 INFO - Installing pip.................done. 20:18:06 INFO - Return code: 0 20:18:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:18:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd63b0>, '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 0x1dd72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7740>, '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': 'db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839', '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 20:18:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:18:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:18:06 INFO - Using env: {'DISPLAY': ':0', 20:18:06 INFO - 'HOME': '/home/cltbld', 20:18:06 INFO - 'LANG': 'en_US.UTF-8', 20:18:06 INFO - 'LANGUAGE': 'en_US:en', 20:18:06 INFO - 'LOGNAME': 'cltbld', 20:18:06 INFO - 'MAIL': '/var/mail/cltbld', 20:18:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:06 INFO - 'MOZ_NO_REMOTE': '1', 20:18:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:06 INFO - 'NO_EM_RESTART': '1', 20:18:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:06 INFO - 'PWD': '/builds/slave/test', 20:18:06 INFO - 'SHELL': '/bin/bash', 20:18:06 INFO - 'SHLVL': '1', 20:18:06 INFO - 'TERM': 'linux', 20:18:06 INFO - 'TMOUT': '86400', 20:18:06 INFO - 'USER': 'cltbld', 20:18:06 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839', 20:18:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:06 INFO - '_': '/tools/buildbot/bin/python'} 20:18:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:07 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 20:18:07 INFO - Cleaning up... 20:18:07 INFO - Return code: 0 20:18:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:18: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')]} 20:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18: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')]} 20:18:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:07 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 0x1b17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd63b0>, '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 0x1dd72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7740>, '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': 'db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839', '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 20:18:07 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 20:18:07 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 20:18:07 INFO - Using env: {'DISPLAY': ':0', 20:18:07 INFO - 'HOME': '/home/cltbld', 20:18:07 INFO - 'LANG': 'en_US.UTF-8', 20:18:07 INFO - 'LANGUAGE': 'en_US:en', 20:18:07 INFO - 'LOGNAME': 'cltbld', 20:18:07 INFO - 'MAIL': '/var/mail/cltbld', 20:18:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:07 INFO - 'MOZ_NO_REMOTE': '1', 20:18:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:07 INFO - 'NO_EM_RESTART': '1', 20:18:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:07 INFO - 'PWD': '/builds/slave/test', 20:18:07 INFO - 'SHELL': '/bin/bash', 20:18:07 INFO - 'SHLVL': '1', 20:18:07 INFO - 'TERM': 'linux', 20:18:07 INFO - 'TMOUT': '86400', 20:18:07 INFO - 'USER': 'cltbld', 20:18:07 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839', 20:18:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:07 INFO - '_': '/tools/buildbot/bin/python'} 20:18:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:07 INFO - Downloading/unpacking psutil>=3.1.1 20:18:07 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 20:18:07 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 20:18:07 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 20:18:07 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 20:18:07 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 20:18:07 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 20:18:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:18:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:18:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:18:09 INFO - Installing collected packages: psutil 20:18:09 INFO - Running setup.py install for psutil 20:18:09 INFO - building 'psutil._psutil_linux' extension 20:18:09 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 20:18:09 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 20:18:09 INFO - building 'psutil._psutil_posix' extension 20:18:09 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 20:18:09 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 20:18:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:18:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:18:09 INFO - Successfully installed psutil 20:18:09 INFO - Cleaning up... 20:18:09 INFO - Return code: 0 20:18:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:18:09 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')]} 20:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:09 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')]} 20:18:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:09 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 0x1b17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd63b0>, '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 0x1dd72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7740>, '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': 'db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839', '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 20:18:09 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 20:18:09 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 20:18:09 INFO - Using env: {'DISPLAY': ':0', 20:18:09 INFO - 'HOME': '/home/cltbld', 20:18:09 INFO - 'LANG': 'en_US.UTF-8', 20:18:09 INFO - 'LANGUAGE': 'en_US:en', 20:18:09 INFO - 'LOGNAME': 'cltbld', 20:18:09 INFO - 'MAIL': '/var/mail/cltbld', 20:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:09 INFO - 'MOZ_NO_REMOTE': '1', 20:18:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:09 INFO - 'NO_EM_RESTART': '1', 20:18:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:09 INFO - 'PWD': '/builds/slave/test', 20:18:09 INFO - 'SHELL': '/bin/bash', 20:18:09 INFO - 'SHLVL': '1', 20:18:09 INFO - 'TERM': 'linux', 20:18:09 INFO - 'TMOUT': '86400', 20:18:09 INFO - 'USER': 'cltbld', 20:18:09 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839', 20:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:09 INFO - '_': '/tools/buildbot/bin/python'} 20:18:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:18:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:18:12 INFO - Installing collected packages: mozsystemmonitor 20:18:12 INFO - Running setup.py install for mozsystemmonitor 20:18:12 INFO - Successfully installed mozsystemmonitor 20:18:12 INFO - Cleaning up... 20:18:12 INFO - Return code: 0 20:18:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:18:12 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')]} 20:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:12 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')]} 20:18:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:12 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 0x1b17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd63b0>, '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 0x1dd72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7740>, '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': 'db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839', '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 20:18:12 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 20:18:12 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 20:18:12 INFO - Using env: {'DISPLAY': ':0', 20:18:12 INFO - 'HOME': '/home/cltbld', 20:18:12 INFO - 'LANG': 'en_US.UTF-8', 20:18:12 INFO - 'LANGUAGE': 'en_US:en', 20:18:12 INFO - 'LOGNAME': 'cltbld', 20:18:12 INFO - 'MAIL': '/var/mail/cltbld', 20:18:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:12 INFO - 'MOZ_NO_REMOTE': '1', 20:18:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:12 INFO - 'NO_EM_RESTART': '1', 20:18:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:12 INFO - 'PWD': '/builds/slave/test', 20:18:12 INFO - 'SHELL': '/bin/bash', 20:18:12 INFO - 'SHLVL': '1', 20:18:12 INFO - 'TERM': 'linux', 20:18:12 INFO - 'TMOUT': '86400', 20:18:12 INFO - 'USER': 'cltbld', 20:18:12 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839', 20:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:12 INFO - '_': '/tools/buildbot/bin/python'} 20:18:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:12 INFO - Downloading/unpacking jsonschema==2.5.1 20:18:12 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 20:18:12 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 20:18:12 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 20:18:12 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 20:18:12 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 20:18:12 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 20:18:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:18:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:14 INFO - Downloading functools32-3.2.3-2.tar.gz 20:18:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:18:14 INFO - warning: no files found matching '*.txt' 20:18:14 INFO - no previously-included directories found matching 'build' 20:18:14 INFO - no previously-included directories found matching 'dist' 20:18:14 INFO - no previously-included directories found matching '.git*' 20:18:14 INFO - Installing collected packages: jsonschema, functools32 20:18:14 INFO - Running setup.py install for functools32 20:18:14 INFO - warning: no files found matching '*.txt' 20:18:14 INFO - no previously-included directories found matching 'build' 20:18:14 INFO - no previously-included directories found matching 'dist' 20:18:14 INFO - no previously-included directories found matching '.git*' 20:18:14 INFO - Successfully installed jsonschema functools32 20:18:14 INFO - Cleaning up... 20:18:14 INFO - Return code: 0 20:18:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:18: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')]} 20:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18: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')]} 20:18:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18: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', '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 0x1b17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd63b0>, '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 0x1dd72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7740>, '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': 'db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839', '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 20:18: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:18: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 functools32==3.2.3-2 20:18:14 INFO - Using env: {'DISPLAY': ':0', 20:18:14 INFO - 'HOME': '/home/cltbld', 20:18:14 INFO - 'LANG': 'en_US.UTF-8', 20:18:14 INFO - 'LANGUAGE': 'en_US:en', 20:18:14 INFO - 'LOGNAME': 'cltbld', 20:18:14 INFO - 'MAIL': '/var/mail/cltbld', 20:18:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:14 INFO - 'MOZ_NO_REMOTE': '1', 20:18:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:14 INFO - 'NO_EM_RESTART': '1', 20:18:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:14 INFO - 'PWD': '/builds/slave/test', 20:18:14 INFO - 'SHELL': '/bin/bash', 20:18:14 INFO - 'SHLVL': '1', 20:18:14 INFO - 'TERM': 'linux', 20:18:14 INFO - 'TMOUT': '86400', 20:18:14 INFO - 'USER': 'cltbld', 20:18:14 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839', 20:18:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:14 INFO - '_': '/tools/buildbot/bin/python'} 20:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:18:15 INFO - Cleaning up... 20:18:15 INFO - Return code: 0 20:18:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd63b0>, '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 0x1dd72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7740>, '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': 'db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839', '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 20:18:15 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 20:18:15 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 20:18:15 INFO - Using env: {'DISPLAY': ':0', 20:18:15 INFO - 'HOME': '/home/cltbld', 20:18:15 INFO - 'LANG': 'en_US.UTF-8', 20:18:15 INFO - 'LANGUAGE': 'en_US:en', 20:18:15 INFO - 'LOGNAME': 'cltbld', 20:18:15 INFO - 'MAIL': '/var/mail/cltbld', 20:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:15 INFO - 'MOZ_NO_REMOTE': '1', 20:18:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:15 INFO - 'NO_EM_RESTART': '1', 20:18:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:15 INFO - 'PWD': '/builds/slave/test', 20:18:15 INFO - 'SHELL': '/bin/bash', 20:18:15 INFO - 'SHLVL': '1', 20:18:15 INFO - 'TERM': 'linux', 20:18:15 INFO - 'TMOUT': '86400', 20:18:15 INFO - 'USER': 'cltbld', 20:18:15 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839', 20:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:15 INFO - '_': '/tools/buildbot/bin/python'} 20:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:15 INFO - Downloading/unpacking blobuploader==1.2.4 20:18:15 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 20:18:15 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 20:18:15 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 20:18:15 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 20:18:15 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 20:18:15 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 20:18:17 INFO - Downloading blobuploader-1.2.4.tar.gz 20:18:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:18:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:18:17 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 20:18:17 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 20:18:17 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 20:18:17 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 20:18:17 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 20:18:17 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 20:18:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:18:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:18:17 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 20:18:17 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 20:18:17 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 20:18:17 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 20:18:17 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 20:18:17 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 20:18:17 INFO - Downloading docopt-0.6.1.tar.gz 20:18:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:18:17 INFO - Installing collected packages: blobuploader, requests, docopt 20:18:17 INFO - Running setup.py install for blobuploader 20:18:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:18:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:18:17 INFO - Running setup.py install for requests 20:18:18 INFO - Running setup.py install for docopt 20:18:18 INFO - Successfully installed blobuploader requests docopt 20:18:18 INFO - Cleaning up... 20:18:18 INFO - Return code: 0 20:18:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:18 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 0x1b17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd63b0>, '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 0x1dd72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7740>, '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': 'db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839', '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 20:18:18 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 20:18:18 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 20:18:18 INFO - Using env: {'DISPLAY': ':0', 20:18:18 INFO - 'HOME': '/home/cltbld', 20:18:18 INFO - 'LANG': 'en_US.UTF-8', 20:18:18 INFO - 'LANGUAGE': 'en_US:en', 20:18:18 INFO - 'LOGNAME': 'cltbld', 20:18:18 INFO - 'MAIL': '/var/mail/cltbld', 20:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:18 INFO - 'MOZ_NO_REMOTE': '1', 20:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:18 INFO - 'NO_EM_RESTART': '1', 20:18:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:18 INFO - 'PWD': '/builds/slave/test', 20:18:18 INFO - 'SHELL': '/bin/bash', 20:18:18 INFO - 'SHLVL': '1', 20:18:18 INFO - 'TERM': 'linux', 20:18:18 INFO - 'TMOUT': '86400', 20:18:18 INFO - 'USER': 'cltbld', 20:18:18 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839', 20:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:18 INFO - '_': '/tools/buildbot/bin/python'} 20:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:18:18 INFO - Running setup.py (path:/tmp/pip-CQJELO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:18:18 INFO - Running setup.py (path:/tmp/pip-Z8bzP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:18:18 INFO - Running setup.py (path:/tmp/pip-5UoC_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:18:18 INFO - Running setup.py (path:/tmp/pip-18JUea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:18:18 INFO - Running setup.py (path:/tmp/pip-zfnllB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:18:19 INFO - Running setup.py (path:/tmp/pip-6ZVlXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:18:19 INFO - Running setup.py (path:/tmp/pip-OGZejF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:18:19 INFO - Running setup.py (path:/tmp/pip-Czm10I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:18:19 INFO - Running setup.py (path:/tmp/pip-vqZFsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:18:19 INFO - Running setup.py (path:/tmp/pip-cSyyQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:18:19 INFO - Running setup.py (path:/tmp/pip-ChTxqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:18:19 INFO - Running setup.py (path:/tmp/pip-UMM38O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:18:19 INFO - Running setup.py (path:/tmp/pip-J1Ig2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:18:19 INFO - Running setup.py (path:/tmp/pip-xkR5nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:18:19 INFO - Running setup.py (path:/tmp/pip-SGRVBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:18:19 INFO - Running setup.py (path:/tmp/pip-gRW4IP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:18:19 INFO - Running setup.py (path:/tmp/pip-QhUNWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:18:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:18:19 INFO - Running setup.py install for manifestparser 20:18:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:18:20 INFO - Running setup.py install for mozcrash 20:18:20 INFO - Running setup.py install for mozdebug 20:18:20 INFO - Running setup.py install for mozdevice 20:18:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:18:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:18:20 INFO - Running setup.py install for mozfile 20:18:20 INFO - Running setup.py install for mozhttpd 20:18:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:18:20 INFO - Running setup.py install for mozinfo 20:18:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:18:20 INFO - Running setup.py install for mozInstall 20:18:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:18:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:18:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:18:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:18:20 INFO - Running setup.py install for mozleak 20:18:20 INFO - Running setup.py install for mozlog 20:18:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:18:20 INFO - Running setup.py install for moznetwork 20:18:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:18:21 INFO - Running setup.py install for mozprocess 20:18:21 INFO - Running setup.py install for mozprofile 20:18:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:18:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:18:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:18:21 INFO - Running setup.py install for mozrunner 20:18:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:18:21 INFO - Running setup.py install for mozscreenshot 20:18:21 INFO - Running setup.py install for moztest 20:18:21 INFO - Running setup.py install for mozversion 20:18:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:18:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:18:21 INFO - Cleaning up... 20:18:21 INFO - Return code: 0 20:18:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:18:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:21 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 0x1b17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd63b0>, '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 0x1dd72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7740>, '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': 'db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839', '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 20:18:21 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 20:18:21 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 20:18:21 INFO - Using env: {'DISPLAY': ':0', 20:18:21 INFO - 'HOME': '/home/cltbld', 20:18:21 INFO - 'LANG': 'en_US.UTF-8', 20:18:21 INFO - 'LANGUAGE': 'en_US:en', 20:18:21 INFO - 'LOGNAME': 'cltbld', 20:18:21 INFO - 'MAIL': '/var/mail/cltbld', 20:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:21 INFO - 'MOZ_NO_REMOTE': '1', 20:18:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:21 INFO - 'NO_EM_RESTART': '1', 20:18:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:21 INFO - 'PWD': '/builds/slave/test', 20:18:21 INFO - 'SHELL': '/bin/bash', 20:18:21 INFO - 'SHLVL': '1', 20:18:21 INFO - 'TERM': 'linux', 20:18:21 INFO - 'TMOUT': '86400', 20:18:21 INFO - 'USER': 'cltbld', 20:18:21 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839', 20:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:21 INFO - '_': '/tools/buildbot/bin/python'} 20:18:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:18:21 INFO - Running setup.py (path:/tmp/pip-a5tJRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:18:22 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)) 20:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:18:22 INFO - Running setup.py (path:/tmp/pip-OEvSgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:18:22 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)) 20:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:18:22 INFO - Running setup.py (path:/tmp/pip-oDZAX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:18:22 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)) 20:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:18:22 INFO - Running setup.py (path:/tmp/pip-VRPpjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:18:22 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)) 20:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:18:22 INFO - Running setup.py (path:/tmp/pip-_YcE3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:18:22 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)) 20:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:18:22 INFO - Running setup.py (path:/tmp/pip-VGN83Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:18:22 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)) 20:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:18:22 INFO - Running setup.py (path:/tmp/pip-jMsnrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:18:22 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)) 20:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:18:22 INFO - Running setup.py (path:/tmp/pip-rm8VIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:18:22 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)) 20:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:18:22 INFO - Running setup.py (path:/tmp/pip-004XUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:18:22 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)) 20:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:18:22 INFO - Running setup.py (path:/tmp/pip-xVf17D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:18:22 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)) 20:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:18:22 INFO - Running setup.py (path:/tmp/pip-T_hMkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:18:22 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)) 20:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:18:22 INFO - Running setup.py (path:/tmp/pip-5hbYUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:18:22 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)) 20:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:18:22 INFO - Running setup.py (path:/tmp/pip-FtQtye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:18:22 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)) 20:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:18:22 INFO - Running setup.py (path:/tmp/pip-5yqwyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:18:22 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)) 20:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:18:22 INFO - Running setup.py (path:/tmp/pip-1zFXjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:18:23 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)) 20:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:18:23 INFO - Running setup.py (path:/tmp/pip-pIJd2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:18:23 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)) 20:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:18:23 INFO - Running setup.py (path:/tmp/pip-Z6i6zL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:18:23 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)) 20:18:23 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)) 20:18:23 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)) 20:18:23 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)) 20:18:23 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)) 20:18:23 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)) 20:18:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:18:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:18:25 INFO - Downloading blessings-1.6.tar.gz 20:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:18:25 INFO - Installing collected packages: blessings 20:18:25 INFO - Running setup.py install for blessings 20:18:25 INFO - Successfully installed blessings 20:18:25 INFO - Cleaning up... 20:18:25 INFO - Return code: 0 20:18:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:18:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:18:25 INFO - Reading from file tmpfile_stdout 20:18:25 INFO - Current package versions: 20:18:25 INFO - argparse == 1.2.1 20:18:25 INFO - blessings == 1.6 20:18:25 INFO - blobuploader == 1.2.4 20:18:25 INFO - docopt == 0.6.1 20:18:25 INFO - functools32 == 3.2.3-2 20:18:25 INFO - jsonschema == 2.5.1 20:18:25 INFO - manifestparser == 1.1 20:18:25 INFO - mozInstall == 1.12 20:18:25 INFO - mozcrash == 0.17 20:18:25 INFO - mozdebug == 0.1 20:18:25 INFO - mozdevice == 0.48 20:18:25 INFO - mozfile == 1.2 20:18:25 INFO - mozhttpd == 0.7 20:18:25 INFO - mozinfo == 0.9 20:18:25 INFO - mozleak == 0.1 20:18:25 INFO - mozlog == 3.3 20:18:25 INFO - moznetwork == 0.27 20:18:25 INFO - mozprocess == 0.23 20:18:25 INFO - mozprofile == 0.28 20:18:25 INFO - mozrunner == 6.12 20:18:25 INFO - mozscreenshot == 0.1 20:18:25 INFO - mozsystemmonitor == 0.3 20:18:25 INFO - moztest == 0.7 20:18:25 INFO - mozversion == 1.4 20:18:25 INFO - psutil == 3.1.1 20:18:25 INFO - requests == 1.2.3 20:18:25 INFO - wsgiref == 0.1.2 20:18:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:18:25 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')]} 20:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:25 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')]} 20:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:25 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 0x1b17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd63b0>, '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 0x1dd72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7740>, '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': 'db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839', '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 20:18:25 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 20:18:25 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 20:18:25 INFO - Using env: {'DISPLAY': ':0', 20:18:25 INFO - 'HOME': '/home/cltbld', 20:18:25 INFO - 'LANG': 'en_US.UTF-8', 20:18:25 INFO - 'LANGUAGE': 'en_US:en', 20:18:25 INFO - 'LOGNAME': 'cltbld', 20:18:25 INFO - 'MAIL': '/var/mail/cltbld', 20:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:25 INFO - 'MOZ_NO_REMOTE': '1', 20:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:25 INFO - 'NO_EM_RESTART': '1', 20:18:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:25 INFO - 'PWD': '/builds/slave/test', 20:18:25 INFO - 'SHELL': '/bin/bash', 20:18:25 INFO - 'SHLVL': '1', 20:18:25 INFO - 'TERM': 'linux', 20:18:25 INFO - 'TMOUT': '86400', 20:18:25 INFO - 'USER': 'cltbld', 20:18:25 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839', 20:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:25 INFO - '_': '/tools/buildbot/bin/python'} 20:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:25 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)) 20:18:25 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)) 20:18:25 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)) 20:18:25 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)) 20:18:25 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)) 20:18:25 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)) 20:18:25 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)) 20:18:25 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)) 20:18:25 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)) 20:18:25 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)) 20:18:25 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)) 20:18:25 INFO - Cleaning up... 20:18:25 INFO - Return code: 0 20:18:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:18:25 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')]} 20:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:25 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')]} 20:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:25 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 0x1b17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd63b0>, '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 0x1dd72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7740>, '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': 'db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839', '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 20:18:25 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 20:18:25 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 20:18:25 INFO - Using env: {'DISPLAY': ':0', 20:18:25 INFO - 'HOME': '/home/cltbld', 20:18:25 INFO - 'LANG': 'en_US.UTF-8', 20:18:25 INFO - 'LANGUAGE': 'en_US:en', 20:18:25 INFO - 'LOGNAME': 'cltbld', 20:18:25 INFO - 'MAIL': '/var/mail/cltbld', 20:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:25 INFO - 'MOZ_NO_REMOTE': '1', 20:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:25 INFO - 'NO_EM_RESTART': '1', 20:18:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:25 INFO - 'PWD': '/builds/slave/test', 20:18:25 INFO - 'SHELL': '/bin/bash', 20:18:25 INFO - 'SHLVL': '1', 20:18:25 INFO - 'TERM': 'linux', 20:18:25 INFO - 'TMOUT': '86400', 20:18:25 INFO - 'USER': 'cltbld', 20:18:25 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839', 20:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:25 INFO - '_': '/tools/buildbot/bin/python'} 20:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:18:26 INFO - Cleaning up... 20:18:26 INFO - Return code: 0 20:18:26 INFO - Running post-action listener: _resource_record_post_action 20:18:26 INFO - Running post-action listener: _start_resource_monitoring 20:18:26 INFO - Starting resource monitoring. 20:18:26 INFO - [mozharness: 2016-08-11 03:18:26.042288Z] Finished create-virtualenv step (success) 20:18:26 INFO - [mozharness: 2016-08-11 03:18:26.042742Z] Running install step. 20:18:26 INFO - Running pre-action listener: _resource_record_pre_action 20:18:26 INFO - Running main action method: install 20:18:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:18:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:18:26 INFO - Reading from file tmpfile_stdout 20:18:26 INFO - Detecting whether we're running mozinstall >=1.0... 20:18:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:18:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:18:26 INFO - Reading from file tmpfile_stdout 20:18:26 INFO - Output received: 20:18:26 INFO - Usage: mozinstall [options] installer 20:18:26 INFO - Options: 20:18:26 INFO - -h, --help show this help message and exit 20:18:26 INFO - -d DEST, --destination=DEST 20:18:26 INFO - Directory to install application into. [default: 20:18:26 INFO - "/builds/slave/test"] 20:18:26 INFO - --app=APP Application being installed. [default: firefox] 20:18:26 INFO - mkdir: /builds/slave/test/build/application 20:18:26 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'] 20:18:26 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 20:18:43 INFO - Reading from file tmpfile_stdout 20:18:43 INFO - Output received: 20:18:43 INFO - /builds/slave/test/build/application/firefox/firefox 20:18:43 INFO - Running post-action listener: _resource_record_post_action 20:18:43 INFO - [mozharness: 2016-08-11 03:18:43.226181Z] Finished install step (success) 20:18:43 INFO - [mozharness: 2016-08-11 03:18:43.226521Z] Running run-tests step. 20:18:43 INFO - Running pre-action listener: _resource_record_pre_action 20:18:43 INFO - Running main action method: run_tests 20:18:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:18:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:18:43 INFO - Python 2.7.3 20:18:43 INFO - Return code: 0 20:18:43 INFO - grabbing minidump binary from tooltool 20:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:18:43 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 0x1dd63b0>, '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 0x1dd72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:18:43 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 20:18:43 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 20:18:43 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 20:18:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:18:43 INFO - Return code: 0 20:18:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:18:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:18:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:18:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:18:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:18:43 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:18:43 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:18:43 INFO - Using env: {'DISPLAY': ':0', 20:18:43 INFO - 'HOME': '/home/cltbld', 20:18:43 INFO - 'LANG': 'en_US.UTF-8', 20:18:43 INFO - 'LANGUAGE': 'en_US:en', 20:18:43 INFO - 'LOGNAME': 'cltbld', 20:18:43 INFO - 'MAIL': '/var/mail/cltbld', 20:18:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:18:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:18:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:43 INFO - 'MOZ_NO_REMOTE': '1', 20:18:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:18:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:43 INFO - 'NO_EM_RESTART': '1', 20:18:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:43 INFO - 'PWD': '/builds/slave/test', 20:18:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:18:43 INFO - 'SHELL': '/bin/bash', 20:18:43 INFO - 'SHLVL': '1', 20:18:43 INFO - 'TERM': 'linux', 20:18:43 INFO - 'TMOUT': '86400', 20:18:43 INFO - 'USER': 'cltbld', 20:18:43 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839', 20:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:43 INFO - '_': '/tools/buildbot/bin/python'} 20:18:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:18:43 INFO - mozversion application_buildid: 20160810173002 20:18:43 INFO - mozversion application_changeset: c4a79e57209adab8f38ca9ea9da8317bf748235a 20:18:43 INFO - mozversion application_display_name: Nightly 20:18:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:18:43 INFO - mozversion application_name: Firefox 20:18:43 INFO - mozversion application_remotingname: firefox 20:18:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:18:43 INFO - mozversion application_vendor: Mozilla 20:18:43 INFO - mozversion application_version: 51.0a1 20:18:43 INFO - mozversion platform_buildid: 20160810173002 20:18:43 INFO - mozversion platform_changeset: c4a79e57209adab8f38ca9ea9da8317bf748235a 20:18:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:18:43 INFO - mozversion platform_version: 51.0a1 20:18:43 INFO - using testdate: 1470885523 20:18:43 INFO - actual date: 1470885523 20:18:43 INFO - starting webserver on 'localhost:34017' 20:18:43 INFO - SUITE-START | Running 2 tests 20:18:43 INFO - TEST-START | dromaeo_css 20:18:43 INFO - operating with platform_type : linux_ 20:18:43 INFO - Initialising browser for dromaeo_css test... 20:18:43 INFO - TEST-INFO | started process 1932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdFli69/profile http://localhost:34017/getInfo.html) 20:18:47 INFO - PROCESS | 1932 | __metrics Screen width/height:1600/1200 20:18:47 INFO - PROCESS | 1932 | colorDepth:24 20:18:47 INFO - PROCESS | 1932 | Browser inner width/height: 1024/697 20:18:47 INFO - PROCESS | 1932 | __metrics 20:18:48 ERROR - PROCESS | 1932 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 20:18:49 INFO - TEST-INFO | 1932: exit 0 20:18:49 INFO - Browser initialized. 20:18:49 INFO - Running cycle 1/1 for dromaeo_css test... 20:18:49 INFO - TEST-INFO | started process 2057 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdFli69/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:19:01 INFO - PROCESS | 2057 | RSS: Main: 162836480 20:19:01 INFO - PROCESS | 2057 | 20:19:51 INFO - PROCESS | 2057 | 1470885591006 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] 20:22:00 INFO - PROCESS | 2057 | Cycle 1(1): loaded http://localhost:34017/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34017/tests/dromaeo/cssquery-ext.html) 20:22:01 INFO - PROCESS | 2057 | RSS: Main: 165605376 20:22:01 INFO - PROCESS | 2057 | 20:25:04 INFO - PROCESS | 2057 | Cycle 1(1): loaded http://localhost:34017/tests/dromaeo/cssquery-ext.html (next: http://localhost:34017/tests/dromaeo/cssquery-jquery.html) 20:25:04 INFO - PROCESS | 2057 | RSS: Main: 163946496 20:25:04 INFO - PROCESS | 2057 | 20:28:06 INFO - PROCESS | 2057 | Cycle 1(1): loaded http://localhost:34017/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34017/tests/dromaeo/cssquery-mootools.html) 20:28:07 INFO - PROCESS | 2057 | RSS: Main: 168882176 20:28:07 INFO - PROCESS | 2057 | 20:31:09 INFO - PROCESS | 2057 | Cycle 1(1): loaded http://localhost:34017/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34017/tests/dromaeo/cssquery-prototype.html) 20:31:09 INFO - PROCESS | 2057 | RSS: Main: 162983936 20:31:09 INFO - PROCESS | 2057 | 20:34:12 INFO - PROCESS | 2057 | Cycle 1(1): loaded http://localhost:34017/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34017/tests/dromaeo/cssquery-yui.html) 20:34:12 INFO - PROCESS | 2057 | RSS: Main: 165277696 20:34:12 INFO - PROCESS | 2057 | 20:37:15 INFO - PROCESS | 2057 | Cycle 1(1): loaded http://localhost:34017/tests/dromaeo/cssquery-yui.html (next: http://localhost:34017/tests/dromaeo/cssquery-dojo.html) 20:37:15 INFO - PROCESS | 2057 | RSS: Main: 168849408 20:37:15 INFO - PROCESS | 2057 | 20:37:15 INFO - PROCESS | 2057 | __start_tp_report 20:37:15 INFO - PROCESS | 2057 | _x_x_mozilla_page_load 20:37:15 INFO - PROCESS | 2057 | _x_x_mozilla_page_load_details 20:37:15 INFO - PROCESS | 2057 | |i|pagename|runs| 20:37:15 INFO - PROCESS | 2057 | |0;dojo.html;3060.8163510189383;3080.8921687740935;3102.860371283293;3111.6421611514684;3113.12832406926;5297.841064768054;5456.208849716793;5493.890122197554;5539.224508568804;5560;5361.812336568221;5378.300820893288;5486.890262194754;5490.149026900826;5577.749001294941;4978.303037574742;4990.0019996000765;5135.51212634801;5148.948510514903;5156.742162891859;5014.423341315759;5124.92312615311;5222.321098257221;5235.6596821206695;5254.395744489375;4913.140200464904;5050.242463630485;5057.317262169634;5113.437521872591;5128.692278463285;4937.753112344404;5005.449400565934;5011.6241281904;5024.472430394792;5061.063703214917;4967.130752118364;4971.751412429364;4981.526754958273;4990.72551009698;5040.873978150539;5312.2828418163435;5426.9185962210595;5427.240186373911;5441.483059109379;5494.752736126884;5879.647221166701;5937.109433584954;5939.970300148515;5954.255718035246;5980.461758441761;5958.136070269787;5970.462658360769;5977;5982.880342393128;5995.940040599582;5318.414974352818;5437.293151890308;5550.8057217997175;5556.6943818089585;5576.10782274834;5992;6075.544334174866;6083.726232319556;6118.051701986199;6125.295591007091;5829.766809327664;5839.854003649858;5840.620359676607;5840.620359676607;5847.26909136358;5684.346300175533;5765.798197063083;5899.498542623839;5909;5931.911021334683;5618.971905140448;5753;5775.971120144372;5841.649501029951;5911.113332999998;5830.096335068071;5912.556558258062;5923.318818335861;5925.377835327315;5960.880782384328;4517.81928722854;4525.140223357552;4526.162659907927;4526.388937493462;4563.247064234364;3874.4382064600477;3931.9606803932165;3954.7231693781737;3957.3470377387407;3981.3231750602467;5537.833864984057;5576.97211513948;5629.971850140805;5630.831075067755;5674.574406919498;5917.349091599921;5928.822135335947;5948.078047902582;5955.583109182316;5961.225040744675;5396.163594642837;5559.277293951841;5566.248556444909;5598.076317407664;5608.831735047955;5088;5112.616553758483;5116.513931176607;5118.411382690963;5150;6082.0876868469195;6106.236720409949;6135.84660383494;6145.9692701536205;6151.96924015377;5704.657720536781;5849;5859.531237500904;5877.73550190251;5949.940500594938;6081.574289799849;6082.9695851520455;6095.847603809941;6102.908456373247;6117.816465506042;5805.071188609802;5808;5817.447342502455;5823.4176582343125;5825.621334613236;5730.455606717355;5835.299764028344;5890.617109887844;5891.351951285441;5914.792982245773;5694.316681998187;5723.227364305932;5783.306003279633;5787.045137552257;5826.679532625577;5706.657600543981;5738.540916726568;5752.942470575408;5773.6824474654295;5774.249347584787;5508.063629183129;5711.914321285101;5749.8562535936935;5759.395263497272;5781.132830075354;5800.680962546931;5818.069108942549;5854.677992710272;5861.677607731615;5868.943590153814;5702.258706368146;5718.056520674042;5718.228039214653;5721.8569535761935;5728.598998070095 20:37:15 INFO - PROCESS | 2057 | |1;ext.html;527.7994362142385;566.4788394676897;578.1241419249834;580.6835274775249;593.3650993437021;27919.16242512725;28554.428911421786;42028.15943681124;43719.56280437195;43833.12333753323;43841.34237986433;44347.77826110865;44352;44431.55568444315;44697.329540056926;8877.778055548632;8976.237019853288;9016.54917254138;9031.548422578877;9058;8910.198082172603;8912.420692654989;8928.910710892906;8978.955105224497;8983.14660107292;8949.955250223773;9017.864732028993;9026.368154229174;9028.68399606014;9052.683156089506;8968.327375446868;8974.820503589957;8989.685361012365;9036.728898133033;9047.185753282236;8813.603387847497;8853.24747396472;8868.822623547492;8882.644694212224;8929.151730585583;41452.170956580696;42017.369739453934;42078.789606051774;42092;42266.78866605678;3566.286742651454;3567.4470457079196;3630.6550877666577;3697.6487233713024;4191.622753952129;32434;32602.347953040808;32665.673343266502;32699.836500817342;33916.15209619755;4217.240896638604;4307.461567304087;4358.8910277243;4365.257906155929;4495.64034877209;336356;338064;339686;340836.9999999975;341079.2946035279;54818.725906370215;55582;55590.44409555852;55591.44408555944;55614.44385556174;36379.27241455156;37553.81223093867;37640.43539346912;38821.80589097093;38858.6114138855;17075.48773536796;17143.57141071483;17150.914245428943;17154.828451715322;17240.568985775204;13040.217586944813;13100.279484628247;13175.868241317656;13186.934065329804;13229.272390018448;19000;19012.904935475235;19110.61778764445;19189.424317270503;19241.422757317025;7181.461390395742;7331.706731730671;7359.595222262827;7446.255374462618;7480.606206014023;1007.2495990487134;1078.008232426154;1139.9512448547357;1139.9943000284945;1143.5368675686361;32337.51493727596;32561.348773024405;33063.50404743931;33116.3376732464;33660.326793463995;1102.729831191347;1117.201201141188;1121.43928035982;1128.8193888977723;1139.9911078695413;17126.743098853527;17405.129743512774;17464.476065717794;17484;17543.912280438515;524778;530824;531259;532220;537734;57755.13367299494;57764;57773.13340299899;57791.422085778606;58612.41387586155;1325.8674132586857;1368.945242190321;1374.9862501374857;1377.7037936843626;1394.7350003499303;30519.120635507148;32211.838940805144;32271.193220169684;32794.1801454956;32831.83584082064;50254.74872625613;50368.74815625898;50415.24377134273;50655.74672126616;50816.491835082656;443323;443453;444388;444479.33124012663;446301;28099.859500702365;29142.648595410952;29168;29176.416471670873;29223.123306300844;46706.76646616745;47619.523804761506;47917.5208247913;48092.27861582009;48720;40011.199776003734;41389.1722165561;41426.792866035474;42094.78952605218;42709.78645106754;42041.78979105085;42309.15381692287;42340;43088;43373.13253734971;35942.640573593926;38128.42807357836;40705.592944071366;41826.79086604548;41906.37140442957;34513.685789276344;36462.4530632046;37404.43893341548;37705.81147094247;40484.39273410842;28547.220685496228;28618.85690571534;29001.85499072491;29118;29325.56011659784 20:37:15 INFO - PROCESS | 2057 | |2;jquery.html;382.34618801848836;385.8610900075972;388.0434728394507;397.17586009031265;411.522633744856;14065.507707230248;18926.621467570658;19594.216231350765;20398.286059987902;20415.693764593525;19227;19475.805241947575;19513.90243048783;20258.290959816408;20415.795842041574;5791.305043394798;5809.128630705386;6022.217111775463;6035.969820150915;6071.3625069367745;6082.635041897478;6098.695065246742;6123.295820980599;6164.291106522763;6164.691765411734;5924.970375148118;6149.631022138664;6194.907076393858;6196.81409557714;6205.0692396140485;5986.2517185351835;6102.847428814271;6162.7534898604;6181.845453863667;6199.225096862892;5919.5560332974765;5942.3166335871065;5948.464638182584;5953.851153721148;5963.2844058713235;14651.12093274407;17030.063346515937;20528.38414847542;24021.519569608685;24700.505989880283;2296.988515057414;2308.0883051194683;2313.502596941649;2371.5849726298;2991.536311871663;10364.948175259151;10439.739006524822;10589.9470502647;11039.172062095375;11089.611863584736;1932.2077948041235;1958.7355706979517;2000.649886269897;2030.8375329973567;2033.186725309873;88296;90353.54823225907;91174.54412727893;92269;92697;10960.725981850359;11126.554937802397;11127.944360278147;11146.832797508045;11354.148438867118;15866.52400427989;15875.603109922344;15878;15931.36274549005;15937.521874343789;8173.754787356389;8355.540445275568;8357;8531.65873365071;8626.39615226928;8051.4766540174705;8157.510549367057;8171.387145964077;8335.458195217412;8413.537255451009;4746.315058154306;4812.302216178635;4848.733319667382;4866.081963344569;4964.503549645079;1947.123794292574;1996.4709352021725;2001.9799802001794;2019.5859848730975;2066.917323307051;922.9907700923039;949.3212353167519;975.6097560975667;987.2496902354119;1000.5097502223858;18672.906635466737;20352.49118772013;20577.38267851967;20743.831350315493;21137.68293475599;947.5215016416665;993.8111758765812;1007.9496025198857;1009.9293049486465;1037.7613148975777;10673.679789606324;11478.94260528692;11539.36533490666;11671.35807530577;11718.296902185895;456665;461964;464672;465196;476759;87869.1213087861;88598.55700721584;90027;93793.5310323444;100562.4971875136;955.3312681123102;960.6829746183743;985.2905907746411;992.2310209587628;999.4552968632113;17537.035463049655;18483.815161848208;18643.90678046601;18742.437726868215;18858.24567017304;31420.214494637818;35978.64021359858;44918.77540612276;45098.09803803971;46119.76940115278;60170.09744853743;61927.665063446926;62875.37124628695;65847;66049.33950660432;8160.306373958043;8283.875741863998;8427.915720842713;8462.536166816175;8485.40602157843;11154.442277885912;13322.134061285986;13329.200247985153;13346.466141354236;13501.189928604315;11453.656390308304;11477;11650.242734222249;11930.642080737593;12464.252144871336;11209.215354925076;11404.82892756626;11574.88425115738;11880.46537905779;12105.455254513392;11726.179167458196;11826.467808948446;11867.703307417383;12070.939645301718;12571.18287311322;7431.29402706742;7560.697572097274;7647.694092236471;8090.797730056795;8100.594970251346;9055.18503334703;11748.471318790504;12228.510859565518;12289.56986505468;12305.26168429897 20:37:15 INFO - PROCESS | 2057 | |3;mootools.html;1398.112198753791;1444.6966137111206;1558.633721075547;1792.0502133869054;1794.3630011345972;8081.474704144227;8587.098354672748;8688.218060374566;9373.390729602572;9376.437413755179;8963.058878817728;9173.403728757627;9237.214836738869;9237.49193794341;9240.491772952502;2376.5603363377786;2411.2886698423918;2417.069428270111;2417.468157005456;2425.1027119965547;2321.8606883586954;2350.3066595354326;2363.858168509886;2367.715874095102;2374.8693821839793;2390.366552863484;2401.5797235483806;2408.95182096358;2422.648715936188;2423.151896836102;2286.074139973297;2307.665388518672;2350.2831636350907;2386.904523819045;2391.5934291170543;2260.525289689167;2261.683364328995;2282.132789539964;2287.645414960684;2297.0696867768415;9322;9378.812423751488;9392.29557783169;9402.059794020543;9448.338616296862;5206.427292997767;5332.440093790174;5354.9196762048605;5370.785168593252;5393.83818485446;3434.9180008297308;3452.1197094740933;3504.26410453805;3547.5742910850604;3553.733469989735;1115.8828323026128;1116.5589592111153;1120.5181771838106;1121.0975164992178;1123.3709122891207;12841.84423401889;12855.485780568766;12885.420156092998;12894.161879477897;12941.417636206394;4332.393464914914;4498.797554110073;4597.126545956325;4663.603593694506;4685.250359942393;10677.199210059121;10688.038076573146;10720.46397680113;10804.567817287378;10824.268117101226;5309.469053094737;5365.195220716923;5379.112446446293;5396.379416367168;5403.540699040625;4330.069035157457;4745.145873742759;4847.127517046965;4869.63477739171;4896.338994235733;4087.2438598859308;4094.2220978014084;4109.950457801205;4120.587941205916;4207.074443622399;1273.8726127387372;1310.33173081729;1312.7637025335341;1316.5918565244804;1327.8141060251573;750.6697053296532;765.1736124985002;859.5573279760928;891.5987805487426;987.5852142100335;5925.762969481259;6364.459020983269;6388.456981156561;6462.353764623594;6526.086347911296;439.35195586509644;441.62241283702616;442.2525931176366;447.25085481817825;448.1194452900067;4456.6211871991245;4458.799354029076;4510.1656193604285;4527.071950250191;4535.523770004168;10935.179861510418;11171;11189.328640281608;11258.21192516516;11289.943550282196;10861.13110951122;11117.221794474472;11167.106631469464;11191.72020699489;11277.379744113989;8532.36007299455;8670.566471676391;8694.217520423319;8711.738647840575;8722.258608018263;6309.652969086745;6361.236651601837;6374.776882809265;6427.55007149495;6574.211094668671;10531.368117912949;10548.419836909045;10563.94718026405;10618.8407173894;10670.946645266724;9869.457179855177;10307.278490505592;10322.12261957742;10418.791624167627;10502.4223667699;7359.595222262827;7992.6802927884555;8232.17678232172;8270;8320.83358332842;9060.097379550369;9190.908090919005;9221.953890230774;9251.306152038489;9260.39807412516;8036.397270204641;8210.671573137008;8348.791280218044;8367.790805229917;8431.19903609156;7814.101378341336;7847.411444141826;7965.338779718861;8110.4728192669645;8230.670773169006;7029.367356937695;7358.742444014434;7469.290417410337;7477.401807855467;7481.364084052916;5491.395946445968;5529.30883639545;5554.694491802989;5566.860828479321;5677.602567820378;5384.165454354581;5398.13629819227;5570.665760054248;5590.944090559043;5703.971480142573 20:37:15 INFO - PROCESS | 2057 | |4;prototype.html;339.5619650650661;340.76316959712995;346.0190360328469;348.2964411887988;350.8070561191344;5448.809291674792;5617.297837770278;5635.154726790978;5639.68981706006;5652.897684951426;5446.2647542581735;5517.420670829565;5531.529819965308;5549.306336707911;5611.979687312564;4158.4594002779595;4220.409142720022;4299.505556860954;4330.84842030529;4350.7607081610495;4312.353147027955;4316.374125751764;4318.632916202127;4341.348797680342;4370.519242883281;4344.413504176927;4357.411749413836;4382.9342559861625;4386.736795792247;4387.29803231483;4258.595433433834;4282.357646353041;4287.849925252617;4327.826886924519;4328.523862375137;3838.098046958962;3851.2490064437447;3864.8454061837774;3867.8646247381207;3883.825227864753;5404.891902161974;5441.59188060897;5477.20580515827;5487.670739755627;5497.257870187514;4838.782254798542;4937.728424936663;4955.380577427822;4978.800847966077;4980.501949805027;5716.628419152742;5726.341470730836;5758.337791154029;5809.257222833176;5838.854028649275;4197.601227883346;4211.43145675333;4211.620954114144;4214.304639734441;4216.219999300109;5633;5936.7328470218945;5940;5980.730867110947;6118.5009672630495;4114.490161001787;4148.502179738451;4163.979824942909;4166.58334166587;4184.079502509443;4179.686523510749;4205.516365617932;4211.241976444208;4216.198922204771;4231.555686652919;4767.141914455431;4837.95162048382;4846.418429788448;4865.537773911473;4895.755212239374;5817.592768506164;5820.9813282676205;5833.445822646927;5863.941360586425;5880.088586269135;1470.3677418710058;1483.428879881232;1484.8812095032372;1491.7687758397465;1493.313075985059;931.9440833550009;950.9144177024101;952.5284983932997;958.9691082086784;976.5605477534996;4917.483664215278;4937.654364194544;4953.950460495421;4968.583953573287;5047.394312682502;5220;5279.337008842279;5314.73426328682;5325.562098233455;5339.866503337447;4691.74796097875;4910.459849416561;4925.532074452921;4962.503749625009;5051.852962490927;2793.329600895811;2806.5088609493255;2808;2816.507111255522;2846.5018621741115;5369.7583608737705;5381.031414345377;5434.239206511092;5482.245681381999;5515.862103447446;5073.943505283042;5180.352455943007;5308.256844041837;5328.973355133277;5362.82017956049;5432.728363581884;5443.265159203536;5444;5503.532199762985;5508.9724551376985;4883.389576302962;5257.316548848626;5311.521963023347;5386.784528618811;5401.540869026177;5065.240213967787;5135.92296115566;5228.686278823283;5249.296612244773;5270.446603106772;5410.917816436807;5431.958103462074;5462.8361149165585;5476.698781567052;5494.450554944474;3838.7312888097563;3862.3627101529055;3867.2458870521104;3883.786391748481;3898.5185629460625;5775.595708300379;5896.410358964241;5909.172715819875;5928.733207005609;5990.430909063632;5733.913991290051;5788.739506722123;5803.506701930383;5825.2135961644635;5831.912521312269;5827.6794776286015;5837.532997360286;5846.853828654318;5860.882782344244;5870.823875283749;5706.885862282648;5784.7107644618445;5821.301443826768;5823.272090988627;5831.375880853718;5839.554662748998;5841.2406387171095;5888.558358123072;5892.175095486549;5930.406959304035;5602;5733.741981610754;5746.798862039976;5756.568257380797;5764.625299355696 20:37:15 INFO - PROCESS | 2057 | |5;yui.html;725.9237780033096;738.8337624034593;747;772.3898120484818;787.4212453846426;15805.525834224978;16259.51221463355;16863.747043794352;16864.409745658904;17079.743803842954;15644.843551564481;15793.210339483037;15843.20783960803;15882.602934926605;15905.761413578777;475.3297850031456;797.8404319136182;803.4054799448395;803.5580430763086;804.8953636027309;787.7282337593521;799.400449662753;801.4710291207804;805.9717909873156;808.559335162335;845.0239972831359;845.0957475501216;845.6786421159951;849.2908421468081;849.5752123938031;835.2983493865182;838.2288294768828;842.1662554071456;843.5571325054334;843.633019636457;615.1480199923094;615.4338009031702;615.7660089166133;616.2666426951913;616.442119881508;15350.232488375648;15729.134897580629;15780.132092734895;15795.368185272575;15881.205939703084;16060.919695401448;16086.678266434723;16105.27526261321;16280;16287.104209268486;12496.8125478117;12616.369181540886;12678.492860285669;12692.873071269354;12822.551210707674;3995.52850577568;4023.7988100594853;4025.818838152261;4026.697997650188;4062.7765472898977;83524.58237708833;83650.58174709088;87089.12910870873;88844.55577722135;89341.55329223312;11837.822432663517;11892.167548271711;12141;12367.319797411228;12565.497380104876;23807.285781426584;24050.63924041141;24071.157509487435;24087.397815054763;24189.51620967606;8720.78198045054;8881.777955551162;8990.955045224731;9111.863322050174;9116.680916167903;5013.749312534359;5065.290859279704;5081.898362032739;5133.974330128325;5339.252504649352;3639.7088232941833;3745.700343972476;3784.299904517673;3803.3344164771056;3806.4861243732294;590.1825971030069;600.4535872356134;602.4006113916681;603.8852618002566;614.9569530132848;659.6174218952996;726.5469061876247;739.1425945902727;757.8673732096861;784.0043145205557;10343.581186466616;10553.47232638365;10562.524686389132;11458.541658333574;11919.523219071314;595.5979713693326;616.7295371534653;686.9107016087877;767.760067490998;808;4890.388701412324;5010.148274793294;5163.3545806774155;5175.689458632419;5235.267062611238;101736;104654.4767276174;119456.40271798585;128767;129460.3526982359;99849.50075249578;100408.49795751121;101074.4946275264;102443;106844.46577767062;87520.56239718889;88234.55882720546;90227.54886225527;90236.54881725549;90678.54660726654;10289.073983341535;10692.305000175274;11010.449477526252;11024.834627480433;11058.612948546763;52228.73885630548;54102.48333858287;55273;55385.44614553964;55446.44553554413;46487.53512464832;46665.76667116643;74418;74950.25049749651;77225;12763.617091487271;12930.224186548838;13190.493806176795;13452.730945381234;13797.310134493437;15648.217589120726;15745.44890928812;15962.28169732388;16108.67782644364;16645.583860403585;14496.85503144955;14556.272186390426;14708.926455367655;15206.46777362787;15792.526224213292;14175.291235438393;14866.256687165815;14963.625909352353;14981.775273371126;14984.700305994038;14052.508162214273;14097.365618546984;14446.133232006114;14704.632384190481;14809.92595037018;10841.783164336512;11011.889881101408;11343.205975581961;11364.261323013978;11430.657080287272;10090.848637270594;10500.947495262475;11455.713607159887;12180.87819121833;12711.74576508446 20:37:15 INFO - PROCESS | 2057 | __end_tp_report 20:37:15 INFO - PROCESS | 2057 | __start_cc_report 20:37:15 INFO - PROCESS | 2057 | _x_x_mozilla_cycle_collect,322 20:37:15 INFO - PROCESS | 2057 | __end_cc_report 20:37:15 INFO - PROCESS | 2057 | __startTimestamp1470886635684__endTimestamp 20:37:15 INFO - PROCESS | 2057 | 20:37:15 INFO - PROCESS | 2057 | ------- Summary: start ------- 20:37:15 INFO - PROCESS | 2057 | Number of tests: 6 20:37:15 INFO - PROCESS | 2057 | 20:37:15 INFO - PROCESS | 2057 | [#0] dojo.html Cycles:165 Average:5478.58 Median:5711.91 stddev:635.94 (11.1%) stddev-sans-first:608.95 20:37:15 INFO - PROCESS | 2057 | Values: 3060.8 3080.9 3102.9 3111.6 3113.1 5297.8 5456.2 5493.9 5539.2 5560.0 5361.8 5378.3 5486.9 5490.1 5577.7 4978.3 4990.0 5135.5 5148.9 5156.7 5014.4 5124.9 5222.3 5235.7 5254.4 4913.1 5050.2 5057.3 5113.4 5128.7 4937.8 5005.4 5011.6 5024.5 5061.1 4967.1 4971.8 4981.5 4990.7 5040.9 5312.3 5426.9 5427.2 5441.5 5494.8 5879.6 5937.1 5940.0 5954.3 5980.5 5958.1 5970.5 5977.0 5982.9 5995.9 5318.4 5437.3 5550.8 5556.7 5576.1 5992.0 6075.5 6083.7 6118.1 6125.3 5829.8 5839.9 5840.6 5840.6 5847.3 5684.3 5765.8 5899.5 5909.0 5931.9 5619.0 5753.0 5776.0 5841.6 5911.1 5830.1 5912.6 5923.3 5925.4 5960.9 4517.8 4525.1 4526.2 4526.4 4563.2 3874.4 3932.0 3954.7 3957.3 3981.3 5537.8 5577.0 5630.0 5630.8 5674.6 5917.3 5928.8 5948.1 5955.6 5961.2 5396.2 5559.3 5566.2 5598.1 5608.8 5088.0 5112.6 5116.5 5118.4 5150.0 6082.1 6106.2 6135.8 6146.0 6152.0 5704.7 5849.0 5859.5 5877.7 5949.9 6081.6 6083.0 6095.8 6102.9 6117.8 5805.1 5808.0 5817.4 5823.4 5825.6 5730.5 5835.3 5890.6 5891.4 5914.8 5694.3 5723.2 5783.3 5787.0 5826.7 5706.7 5738.5 5752.9 5773.7 5774.2 5508.1 5711.9 5749.9 5759.4 5781.1 5800.7 5818.1 5854.7 5861.7 5868.9 5702.3 5718.1 5718.2 5721.9 5728.6 20:37:15 INFO - PROCESS | 2057 | 20:37:15 INFO - PROCESS | 2057 | [#1] ext.html Cycles:180 Average:59340.52 Median:23104.50 stddev:118065.67 (511.0%) stddev-sans-first:118314.30 20:37:15 INFO - PROCESS | 2057 | Values: 527.8 566.5 578.1 580.7 593.4 27919.2 28554.4 42028.2 43719.6 43833.1 43841.3 44347.8 44352.0 44431.6 44697.3 8877.8 8976.2 9016.5 9031.5 9058.0 8910.2 8912.4 8928.9 8979.0 8983.1 8950.0 9017.9 9026.4 9028.7 9052.7 8968.3 8974.8 8989.7 9036.7 9047.2 8813.6 8853.2 8868.8 8882.6 8929.2 41452.2 42017.4 42078.8 42092.0 42266.8 3566.3 3567.4 3630.7 3697.6 4191.6 32434.0 32602.3 32665.7 32699.8 33916.2 4217.2 4307.5 4358.9 4365.3 4495.6 336356.0 338064.0 339686.0 340837.0 341079.3 54818.7 55582.0 55590.4 55591.4 55614.4 36379.3 37553.8 37640.4 38821.8 38858.6 17075.5 17143.6 17150.9 17154.8 17240.6 13040.2 13100.3 13175.9 13186.9 13229.3 19000.0 19012.9 19110.6 19189.4 19241.4 7181.5 7331.7 7359.6 7446.3 7480.6 1007.2 1078.0 1140.0 1140.0 1143.5 32337.5 32561.3 33063.5 33116.3 33660.3 1102.7 1117.2 1121.4 1128.8 1140.0 17126.7 17405.1 17464.5 17484.0 17543.9 524778.0 530824.0 531259.0 532220.0 537734.0 57755.1 57764.0 57773.1 57791.4 58612.4 1325.9 1368.9 1375.0 1377.7 1394.7 30519.1 32211.8 32271.2 32794.2 32831.8 50254.7 50368.7 50415.2 50655.7 50816.5 443323.0 443453.0 444388.0 444479.3 446301.0 28099.9 29142.6 29168.0 29176.4 29223.1 46706.8 47619.5 47917.5 48092.3 48720.0 40011.2 41389.2 41426.8 42094.8 42709.8 42041.8 42309.2 42340.0 43088.0 43373.1 35942.6 38128.4 40705.6 41826.8 41906.4 34513.7 36462.5 37404.4 37705.8 40484.4 28547.2 28618.9 29001.9 29118.0 29325.6 20:37:15 INFO - PROCESS | 2057 | 20:37:15 INFO - PROCESS | 2057 | [#2] jquery.html Cycles:180 Average:28788.87 Median:18180.49 stddev:77088.11 (424.0%) stddev-sans-first:77274.85 20:37:15 INFO - PROCESS | 2057 | Values: 382.3 385.9 388.0 397.2 411.5 14065.5 18926.6 19594.2 20398.3 20415.7 19227.0 19475.8 19513.9 20258.3 20415.8 5791.3 5809.1 6022.2 6036.0 6071.4 6082.6 6098.7 6123.3 6164.3 6164.7 5925.0 6149.6 6194.9 6196.8 6205.1 5986.3 6102.8 6162.8 6181.8 6199.2 5919.6 5942.3 5948.5 5953.9 5963.3 14651.1 17030.1 20528.4 24021.5 24700.5 2297.0 2308.1 2313.5 2371.6 2991.5 10364.9 10439.7 10589.9 11039.2 11089.6 1932.2 1958.7 2000.6 2030.8 2033.2 88296.0 90353.5 91174.5 92269.0 92697.0 10960.7 11126.6 11127.9 11146.8 11354.1 15866.5 15875.6 15878.0 15931.4 15937.5 8173.8 8355.5 8357.0 8531.7 8626.4 8051.5 8157.5 8171.4 8335.5 8413.5 4746.3 4812.3 4848.7 4866.1 4964.5 1947.1 1996.5 2002.0 2019.6 2066.9 923.0 949.3 975.6 987.2 1000.5 18672.9 20352.5 20577.4 20743.8 21137.7 947.5 993.8 1007.9 1009.9 1037.8 10673.7 11478.9 11539.4 11671.4 11718.3 456665.0 461964.0 464672.0 465196.0 476759.0 87869.1 88598.6 90027.0 93793.5 100562.5 955.3 960.7 985.3 992.2 999.5 17537.0 18483.8 18643.9 18742.4 18858.2 31420.2 35978.6 44918.8 45098.1 46119.8 60170.1 61927.7 62875.4 65847.0 66049.3 8160.3 8283.9 8427.9 8462.5 8485.4 11154.4 13322.1 13329.2 13346.5 13501.2 11453.7 11477.0 11650.2 11930.6 12464.3 11209.2 11404.8 11574.9 11880.5 12105.5 11726.2 11826.5 11867.7 12070.9 12571.2 7431.3 7560.7 7647.7 8090.8 8100.6 9055.2 11748.5 12228.5 12289.6 12305.3 20:37:15 INFO - PROCESS | 2057 | 20:37:15 INFO - PROCESS | 2057 | [#3] mootools.html Cycles:180 Average:6021.45 Median:4531.30 stddev:3470.06 (76.6%) stddev-sans-first:3462.40 20:37:15 INFO - PROCESS | 2057 | Values: 1398.1 1444.7 1558.6 1792.1 1794.4 8081.5 8587.1 8688.2 9373.4 9376.4 8963.1 9173.4 9237.2 9237.5 9240.5 2376.6 2411.3 2417.1 2417.5 2425.1 2321.9 2350.3 2363.9 2367.7 2374.9 2390.4 2401.6 2409.0 2422.6 2423.2 2286.1 2307.7 2350.3 2386.9 2391.6 2260.5 2261.7 2282.1 2287.6 2297.1 9322.0 9378.8 9392.3 9402.1 9448.3 5206.4 5332.4 5354.9 5370.8 5393.8 3434.9 3452.1 3504.3 3547.6 3553.7 1115.9 1116.6 1120.5 1121.1 1123.4 12841.8 12855.5 12885.4 12894.2 12941.4 4332.4 4498.8 4597.1 4663.6 4685.3 10677.2 10688.0 10720.5 10804.6 10824.3 5309.5 5365.2 5379.1 5396.4 5403.5 4330.1 4745.1 4847.1 4869.6 4896.3 4087.2 4094.2 4110.0 4120.6 4207.1 1273.9 1310.3 1312.8 1316.6 1327.8 750.7 765.2 859.6 891.6 987.6 5925.8 6364.5 6388.5 6462.4 6526.1 439.4 441.6 442.3 447.3 448.1 4456.6 4458.8 4510.2 4527.1 4535.5 10935.2 11171.0 11189.3 11258.2 11289.9 10861.1 11117.2 11167.1 11191.7 11277.4 8532.4 8670.6 8694.2 8711.7 8722.3 6309.7 6361.2 6374.8 6427.6 6574.2 10531.4 10548.4 10563.9 10618.8 10670.9 9869.5 10307.3 10322.1 10418.8 10502.4 7359.6 7992.7 8232.2 8270.0 8320.8 9060.1 9190.9 9222.0 9251.3 9260.4 8036.4 8210.7 8348.8 8367.8 8431.2 7814.1 7847.4 7965.3 8110.5 8230.7 7029.4 7358.7 7469.3 7477.4 7481.4 5491.4 5529.3 5554.7 5566.9 5677.6 5384.2 5398.1 5570.7 5590.9 5704.0 20:37:15 INFO - PROCESS | 2057 | 20:37:15 INFO - PROCESS | 2057 | [#4] prototype.html Cycles:180 Average:4701.09 Median:5293.80 stddev:1362.85 (25.7%) stddev-sans-first:1326.77 20:37:15 INFO - PROCESS | 2057 | Values: 339.6 340.8 346.0 348.3 350.8 5448.8 5617.3 5635.2 5639.7 5652.9 5446.3 5517.4 5531.5 5549.3 5612.0 4158.5 4220.4 4299.5 4330.8 4350.8 4312.4 4316.4 4318.6 4341.3 4370.5 4344.4 4357.4 4382.9 4386.7 4387.3 4258.6 4282.4 4287.8 4327.8 4328.5 3838.1 3851.2 3864.8 3867.9 3883.8 5404.9 5441.6 5477.2 5487.7 5497.3 4838.8 4937.7 4955.4 4978.8 4980.5 5716.6 5726.3 5758.3 5809.3 5838.9 4197.6 4211.4 4211.6 4214.3 4216.2 5633.0 5936.7 5940.0 5980.7 6118.5 4114.5 4148.5 4164.0 4166.6 4184.1 4179.7 4205.5 4211.2 4216.2 4231.6 4767.1 4838.0 4846.4 4865.5 4895.8 5817.6 5821.0 5833.4 5863.9 5880.1 1470.4 1483.4 1484.9 1491.8 1493.3 931.9 950.9 952.5 959.0 976.6 4917.5 4937.7 4954.0 4968.6 5047.4 5220.0 5279.3 5314.7 5325.6 5339.9 4691.7 4910.5 4925.5 4962.5 5051.9 2793.3 2806.5 2808.0 2816.5 2846.5 5369.8 5381.0 5434.2 5482.2 5515.9 5073.9 5180.4 5308.3 5329.0 5362.8 5432.7 5443.3 5444.0 5503.5 5509.0 4883.4 5257.3 5311.5 5386.8 5401.5 5065.2 5135.9 5228.7 5249.3 5270.4 5410.9 5432.0 5462.8 5476.7 5494.5 3838.7 3862.4 3867.2 3883.8 3898.5 5775.6 5896.4 5909.2 5928.7 5990.4 5733.9 5788.7 5803.5 5825.2 5831.9 5827.7 5837.5 5846.9 5860.9 5870.8 5706.9 5784.7 5821.3 5823.3 5831.4 5839.6 5841.2 5888.6 5892.2 5930.4 5602.0 5733.7 5746.8 5756.6 5764.6 20:37:15 INFO - PROCESS | 2057 | 20:37:15 INFO - PROCESS | 2057 | [#5] yui.html Cycles:180 Average:21604.16 Median:3765.00 stddev:30735.22 (816.3%) stddev-sans-first:30781.46 20:37:15 INFO - PROCESS | 2057 | Values: 725.9 738.8 747.0 772.4 787.4 15805.5 16259.5 16863.7 16864.4 17079.7 15644.8 15793.2 15843.2 15882.6 15905.8 475.3 797.8 803.4 803.6 804.9 787.7 799.4 801.5 806.0 808.6 845.0 845.1 845.7 849.3 849.6 835.3 838.2 842.2 843.6 843.6 615.1 615.4 615.8 616.3 616.4 15350.2 15729.1 15780.1 15795.4 15881.2 16060.9 16086.7 16105.3 16280.0 16287.1 12496.8 12616.4 12678.5 12692.9 12822.6 3995.5 4023.8 4025.8 4026.7 4062.8 83524.6 83650.6 87089.1 88844.6 89341.6 11837.8 11892.2 12141.0 12367.3 12565.5 23807.3 24050.6 24071.2 24087.4 24189.5 8720.8 8881.8 8991.0 9111.9 9116.7 5013.7 5065.3 5081.9 5134.0 5339.3 3639.7 3745.7 3784.3 3803.3 3806.5 590.2 600.5 602.4 603.9 615.0 659.6 726.5 739.1 757.9 784.0 10343.6 10553.5 10562.5 11458.5 11919.5 595.6 616.7 686.9 767.8 808.0 4890.4 5010.1 5163.4 5175.7 5235.3 101736.0 104654.5 119456.4 128767.0 129460.4 99849.5 100408.5 101074.5 102443.0 106844.5 87520.6 88234.6 90227.5 90236.5 90678.5 10289.1 10692.3 11010.4 11024.8 11058.6 52228.7 54102.5 55273.0 55385.4 55446.4 46487.5 46665.8 74418.0 74950.3 77225.0 12763.6 12930.2 13190.5 13452.7 13797.3 15648.2 15745.4 15962.3 16108.7 16645.6 14496.9 14556.3 14708.9 15206.5 15792.5 14175.3 14866.3 14963.6 14981.8 14984.7 14052.5 14097.4 14446.1 14704.6 14809.9 10841.8 11011.9 11343.2 11364.3 11430.7 10090.8 10500.9 11455.7 12180.9 12711.7 20:37:15 INFO - PROCESS | 2057 | -------- Summary: end -------- 20:37:15 INFO - PROCESS | 2057 | 20:37:16 INFO - TEST-INFO | 2057: exit 0 20:37:16 INFO - TEST-OK | dromaeo_css | took 1112922ms 20:37:16 INFO - TEST-START | kraken 20:37:16 INFO - operating with platform_type : linux_ 20:37:16 INFO - Initialising browser for kraken test... 20:37:16 INFO - TEST-INFO | started process 2296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOhhu2t/profile http://localhost:34017/getInfo.html) 20:37:20 INFO - PROCESS | 2296 | __metrics Screen width/height:1600/1200 20:37:20 INFO - PROCESS | 2296 | colorDepth:24 20:37:20 INFO - PROCESS | 2296 | Browser inner width/height: 1024/697 20:37:20 INFO - PROCESS | 2296 | __metrics 20:37:21 ERROR - PROCESS | 2296 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 20:37:22 INFO - TEST-INFO | 2296: exit 0 20:37:22 INFO - Browser initialized. 20:37:22 INFO - Running cycle 1/1 for kraken test... 20:37:22 INFO - TEST-INFO | started process 2488 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOhhu2t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:37:34 INFO - PROCESS | 2488 | RSS: Main: 162504704 20:37:34 INFO - PROCESS | 2488 | 20:37:36 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:34017/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34017/tests/kraken/driver.html?testName=audio-beat-detection) 20:37:37 INFO - PROCESS | 2488 | RSS: Main: 167944192 20:37:37 INFO - PROCESS | 2488 | 20:37:40 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:34017/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34017/tests/kraken/driver.html?testName=audio-dft) 20:37:40 INFO - PROCESS | 2488 | RSS: Main: 166989824 20:37:40 INFO - PROCESS | 2488 | 20:37:43 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:34017/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34017/tests/kraken/driver.html?testName=audio-fft) 20:37:44 INFO - PROCESS | 2488 | RSS: Main: 162746368 20:37:44 INFO - PROCESS | 2488 | 20:37:46 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:34017/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34017/tests/kraken/driver.html?testName=audio-oscillator) 20:37:47 INFO - PROCESS | 2488 | RSS: Main: 163573760 20:37:47 INFO - PROCESS | 2488 | 20:37:49 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:34017/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34017/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:37:49 INFO - PROCESS | 2488 | RSS: Main: 164081664 20:37:49 INFO - PROCESS | 2488 | 20:37:53 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:34017/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34017/tests/kraken/driver.html?testName=imaging-darkroom) 20:37:53 INFO - PROCESS | 2488 | RSS: Main: 163962880 20:37:53 INFO - PROCESS | 2488 | 20:37:57 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:34017/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34017/tests/kraken/driver.html?testName=imaging-desaturate) 20:37:57 INFO - PROCESS | 2488 | RSS: Main: 161890304 20:37:57 INFO - PROCESS | 2488 | 20:38:00 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:34017/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34017/tests/kraken/driver.html?testName=json-parse-financial) 20:38:01 INFO - PROCESS | 2488 | RSS: Main: 163688448 20:38:01 INFO - PROCESS | 2488 | 20:38:02 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:34017/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34017/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:38:03 INFO - PROCESS | 2488 | RSS: Main: 163483648 20:38:03 INFO - PROCESS | 2488 | 20:38:05 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:34017/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34017/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:38:05 INFO - PROCESS | 2488 | RSS: Main: 163954688 20:38:05 INFO - PROCESS | 2488 | 20:38:07 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:34017/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34017/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:38:08 INFO - PROCESS | 2488 | RSS: Main: 164143104 20:38:08 INFO - PROCESS | 2488 | 20:38:11 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:34017/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34017/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:38:11 INFO - PROCESS | 2488 | RSS: Main: 164671488 20:38:11 INFO - PROCESS | 2488 | 20:38:14 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:34017/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34017/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:38:15 INFO - PROCESS | 2488 | RSS: Main: 164655104 20:38:15 INFO - PROCESS | 2488 | 20:38:16 INFO - PROCESS | 2488 | Cycle 1(1): loaded http://localhost:34017/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34017/tests/kraken/driver.html?testName=ai-astar) 20:38:16 INFO - PROCESS | 2488 | RSS: Main: 165588992 20:38:16 INFO - PROCESS | 2488 | 20:38:16 INFO - PROCESS | 2488 | __start_tp_report 20:38:16 INFO - PROCESS | 2488 | _x_x_mozilla_page_load 20:38:16 INFO - PROCESS | 2488 | _x_x_mozilla_page_load_details 20:38:16 INFO - PROCESS | 2488 | |i|pagename|runs| 20:38:16 INFO - PROCESS | 2488 | |0;ai-astar;101;112;107;112;112;114;112;110;110;112 20:38:16 INFO - PROCESS | 2488 | |1;audio-beat-detection;144;123;141;182;117;151;149;121;171;119 20:38:16 INFO - PROCESS | 2488 | |2;audio-dft;164;162;162;163;163;168;176;164;163;162 20:38:16 INFO - PROCESS | 2488 | |3;audio-fft;75;76;74;184;76;76;75;77;164;77 20:38:16 INFO - PROCESS | 2488 | |4;audio-oscillator;84;86;156;85;84;84;140;84;85;141 20:38:16 INFO - PROCESS | 2488 | |5;imaging-gaussian-blur;117;120;117;117;117;118;118;117;117;117 20:38:16 INFO - PROCESS | 2488 | |6;imaging-darkroom;146;147;148;147;146;146;147;148;146;148 20:38:16 INFO - PROCESS | 2488 | |7;imaging-desaturate;95;99;96;95;95;95;95;95;96;95 20:38:16 INFO - PROCESS | 2488 | |8;json-parse-financial;51;53;52;51;53;51;51;51;51;52 20:38:16 INFO - PROCESS | 2488 | |9;json-stringify-tinderbox;62;62;61;64;64;63;61;61;61;62 20:38:16 INFO - PROCESS | 2488 | |10;stanford-crypto-aes;77;78;76;77;80;75;81;75;81;77 20:38:16 INFO - PROCESS | 2488 | |11;stanford-crypto-ccm;129;125;127;130;131;130;132;124;141;124 20:38:16 INFO - PROCESS | 2488 | |12;stanford-crypto-pbkdf2;164;160;159;159;160;158;159;158;156;159 20:38:16 INFO - PROCESS | 2488 | |13;stanford-crypto-sha256-iterative;65;68;64;66;67;63;66;68;62;63 20:38:16 INFO - PROCESS | 2488 | __end_tp_report 20:38:16 INFO - PROCESS | 2488 | __start_cc_report 20:38:16 INFO - PROCESS | 2488 | _x_x_mozilla_cycle_collect,849 20:38:16 INFO - PROCESS | 2488 | __end_cc_report 20:38:16 INFO - PROCESS | 2488 | __startTimestamp1470886696982__endTimestamp 20:38:16 INFO - PROCESS | 2488 | 20:38:16 INFO - PROCESS | 2488 | ------- Summary: start ------- 20:38:16 INFO - PROCESS | 2488 | Number of tests: 14 20:38:16 INFO - PROCESS | 2488 | 20:38:16 INFO - PROCESS | 2488 | [#0] ai-astar Cycles:10 Average:110.20 Median:112.00 stddev:3.74 (3.3%) stddev-sans-first:1.99 20:38:16 INFO - PROCESS | 2488 | Values: 101.0 112.0 107.0 112.0 112.0 114.0 112.0 110.0 110.0 112.0 20:38:16 INFO - PROCESS | 2488 | 20:38:16 INFO - PROCESS | 2488 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:146.50 stddev:22.44 (15.3%) stddev-sans-first:23.79 20:38:16 INFO - PROCESS | 2488 | Values: 144.0 123.0 141.0 182.0 117.0 151.0 149.0 121.0 171.0 119.0 20:38:16 INFO - PROCESS | 2488 | 20:38:16 INFO - PROCESS | 2488 | [#2] audio-dft Cycles:10 Average:164.70 Median:163.50 stddev:4.35 (2.7%) stddev-sans-first:4.60 20:38:16 INFO - PROCESS | 2488 | Values: 164.0 162.0 162.0 163.0 163.0 168.0 176.0 164.0 163.0 162.0 20:38:16 INFO - PROCESS | 2488 | 20:38:16 INFO - PROCESS | 2488 | [#3] audio-fft Cycles:10 Average:95.40 Median:76.00 stddev:41.70 (54.9%) stddev-sans-first:43.57 20:38:16 INFO - PROCESS | 2488 | Values: 75.0 76.0 74.0 184.0 76.0 76.0 75.0 77.0 164.0 77.0 20:38:16 INFO - PROCESS | 2488 | 20:38:16 INFO - PROCESS | 2488 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:84.00 stddev:29.82 (35.5%) stddev-sans-first:30.83 20:38:16 INFO - PROCESS | 2488 | Values: 84.0 86.0 156.0 85.0 84.0 84.0 140.0 84.0 85.0 141.0 20:38:16 INFO - PROCESS | 2488 | 20:38:16 INFO - PROCESS | 2488 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:0.97 (0.8%) stddev-sans-first:1.01 20:38:16 INFO - PROCESS | 2488 | Values: 117.0 120.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 20:38:16 INFO - PROCESS | 2488 | 20:38:16 INFO - PROCESS | 2488 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.87 20:38:16 INFO - PROCESS | 2488 | Values: 146.0 147.0 148.0 147.0 146.0 146.0 147.0 148.0 146.0 148.0 20:38:16 INFO - PROCESS | 2488 | 20:38:16 INFO - PROCESS | 2488 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.00 stddev:1.26 (1.3%) stddev-sans-first:1.32 20:38:16 INFO - PROCESS | 2488 | Values: 95.0 99.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 20:38:16 INFO - PROCESS | 2488 | 20:38:16 INFO - PROCESS | 2488 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:51.50 stddev:0.84 (1.6%) stddev-sans-first:0.87 20:38:16 INFO - PROCESS | 2488 | Values: 51.0 53.0 52.0 51.0 53.0 51.0 51.0 51.0 51.0 52.0 20:38:16 INFO - PROCESS | 2488 | 20:38:16 INFO - PROCESS | 2488 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:1.20 (1.9%) stddev-sans-first:1.27 20:38:16 INFO - PROCESS | 2488 | Values: 62.0 62.0 61.0 64.0 64.0 63.0 61.0 61.0 61.0 62.0 20:38:16 INFO - PROCESS | 2488 | 20:38:16 INFO - PROCESS | 2488 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:77.50 stddev:2.26 (2.9%) stddev-sans-first:2.39 20:38:16 INFO - PROCESS | 2488 | Values: 77.0 78.0 76.0 77.0 80.0 75.0 81.0 75.0 81.0 77.0 20:38:16 INFO - PROCESS | 2488 | 20:38:16 INFO - PROCESS | 2488 | [#11] stanford-crypto-ccm Cycles:10 Average:129.30 Median:130.00 stddev:5.03 (3.9%) stddev-sans-first:5.34 20:38:17 INFO - PROCESS | 2488 | Values: 129.0 125.0 127.0 130.0 131.0 130.0 132.0 124.0 141.0 124.0 20:38:17 INFO - PROCESS | 2488 | 20:38:17 INFO - PROCESS | 2488 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.20 Median:159.00 stddev:2.04 (1.3%) stddev-sans-first:1.22 20:38:17 INFO - PROCESS | 2488 | Values: 164.0 160.0 159.0 159.0 160.0 158.0 159.0 158.0 156.0 159.0 20:38:17 INFO - PROCESS | 2488 | 20:38:17 INFO - PROCESS | 2488 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:66.00 stddev:2.15 (3.3%) stddev-sans-first:2.28 20:38:17 INFO - PROCESS | 2488 | Values: 65.0 68.0 64.0 66.0 67.0 63.0 66.0 68.0 62.0 63.0 20:38:17 INFO - PROCESS | 2488 | -------- Summary: end -------- 20:38:17 INFO - PROCESS | 2488 | 20:38:17 INFO - TEST-INFO | 2488: exit 0 20:38:17 INFO - TEST-OK | kraken | took 61564ms 20:38:17 INFO - SUITE-END | took 1174s 20:38:18 INFO - Completed test suite (00:19:34) 20:38:18 INFO - javascript benchmark 20:38:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7367.621691161713, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3060.8163510189383, 3080.8921687740935, 3102.860371283293, 3111.6421611514684, 3113.12832406926, 5297.841064768054, 5456.208849716793, 5493.890122197554, 5539.224508568804, 5560.0, 5361.812336568221, 5378.300820893288, 5486.890262194754, 5490.149026900826, 5577.749001294941, 4978.303037574742, 4990.0019996000765, 5135.51212634801, 5148.948510514903, 5156.742162891859, 5014.423341315759, 5124.92312615311, 5222.321098257221, 5235.6596821206695, 5254.395744489375, 4913.140200464904, 5050.242463630485, 5057.317262169634, 5113.437521872591, 5128.692278463285, 4937.753112344404, 5005.449400565934, 5011.6241281904, 5024.472430394792, 5061.063703214917, 4967.130752118364, 4971.751412429364, 4981.526754958273, 4990.72551009698, 5040.873978150539, 5312.2828418163435, 5426.9185962210595, 5427.240186373911, 5441.483059109379, 5494.752736126884, 5879.647221166701, 5937.109433584954, 5939.970300148515, 5954.255718035246, 5980.461758441761, 5958.136070269787, 5970.462658360769, 5977.0, 5982.880342393128, 5995.940040599582, 5318.414974352818, 5437.293151890308, 5550.8057217997175, 5556.6943818089585, 5576.10782274834, 5992.0, 6075.544334174866, 6083.726232319556, 6118.051701986199, 6125.295591007091, 5829.766809327664, 5839.854003649858, 5840.620359676607, 5840.620359676607, 5847.26909136358, 5684.346300175533, 5765.798197063083, 5899.498542623839, 5909.0, 5931.911021334683, 5618.971905140448, 5753.0, 5775.971120144372, 5841.649501029951, 5911.113332999998, 5830.096335068071, 5912.556558258062, 5923.318818335861, 5925.377835327315, 5960.880782384328, 4517.81928722854, 4525.140223357552, 4526.162659907927, 4526.388937493462, 4563.247064234364, 3874.4382064600477, 3931.9606803932165, 3954.7231693781737, 3957.3470377387407, 3981.3231750602467, 5537.833864984057, 5576.97211513948, 5629.971850140805, 5630.831075067755, 5674.574406919498, 5917.349091599921, 5928.822135335947, 5948.078047902582, 5955.583109182316, 5961.225040744675, 5396.163594642837, 5559.277293951841, 5566.248556444909, 5598.076317407664, 5608.831735047955, 5088.0, 5112.616553758483, 5116.513931176607, 5118.411382690963, 5150.0, 6082.0876868469195, 6106.236720409949, 6135.84660383494, 6145.9692701536205, 6151.96924015377, 5704.657720536781, 5849.0, 5859.531237500904, 5877.73550190251, 5949.940500594938, 6081.574289799849, 6082.9695851520455, 6095.847603809941, 6102.908456373247, 6117.816465506042, 5805.071188609802, 5808.0, 5817.447342502455, 5823.4176582343125, 5825.621334613236, 5730.455606717355, 5835.299764028344, 5890.617109887844, 5891.351951285441, 5914.792982245773, 5694.316681998187, 5723.227364305932, 5783.306003279633, 5787.045137552257, 5826.679532625577, 5706.657600543981, 5738.540916726568, 5752.942470575408, 5773.6824474654295, 5774.249347584787, 5508.063629183129, 5711.914321285101, 5749.8562535936935, 5759.395263497272, 5781.132830075354, 5800.680962546931, 5818.069108942549, 5854.677992710272, 5861.677607731615, 5868.943590153814, 5702.258706368146, 5718.056520674042, 5718.228039214653, 5721.8569535761935, 5728.598998070095], "value": 5433.950095997708, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [527.7994362142385, 566.4788394676897, 578.1241419249834, 580.6835274775249, 593.3650993437021, 27919.16242512725, 28554.428911421786, 42028.15943681124, 43719.56280437195, 43833.12333753323, 43841.34237986433, 44347.77826110865, 44352.0, 44431.55568444315, 44697.329540056926, 8877.778055548632, 8976.237019853288, 9016.54917254138, 9031.548422578877, 9058.0, 8910.198082172603, 8912.420692654989, 8928.910710892906, 8978.955105224497, 8983.14660107292, 8949.955250223773, 9017.864732028993, 9026.368154229174, 9028.68399606014, 9052.683156089506, 8968.327375446868, 8974.820503589957, 8989.685361012365, 9036.728898133033, 9047.185753282236, 8813.603387847497, 8853.24747396472, 8868.822623547492, 8882.644694212224, 8929.151730585583, 41452.170956580696, 42017.369739453934, 42078.789606051774, 42092.0, 42266.78866605678, 3566.286742651454, 3567.4470457079196, 3630.6550877666577, 3697.6487233713024, 4191.622753952129, 32434.0, 32602.347953040808, 32665.673343266502, 32699.836500817342, 33916.15209619755, 4217.240896638604, 4307.461567304087, 4358.8910277243, 4365.257906155929, 4495.64034877209, 336356.0, 338064.0, 339686.0, 340836.9999999975, 341079.2946035279, 54818.725906370215, 55582.0, 55590.44409555852, 55591.44408555944, 55614.44385556174, 36379.27241455156, 37553.81223093867, 37640.43539346912, 38821.80589097093, 38858.6114138855, 17075.48773536796, 17143.57141071483, 17150.914245428943, 17154.828451715322, 17240.568985775204, 13040.217586944813, 13100.279484628247, 13175.868241317656, 13186.934065329804, 13229.272390018448, 19000.0, 19012.904935475235, 19110.61778764445, 19189.424317270503, 19241.422757317025, 7181.461390395742, 7331.706731730671, 7359.595222262827, 7446.255374462618, 7480.606206014023, 1007.2495990487134, 1078.008232426154, 1139.9512448547357, 1139.9943000284945, 1143.5368675686361, 32337.51493727596, 32561.348773024405, 33063.50404743931, 33116.3376732464, 33660.326793463995, 1102.729831191347, 1117.201201141188, 1121.43928035982, 1128.8193888977723, 1139.9911078695413, 17126.743098853527, 17405.129743512774, 17464.476065717794, 17484.0, 17543.912280438515, 524778.0, 530824.0, 531259.0, 532220.0, 537734.0, 57755.13367299494, 57764.0, 57773.13340299899, 57791.422085778606, 58612.41387586155, 1325.8674132586857, 1368.945242190321, 1374.9862501374857, 1377.7037936843626, 1394.7350003499303, 30519.120635507148, 32211.838940805144, 32271.193220169684, 32794.1801454956, 32831.83584082064, 50254.74872625613, 50368.74815625898, 50415.24377134273, 50655.74672126616, 50816.491835082656, 443323.0, 443453.0, 444388.0, 444479.33124012663, 446301.0, 28099.859500702365, 29142.648595410952, 29168.0, 29176.416471670873, 29223.123306300844, 46706.76646616745, 47619.523804761506, 47917.5208247913, 48092.27861582009, 48720.0, 40011.199776003734, 41389.1722165561, 41426.792866035474, 42094.78952605218, 42709.78645106754, 42041.78979105085, 42309.15381692287, 42340.0, 43088.0, 43373.13253734971, 35942.640573593926, 38128.42807357836, 40705.592944071366, 41826.79086604548, 41906.37140442957, 34513.685789276344, 36462.4530632046, 37404.43893341548, 37705.81147094247, 40484.39273410842, 28547.220685496228, 28618.85690571534, 29001.85499072491, 29118.0, 29325.56011659784], "value": 19946.58173409739, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.34618801848836, 385.8610900075972, 388.0434728394507, 397.17586009031265, 411.522633744856, 14065.507707230248, 18926.621467570658, 19594.216231350765, 20398.286059987902, 20415.693764593525, 19227.0, 19475.805241947575, 19513.90243048783, 20258.290959816408, 20415.795842041574, 5791.305043394798, 5809.128630705386, 6022.217111775463, 6035.969820150915, 6071.3625069367745, 6082.635041897478, 6098.695065246742, 6123.295820980599, 6164.291106522763, 6164.691765411734, 5924.970375148118, 6149.631022138664, 6194.907076393858, 6196.81409557714, 6205.0692396140485, 5986.2517185351835, 6102.847428814271, 6162.7534898604, 6181.845453863667, 6199.225096862892, 5919.5560332974765, 5942.3166335871065, 5948.464638182584, 5953.851153721148, 5963.2844058713235, 14651.12093274407, 17030.063346515937, 20528.38414847542, 24021.519569608685, 24700.505989880283, 2296.988515057414, 2308.0883051194683, 2313.502596941649, 2371.5849726298, 2991.536311871663, 10364.948175259151, 10439.739006524822, 10589.9470502647, 11039.172062095375, 11089.611863584736, 1932.2077948041235, 1958.7355706979517, 2000.649886269897, 2030.8375329973567, 2033.186725309873, 88296.0, 90353.54823225907, 91174.54412727893, 92269.0, 92697.0, 10960.725981850359, 11126.554937802397, 11127.944360278147, 11146.832797508045, 11354.148438867118, 15866.52400427989, 15875.603109922344, 15878.0, 15931.36274549005, 15937.521874343789, 8173.754787356389, 8355.540445275568, 8357.0, 8531.65873365071, 8626.39615226928, 8051.4766540174705, 8157.510549367057, 8171.387145964077, 8335.458195217412, 8413.537255451009, 4746.315058154306, 4812.302216178635, 4848.733319667382, 4866.081963344569, 4964.503549645079, 1947.123794292574, 1996.4709352021725, 2001.9799802001794, 2019.5859848730975, 2066.917323307051, 922.9907700923039, 949.3212353167519, 975.6097560975667, 987.2496902354119, 1000.5097502223858, 18672.906635466737, 20352.49118772013, 20577.38267851967, 20743.831350315493, 21137.68293475599, 947.5215016416665, 993.8111758765812, 1007.9496025198857, 1009.9293049486465, 1037.7613148975777, 10673.679789606324, 11478.94260528692, 11539.36533490666, 11671.35807530577, 11718.296902185895, 456665.0, 461964.0, 464672.0, 465196.0, 476759.0, 87869.1213087861, 88598.55700721584, 90027.0, 93793.5310323444, 100562.4971875136, 955.3312681123102, 960.6829746183743, 985.2905907746411, 992.2310209587628, 999.4552968632113, 17537.035463049655, 18483.815161848208, 18643.90678046601, 18742.437726868215, 18858.24567017304, 31420.214494637818, 35978.64021359858, 44918.77540612276, 45098.09803803971, 46119.76940115278, 60170.09744853743, 61927.665063446926, 62875.37124628695, 65847.0, 66049.33950660432, 8160.306373958043, 8283.875741863998, 8427.915720842713, 8462.536166816175, 8485.40602157843, 11154.442277885912, 13322.134061285986, 13329.200247985153, 13346.466141354236, 13501.189928604315, 11453.656390308304, 11477.0, 11650.242734222249, 11930.642080737593, 12464.252144871336, 11209.215354925076, 11404.82892756626, 11574.88425115738, 11880.46537905779, 12105.455254513392, 11726.179167458196, 11826.467808948446, 11867.703307417383, 12070.939645301718, 12571.18287311322, 7431.29402706742, 7560.697572097274, 7647.694092236471, 8090.797730056795, 8100.594970251346, 9055.18503334703, 11748.471318790504, 12228.510859565518, 12289.56986505468, 12305.26168429897], "value": 9373.024309246905, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1398.112198753791, 1444.6966137111206, 1558.633721075547, 1792.0502133869054, 1794.3630011345972, 8081.474704144227, 8587.098354672748, 8688.218060374566, 9373.390729602572, 9376.437413755179, 8963.058878817728, 9173.403728757627, 9237.214836738869, 9237.49193794341, 9240.491772952502, 2376.5603363377786, 2411.2886698423918, 2417.069428270111, 2417.468157005456, 2425.1027119965547, 2321.8606883586954, 2350.3066595354326, 2363.858168509886, 2367.715874095102, 2374.8693821839793, 2390.366552863484, 2401.5797235483806, 2408.95182096358, 2422.648715936188, 2423.151896836102, 2286.074139973297, 2307.665388518672, 2350.2831636350907, 2386.904523819045, 2391.5934291170543, 2260.525289689167, 2261.683364328995, 2282.132789539964, 2287.645414960684, 2297.0696867768415, 9322.0, 9378.812423751488, 9392.29557783169, 9402.059794020543, 9448.338616296862, 5206.427292997767, 5332.440093790174, 5354.9196762048605, 5370.785168593252, 5393.83818485446, 3434.9180008297308, 3452.1197094740933, 3504.26410453805, 3547.5742910850604, 3553.733469989735, 1115.8828323026128, 1116.5589592111153, 1120.5181771838106, 1121.0975164992178, 1123.3709122891207, 12841.84423401889, 12855.485780568766, 12885.420156092998, 12894.161879477897, 12941.417636206394, 4332.393464914914, 4498.797554110073, 4597.126545956325, 4663.603593694506, 4685.250359942393, 10677.199210059121, 10688.038076573146, 10720.46397680113, 10804.567817287378, 10824.268117101226, 5309.469053094737, 5365.195220716923, 5379.112446446293, 5396.379416367168, 5403.540699040625, 4330.069035157457, 4745.145873742759, 4847.127517046965, 4869.63477739171, 4896.338994235733, 4087.2438598859308, 4094.2220978014084, 4109.950457801205, 4120.587941205916, 4207.074443622399, 1273.8726127387372, 1310.33173081729, 1312.7637025335341, 1316.5918565244804, 1327.8141060251573, 750.6697053296532, 765.1736124985002, 859.5573279760928, 891.5987805487426, 987.5852142100335, 5925.762969481259, 6364.459020983269, 6388.456981156561, 6462.353764623594, 6526.086347911296, 439.35195586509644, 441.62241283702616, 442.2525931176366, 447.25085481817825, 448.1194452900067, 4456.6211871991245, 4458.799354029076, 4510.1656193604285, 4527.071950250191, 4535.523770004168, 10935.179861510418, 11171.0, 11189.328640281608, 11258.21192516516, 11289.943550282196, 10861.13110951122, 11117.221794474472, 11167.106631469464, 11191.72020699489, 11277.379744113989, 8532.36007299455, 8670.566471676391, 8694.217520423319, 8711.738647840575, 8722.258608018263, 6309.652969086745, 6361.236651601837, 6374.776882809265, 6427.55007149495, 6574.211094668671, 10531.368117912949, 10548.419836909045, 10563.94718026405, 10618.8407173894, 10670.946645266724, 9869.457179855177, 10307.278490505592, 10322.12261957742, 10418.791624167627, 10502.4223667699, 7359.595222262827, 7992.6802927884555, 8232.17678232172, 8270.0, 8320.83358332842, 9060.097379550369, 9190.908090919005, 9221.953890230774, 9251.306152038489, 9260.39807412516, 8036.397270204641, 8210.671573137008, 8348.791280218044, 8367.790805229917, 8431.19903609156, 7814.101378341336, 7847.411444141826, 7965.338779718861, 8110.4728192669645, 8230.670773169006, 7029.367356937695, 7358.742444014434, 7469.290417410337, 7477.401807855467, 7481.364084052916, 5491.395946445968, 5529.30883639545, 5554.694491802989, 5566.860828479321, 5677.602567820378, 5384.165454354581, 5398.13629819227, 5570.665760054248, 5590.944090559043, 5703.971480142573], "value": 4688.7934552627485, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.5619650650661, 340.76316959712995, 346.0190360328469, 348.2964411887988, 350.8070561191344, 5448.809291674792, 5617.297837770278, 5635.154726790978, 5639.68981706006, 5652.897684951426, 5446.2647542581735, 5517.420670829565, 5531.529819965308, 5549.306336707911, 5611.979687312564, 4158.4594002779595, 4220.409142720022, 4299.505556860954, 4330.84842030529, 4350.7607081610495, 4312.353147027955, 4316.374125751764, 4318.632916202127, 4341.348797680342, 4370.519242883281, 4344.413504176927, 4357.411749413836, 4382.9342559861625, 4386.736795792247, 4387.29803231483, 4258.595433433834, 4282.357646353041, 4287.849925252617, 4327.826886924519, 4328.523862375137, 3838.098046958962, 3851.2490064437447, 3864.8454061837774, 3867.8646247381207, 3883.825227864753, 5404.891902161974, 5441.59188060897, 5477.20580515827, 5487.670739755627, 5497.257870187514, 4838.782254798542, 4937.728424936663, 4955.380577427822, 4978.800847966077, 4980.501949805027, 5716.628419152742, 5726.341470730836, 5758.337791154029, 5809.257222833176, 5838.854028649275, 4197.601227883346, 4211.43145675333, 4211.620954114144, 4214.304639734441, 4216.219999300109, 5633.0, 5936.7328470218945, 5940.0, 5980.730867110947, 6118.5009672630495, 4114.490161001787, 4148.502179738451, 4163.979824942909, 4166.58334166587, 4184.079502509443, 4179.686523510749, 4205.516365617932, 4211.241976444208, 4216.198922204771, 4231.555686652919, 4767.141914455431, 4837.95162048382, 4846.418429788448, 4865.537773911473, 4895.755212239374, 5817.592768506164, 5820.9813282676205, 5833.445822646927, 5863.941360586425, 5880.088586269135, 1470.3677418710058, 1483.428879881232, 1484.8812095032372, 1491.7687758397465, 1493.313075985059, 931.9440833550009, 950.9144177024101, 952.5284983932997, 958.9691082086784, 976.5605477534996, 4917.483664215278, 4937.654364194544, 4953.950460495421, 4968.583953573287, 5047.394312682502, 5220.0, 5279.337008842279, 5314.73426328682, 5325.562098233455, 5339.866503337447, 4691.74796097875, 4910.459849416561, 4925.532074452921, 4962.503749625009, 5051.852962490927, 2793.329600895811, 2806.5088609493255, 2808.0, 2816.507111255522, 2846.5018621741115, 5369.7583608737705, 5381.031414345377, 5434.239206511092, 5482.245681381999, 5515.862103447446, 5073.943505283042, 5180.352455943007, 5308.256844041837, 5328.973355133277, 5362.82017956049, 5432.728363581884, 5443.265159203536, 5444.0, 5503.532199762985, 5508.9724551376985, 4883.389576302962, 5257.316548848626, 5311.521963023347, 5386.784528618811, 5401.540869026177, 5065.240213967787, 5135.92296115566, 5228.686278823283, 5249.296612244773, 5270.446603106772, 5410.917816436807, 5431.958103462074, 5462.8361149165585, 5476.698781567052, 5494.450554944474, 3838.7312888097563, 3862.3627101529055, 3867.2458870521104, 3883.786391748481, 3898.5185629460625, 5775.595708300379, 5896.410358964241, 5909.172715819875, 5928.733207005609, 5990.430909063632, 5733.913991290051, 5788.739506722123, 5803.506701930383, 5825.2135961644635, 5831.912521312269, 5827.6794776286015, 5837.532997360286, 5846.853828654318, 5860.882782344244, 5870.823875283749, 5706.885862282648, 5784.7107644618445, 5821.301443826768, 5823.272090988627, 5831.375880853718, 5839.554662748998, 5841.2406387171095, 5888.558358123072, 5892.175095486549, 5930.406959304035, 5602.0, 5733.741981610754, 5746.798862039976, 5756.568257380797, 5764.625299355696], "value": 4270.294072171777, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.9237780033096, 738.8337624034593, 747.0, 772.3898120484818, 787.4212453846426, 15805.525834224978, 16259.51221463355, 16863.747043794352, 16864.409745658904, 17079.743803842954, 15644.843551564481, 15793.210339483037, 15843.20783960803, 15882.602934926605, 15905.761413578777, 475.3297850031456, 797.8404319136182, 803.4054799448395, 803.5580430763086, 804.8953636027309, 787.7282337593521, 799.400449662753, 801.4710291207804, 805.9717909873156, 808.559335162335, 845.0239972831359, 845.0957475501216, 845.6786421159951, 849.2908421468081, 849.5752123938031, 835.2983493865182, 838.2288294768828, 842.1662554071456, 843.5571325054334, 843.633019636457, 615.1480199923094, 615.4338009031702, 615.7660089166133, 616.2666426951913, 616.442119881508, 15350.232488375648, 15729.134897580629, 15780.132092734895, 15795.368185272575, 15881.205939703084, 16060.919695401448, 16086.678266434723, 16105.27526261321, 16280.0, 16287.104209268486, 12496.8125478117, 12616.369181540886, 12678.492860285669, 12692.873071269354, 12822.551210707674, 3995.52850577568, 4023.7988100594853, 4025.818838152261, 4026.697997650188, 4062.7765472898977, 83524.58237708833, 83650.58174709088, 87089.12910870873, 88844.55577722135, 89341.55329223312, 11837.822432663517, 11892.167548271711, 12141.0, 12367.319797411228, 12565.497380104876, 23807.285781426584, 24050.63924041141, 24071.157509487435, 24087.397815054763, 24189.51620967606, 8720.78198045054, 8881.777955551162, 8990.955045224731, 9111.863322050174, 9116.680916167903, 5013.749312534359, 5065.290859279704, 5081.898362032739, 5133.974330128325, 5339.252504649352, 3639.7088232941833, 3745.700343972476, 3784.299904517673, 3803.3344164771056, 3806.4861243732294, 590.1825971030069, 600.4535872356134, 602.4006113916681, 603.8852618002566, 614.9569530132848, 659.6174218952996, 726.5469061876247, 739.1425945902727, 757.8673732096861, 784.0043145205557, 10343.581186466616, 10553.47232638365, 10562.524686389132, 11458.541658333574, 11919.523219071314, 595.5979713693326, 616.7295371534653, 686.9107016087877, 767.760067490998, 808.0, 4890.388701412324, 5010.148274793294, 5163.3545806774155, 5175.689458632419, 5235.267062611238, 101736.0, 104654.4767276174, 119456.40271798585, 128767.0, 129460.3526982359, 99849.50075249578, 100408.49795751121, 101074.4946275264, 102443.0, 106844.46577767062, 87520.56239718889, 88234.55882720546, 90227.54886225527, 90236.54881725549, 90678.54660726654, 10289.073983341535, 10692.305000175274, 11010.449477526252, 11024.834627480433, 11058.612948546763, 52228.73885630548, 54102.48333858287, 55273.0, 55385.44614553964, 55446.44553554413, 46487.53512464832, 46665.76667116643, 74418.0, 74950.25049749651, 77225.0, 12763.617091487271, 12930.224186548838, 13190.493806176795, 13452.730945381234, 13797.310134493437, 15648.217589120726, 15745.44890928812, 15962.28169732388, 16108.67782644364, 16645.583860403585, 14496.85503144955, 14556.272186390426, 14708.926455367655, 15206.46777362787, 15792.526224213292, 14175.291235438393, 14866.256687165815, 14963.625909352353, 14981.775273371126, 14984.700305994038, 14052.508162214273, 14097.365618546984, 14446.133232006114, 14704.632384190481, 14809.92595037018, 10841.783164336512, 11011.889881101408, 11343.205975581961, 11364.261323013978, 11430.657080287272, 10090.848637270594, 10500.947495262475, 11455.713607159887, 12180.87819121833, 12711.74576508446], "value": 7862.07616699851, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1520.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 107.0, 112.0, 112.0, 114.0, 112.0, 110.0, 110.0, 112.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 123.0, 141.0, 182.0, 117.0, 151.0, 149.0, 121.0, 171.0, 119.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 162.0, 163.0, 163.0, 168.0, 176.0, 164.0, 163.0, 162.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 184.0, 76.0, 76.0, 75.0, 77.0, 164.0, 77.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 156.0, 85.0, 84.0, 84.0, 140.0, 84.0, 85.0, 141.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 120.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 147.0, 146.0, 146.0, 147.0, 148.0, 146.0, 148.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 99.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 53.0, 52.0, 51.0, 53.0, 51.0, 51.0, 51.0, 51.0, 52.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 64.0, 64.0, 63.0, 61.0, 61.0, 61.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 76.0, 77.0, 80.0, 75.0, 81.0, 75.0, 81.0, 77.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 125.0, 127.0, 130.0, 131.0, 130.0, 132.0, 124.0, 141.0, 124.0], "value": 129.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 159.0, 159.0, 160.0, 158.0, 159.0, 158.0, 156.0, 159.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 64.0, 66.0, 67.0, 63.0, 66.0, 68.0, 62.0, 63.0], "value": 65.2, "unit": "score"}]}]} 20:38:18 INFO - Return code: 0 20:38:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:38:18 ERROR - # TBPL SUCCESS # 20:38:18 INFO - Running post-action listener: _resource_record_post_action 20:38:18 INFO - [mozharness: 2016-08-11 03:38:18.310432Z] Finished run-tests step (success) 20:38:18 INFO - Running post-run listener: _resource_record_post_run 20:38:18 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 557940736; Read time: 0; Write time: 574552 20:38:18 INFO - TinderboxPrint: CPU usage
13.4% 20:38:18 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 20:38:18 INFO - TinderboxPrint: I/O write bytes / time
557,940,736 / 574,552 20:38:18 INFO - TinderboxPrint: CPU idle
8,232.3 (86.6%) 20:38:18 INFO - TinderboxPrint: CPU user
1,219.4 (12.8%) 20:38:18 INFO - TinderboxPrint: Swap in / out
0 / 0 20:38:18 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 259698688; Read time: 0; Write time: 335480 20:38:18 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 293416960; Read time: 0; Write time: 238212 20:38:18 INFO - Running post-run listener: _upload_blobber_files 20:38:18 INFO - Blob upload gear active. 20:38:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:38:18 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 20:38:18 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'] 20:38:18 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 20:38:19 INFO - (blobuploader) - INFO - Open directory for files ... 20:38:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:38:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:38:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:38:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:38:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:38:20 INFO - (blobuploader) - INFO - Done attempting. 20:38:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:38:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:38:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:38:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:38:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:38:21 INFO - (blobuploader) - INFO - Done attempting. 20:38:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:38:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:38:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:38:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:38:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:38:25 INFO - (blobuploader) - INFO - Done attempting. 20:38:25 INFO - (blobuploader) - INFO - Iteration through files over. 20:38:25 INFO - Return code: 0 20:38:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:38:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:38:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4d124307d8f7ed55479c34aee8a8cf09f55542ab644b0b4ddc1042b40a9a7467a9452324796ec7c4894e4589797d2634be03512bd783e1bf205ae996118be4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e65c632060bb778fcb30c1828a4fe9f59de3b3ca1c43c42c71fe1ae66c08e2043379c9171f48fcde5aec9e0225875bd6113fc447b2b4ad7fc99967ac77c302bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/603a16cadaa4d32ca56952478af4b9fade26a0833cdc0ac73f17bafa590896cdc559bd09eeac3864bd9ab58c120c8b036f9ab2ef45ceab6834972771f9f031fd"} 20:38:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:38:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:38:25 INFO - Contents: 20:38:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4d124307d8f7ed55479c34aee8a8cf09f55542ab644b0b4ddc1042b40a9a7467a9452324796ec7c4894e4589797d2634be03512bd783e1bf205ae996118be4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e65c632060bb778fcb30c1828a4fe9f59de3b3ca1c43c42c71fe1ae66c08e2043379c9171f48fcde5aec9e0225875bd6113fc447b2b4ad7fc99967ac77c302bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/603a16cadaa4d32ca56952478af4b9fade26a0833cdc0ac73f17bafa590896cdc559bd09eeac3864bd9ab58c120c8b036f9ab2ef45ceab6834972771f9f031fd"} 20:38:25 INFO - Running post-run listener: copy_logs_to_upload_dir 20:38:25 INFO - Copying logs to upload dir... 20:38:25 INFO - mkdir: /builds/slave/test/build/upload/logs 20:38:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.493053 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-08-10 20:38:24.557437) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 20:38:24.560573) ========= 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=db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4d124307d8f7ed55479c34aee8a8cf09f55542ab644b0b4ddc1042b40a9a7467a9452324796ec7c4894e4589797d2634be03512bd783e1bf205ae996118be4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e65c632060bb778fcb30c1828a4fe9f59de3b3ca1c43c42c71fe1ae66c08e2043379c9171f48fcde5aec9e0225875bd6113fc447b2b4ad7fc99967ac77c302bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/603a16cadaa4d32ca56952478af4b9fade26a0833cdc0ac73f17bafa590896cdc559bd09eeac3864bd9ab58c120c8b036f9ab2ef45ceab6834972771f9f031fd"} build_url:https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011313 build_url: 'https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4d124307d8f7ed55479c34aee8a8cf09f55542ab644b0b4ddc1042b40a9a7467a9452324796ec7c4894e4589797d2634be03512bd783e1bf205ae996118be4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e65c632060bb778fcb30c1828a4fe9f59de3b3ca1c43c42c71fe1ae66c08e2043379c9171f48fcde5aec9e0225875bd6113fc447b2b4ad7fc99967ac77c302bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/603a16cadaa4d32ca56952478af4b9fade26a0833cdc0ac73f17bafa590896cdc559bd09eeac3864bd9ab58c120c8b036f9ab2ef45ceab6834972771f9f031fd"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 20:38:24.617330) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 20:38:24.617651) ========= 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=db7e7c15f3ca076d53731445000001ba-1470884472.976368-1589156839 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.14 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 20:38:24.763586) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 20:38:24.763894) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 20:38:24.764268) ========= ========= Total master_lag: 1.34 =========