builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-041 starttime: 1490959740.58 results: success (0) revision: 03d602fd723ad6ff4588c04855884ffa1dee9410 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 04:29:00.581282) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 04:29:00.581706) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 04:29:00.581998) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 04:29:00.596622) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:29:00.596886) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-31 04:29:00-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.2M=0s 2017-03-31 04:29:00 (88.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083817 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:29:00.694793) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:29:00.695137) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020620 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:29:00.745105) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-31 04:29:00.745470) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 03d602fd723ad6ff4588c04855884ffa1dee9410 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 03d602fd723ad6ff4588c04855884ffa1dee9410 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-31 04:29:00,920 truncating revision to first 12 chars 2017-03-31 04:29:00,920 Setting DEBUG logging. 2017-03-31 04:29:00,920 attempt 1/10 2017-03-31 04:29:00,920 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/03d602fd723a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-31 04:29:01,702 unpacking tar archive at: mozilla-central-03d602fd723a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.351699 ========= master_lag: 0.31 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-31 04:29:02.410646) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 04:29:02.411064) ========= script_repo_revision: 03d602fd723ad6ff4588c04855884ffa1dee9410 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 04:29:02.411459) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 04:29:02.411727) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 04:29:02.423978) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-31 04:29:02.424403) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:29:02 INFO - MultiFileLogger online at 20170331 04:29:02 in /builds/slave/test 04:29:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:29:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:29:02 INFO - {'append_to_log': False, 04:29:02 INFO - 'base_work_dir': '/builds/slave/test', 04:29:02 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:29:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:29:02 INFO - 'branch': 'Firefox-Non-PGO', 04:29:02 INFO - 'buildbot_json_path': 'buildprops.json', 04:29:02 INFO - 'config_files': ('talos/linux_config.py',), 04:29:02 INFO - 'default_actions': ('clobber', 04:29:02 INFO - 'read-buildbot-config', 04:29:02 INFO - 'download-and-extract', 04:29:02 INFO - 'populate-webroot', 04:29:02 INFO - 'create-virtualenv', 04:29:02 INFO - 'install', 04:29:02 INFO - 'run-tests'), 04:29:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:29:02 INFO - 'download_minidump_stackwalk': True, 04:29:02 INFO - 'download_symbols': 'ondemand', 04:29:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:29:02 INFO - 'tooltool.py': '/tools/tooltool.py', 04:29:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:29:02 INFO - '/tools/misc-python/virtualenv.py')}, 04:29:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:29:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:29:02 INFO - 'gecko_profile': False, 04:29:02 INFO - 'gecko_profile_interval': 0, 04:29:02 INFO - 'installer_path': 'installer.exe', 04:29:02 INFO - 'log_level': 'info', 04:29:02 INFO - 'log_name': 'talos', 04:29:02 INFO - 'log_to_console': True, 04:29:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:29:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:29:02 INFO - 'opt_config_files': (), 04:29:02 INFO - 'pip_index': False, 04:29:02 INFO - 'suite': 'dromaeojs-e10s', 04:29:02 INFO - 'system_bits': '32', 04:29:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:29:02 INFO - 'title': 'talos-linux64-ix-041', 04:29:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:29:02 INFO - 'use_talos_json': True, 04:29:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:29:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:29:02 INFO - 'work_dir': 'build'} 04:29:02 INFO - [mozharness: 2017-03-31 11:29:02.704133Z] Running clobber step. 04:29:02 INFO - Running pre-action listener: _resource_record_pre_action 04:29:02 INFO - Running main action method: clobber 04:29:02 INFO - rmtree: /builds/slave/test/build 04:29:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:29:03 INFO - Running post-action listener: _resource_record_post_action 04:29:03 INFO - [mozharness: 2017-03-31 11:29:03.703007Z] Finished clobber step (success) 04:29:03 INFO - [mozharness: 2017-03-31 11:29:03.703104Z] Running read-buildbot-config step. 04:29:03 INFO - Running pre-action listener: _resource_record_pre_action 04:29:03 INFO - Running main action method: read_buildbot_config 04:29:03 INFO - Using buildbot properties: 04:29:03 INFO - { 04:29:03 INFO - "project": "", 04:29:03 INFO - "product": "firefox", 04:29:03 INFO - "who": "cbook@mozilla.com", 04:29:03 INFO - "installer_path": "public/build/target.tar.bz2", 04:29:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:29:03 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:29:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:29:03 INFO - "stage_platform": "linux64", 04:29:03 INFO - "basedir": "/builds/slave/test", 04:29:03 INFO - "buildnumber": 497, 04:29:03 INFO - "platform": "ubuntu64_hw", 04:29:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:29:03 INFO - "slavebuilddir": "test", 04:29:03 INFO - "taskId": "UFxz5J0yRrKlEYJovTfBOQ", 04:29:03 INFO - "branch": "mozilla-central", 04:29:03 INFO - "script_repo_revision": "production", 04:29:03 INFO - "revision": "03d602fd723ad6ff4588c04855884ffa1dee9410", 04:29:03 INFO - "slavename": "talos-linux64-ix-041", 04:29:03 INFO - "repo_path": "mozilla-central" 04:29:03 INFO - } 04:29:03 INFO - Finding installer, test and symbols from parent task. 04:29:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UFxz5J0yRrKlEYJovTfBOQ'}, attempt #1 04:29:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UFxz5J0yRrKlEYJovTfBOQ'}, attempt #1 04:29:04 INFO - Task dependencies: FziPe46tTL-TfFHS0Z7sXw 04:29:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw'}, attempt #1 04:29:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 04:29:05 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/test_packages.json 04:29:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.crashreporter-symbols.zip 04:29:05 INFO - Running post-action listener: _resource_record_post_action 04:29:05 INFO - [mozharness: 2017-03-31 11:29:05.112726Z] Finished read-buildbot-config step (success) 04:29:05 INFO - [mozharness: 2017-03-31 11:29:05.112942Z] Running download-and-extract step. 04:29:05 INFO - Running pre-action listener: _resource_record_pre_action 04:29:05 INFO - Running main action method: download_and_extract 04:29:05 INFO - mkdir: /builds/slave/test/build/tests 04:29:05 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')]} 04:29:05 INFO - trying https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.test_packages.json 04:29:05 INFO - Downloading https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:29:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:29:05 INFO - Downloaded 986 bytes. 04:29:05 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:29:05 INFO - Using the following test package requirements: 04:29:05 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:29:05 INFO - u'common': [u'target.common.tests.zip'], 04:29:05 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:29:05 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:29:05 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:29:05 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:29:05 INFO - u'mozbase': [u'target.common.tests.zip'], 04:29:05 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:29:05 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:29:05 INFO - u'web-platform': [u'target.common.tests.zip', 04:29:05 INFO - u'target.web-platform.tests.zip'], 04:29:05 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:29:05 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:29:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip 04:29:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:29:05 INFO - Fetch https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip into memory 04:29:06 INFO - Expected file size: 58227794 04:29:06 INFO - Obtained file size: 58227794 04:29:16 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:29:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip 04:29:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:29:16 INFO - Fetch https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip into memory 04:29:17 INFO - Expected file size: 58227794 04:29:17 INFO - Obtained file size: 58227794 04:29:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.talos.tests.zip 04:29:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:29:28 INFO - Fetch https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.talos.tests.zip into memory 04:29:29 INFO - Expected file size: 14404152 04:29:29 INFO - Obtained file size: 14404152 04:29:29 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')]} 04:29:29 INFO - trying https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 04:29:29 INFO - Downloading https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:29:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:29:30 INFO - Downloaded 62478421 bytes. 04:29:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 04:29:30 INFO - mkdir: /builds/slave/test/properties 04:29:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:29:30 INFO - Writing to file /builds/slave/test/properties/build_url 04:29:30 INFO - Contents: 04:29:30 INFO - build_url:https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 04:29:30 INFO - Running post-action listener: _resource_record_post_action 04:29:30 INFO - Running post-action listener: set_extra_try_arguments 04:29:30 INFO - [mozharness: 2017-03-31 11:29:30.792152Z] Finished download-and-extract step (success) 04:29:30 INFO - [mozharness: 2017-03-31 11:29:30.792247Z] Running populate-webroot step. 04:29:30 INFO - Running pre-action listener: _resource_record_pre_action 04:29:30 INFO - Running main action method: populate_webroot 04:29:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:29:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:29:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:29:30 INFO - '--tppagecycles', 04:29:30 INFO - '7'], 04:29:30 INFO - 'tests': ['tsvgm']}}, 04:29:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:29:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:29:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:29:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:29:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:29:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:29:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:29:30 INFO - 'talos_options': ['--disable-e10s'], 04:29:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:29:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:29:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:29:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:29:30 INFO - 'talos_options': ['--disable-e10s'], 04:29:30 INFO - 'tests': ['damp', 'tps']}, 04:29:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:29:30 INFO - 'tests': ['damp', 'tps']}, 04:29:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:29:30 INFO - 'tests': ['dromaeo_dom']}, 04:29:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:29:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:29:30 INFO - 'tests': ['basic_compositor_video']}, 04:29:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:29:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:29:30 INFO - 'tests': ['a11yr', 04:29:30 INFO - 'ts_paint', 04:29:30 INFO - 'tpaint', 04:29:30 INFO - 'sessionrestore', 04:29:30 INFO - 'sessionrestore_no_auto_restore', 04:29:30 INFO - 'tabpaint']}, 04:29:30 INFO - 'other-e10s': {'tests': ['a11yr', 04:29:30 INFO - 'ts_paint', 04:29:30 INFO - 'tpaint', 04:29:30 INFO - 'sessionrestore', 04:29:30 INFO - 'sessionrestore_no_auto_restore', 04:29:30 INFO - 'tabpaint']}, 04:29:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:29:30 INFO - 'ts_paint', 04:29:30 INFO - 'tpaint', 04:29:30 INFO - 'sessionrestore', 04:29:30 INFO - 'sessionrestore_no_auto_restore', 04:29:30 INFO - 'tabpaint']}, 04:29:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:29:30 INFO - 'ts_paint', 04:29:30 INFO - 'tpaint', 04:29:30 INFO - 'sessionrestore', 04:29:30 INFO - 'sessionrestore_no_auto_restore', 04:29:30 INFO - 'tabpaint']}, 04:29:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:29:30 INFO - 'tests': ['a11yr', 04:29:30 INFO - 'ts_paint', 04:29:30 INFO - 'tpaint', 04:29:30 INFO - 'sessionrestore', 04:29:30 INFO - 'sessionrestore_no_auto_restore', 04:29:30 INFO - 'tabpaint']}, 04:29:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:29:30 INFO - 'tests': ['a11yr', 04:29:30 INFO - 'ts_paint', 04:29:30 INFO - 'tpaint', 04:29:30 INFO - 'sessionrestore', 04:29:30 INFO - 'sessionrestore_no_auto_restore', 04:29:30 INFO - 'tabpaint']}, 04:29:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:29:30 INFO - 'tests': ['tsvgx', 04:29:30 INFO - 'tsvgr_opacity', 04:29:30 INFO - 'tart', 04:29:30 INFO - 'tscrollx', 04:29:30 INFO - 'cart', 04:29:30 INFO - 'tsvg_static']}, 04:29:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:29:30 INFO - 'tsvgr_opacity', 04:29:30 INFO - 'tart', 04:29:30 INFO - 'tscrollx', 04:29:30 INFO - 'cart', 04:29:30 INFO - 'tsvg_static']}, 04:29:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:29:30 INFO - 'talos_options': ['--disable-e10s'], 04:29:30 INFO - 'tests': ['tp5o']}, 04:29:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:29:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:29:30 INFO - 'talos_options': ['--disable-e10s', 04:29:30 INFO - '--xperf_path', 04:29:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:29:30 INFO - 'tests': ['tp5n']}, 04:29:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:29:30 INFO - 'talos_options': ['--xperf_path', 04:29:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:29:30 INFO - 'tests': ['tp5n']}}, 04:29:30 INFO - 'talos.zip': {'path': '', 04:29:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:29:30 INFO - Running post-action listener: _resource_record_post_action 04:29:30 INFO - [mozharness: 2017-03-31 11:29:30.805275Z] Finished populate-webroot step (success) 04:29:30 INFO - [mozharness: 2017-03-31 11:29:30.805373Z] Running create-virtualenv step. 04:29:30 INFO - Running pre-action listener: _resource_record_pre_action 04:29:30 INFO - Running main action method: create_virtualenv 04:29:30 INFO - Creating virtualenv /builds/slave/test/build/venv 04:29:30 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 04:29:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:29:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:29:30 INFO - Using real prefix '/usr' 04:29:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:29:31 INFO - Installing distribute.............................................................................................................................................................................................done. 04:29:33 INFO - Installing pip.................done. 04:29:33 INFO - Return code: 0 04:29:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:29:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:29:33 INFO - Reading from file tmpfile_stdout 04:29:33 INFO - Output received: 04:29:33 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:29:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:29:33 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')]} 04:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:33 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')]} 04:29:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:33 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 0x1ca81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f45b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f43290>, '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 0x1f43b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f44040>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995', '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 04:29:33 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 04:29:33 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 04:29:33 INFO - Using env: {'DISPLAY': ':0', 04:29:33 INFO - 'HOME': '/home/cltbld', 04:29:33 INFO - 'LANG': 'en_US.UTF-8', 04:29:33 INFO - 'LANGUAGE': 'en_US:en', 04:29:33 INFO - 'LOGNAME': 'cltbld', 04:29:33 INFO - 'MAIL': '/var/mail/cltbld', 04:29:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:33 INFO - 'MOZ_NO_REMOTE': '1', 04:29:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:33 INFO - 'NO_EM_RESTART': '1', 04:29:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:33 INFO - 'PWD': '/builds/slave/test', 04:29:33 INFO - 'SHELL': '/bin/bash', 04:29:33 INFO - 'SHLVL': '1', 04:29:33 INFO - 'TERM': 'linux', 04:29:33 INFO - 'TMOUT': '86400', 04:29:33 INFO - 'USER': 'cltbld', 04:29:33 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995', 04:29:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:33 INFO - '_': '/tools/buildbot/bin/python'} 04:29:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:33 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 04:29:33 INFO - Cleaning up... 04:29:33 INFO - Return code: 0 04:29:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:29:33 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')]} 04:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:33 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')]} 04:29:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:33 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 0x1ca81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f45b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f43290>, '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 0x1f43b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f44040>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995', '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 04:29:33 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 04:29:33 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 04:29:33 INFO - Using env: {'DISPLAY': ':0', 04:29:33 INFO - 'HOME': '/home/cltbld', 04:29:33 INFO - 'LANG': 'en_US.UTF-8', 04:29:33 INFO - 'LANGUAGE': 'en_US:en', 04:29:33 INFO - 'LOGNAME': 'cltbld', 04:29:33 INFO - 'MAIL': '/var/mail/cltbld', 04:29:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:33 INFO - 'MOZ_NO_REMOTE': '1', 04:29:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:33 INFO - 'NO_EM_RESTART': '1', 04:29:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:33 INFO - 'PWD': '/builds/slave/test', 04:29:33 INFO - 'SHELL': '/bin/bash', 04:29:33 INFO - 'SHLVL': '1', 04:29:33 INFO - 'TERM': 'linux', 04:29:33 INFO - 'TMOUT': '86400', 04:29:33 INFO - 'USER': 'cltbld', 04:29:33 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995', 04:29:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:33 INFO - '_': '/tools/buildbot/bin/python'} 04:29:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:34 INFO - Downloading/unpacking psutil>=3.1.1 04:29:34 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 04:29:34 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 04:29:34 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 04:29:34 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 04:29:34 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 04:29:34 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 04:29:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:29:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:29:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:29:36 INFO - Installing collected packages: psutil 04:29:36 INFO - Running setup.py install for psutil 04:29:36 INFO - building 'psutil._psutil_linux' extension 04:29:36 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 04:29:36 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 04:29:36 INFO - building 'psutil._psutil_posix' extension 04:29:36 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 04:29:36 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 04:29:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:29:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:29:36 INFO - Successfully installed psutil 04:29:36 INFO - Cleaning up... 04:29:36 INFO - Return code: 0 04:29:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:29:36 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')]} 04:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:36 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')]} 04:29:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:36 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 0x1ca81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f45b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f43290>, '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 0x1f43b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f44040>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995', '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 04:29:36 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 04:29:36 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 04:29:36 INFO - Using env: {'DISPLAY': ':0', 04:29:36 INFO - 'HOME': '/home/cltbld', 04:29:36 INFO - 'LANG': 'en_US.UTF-8', 04:29:36 INFO - 'LANGUAGE': 'en_US:en', 04:29:36 INFO - 'LOGNAME': 'cltbld', 04:29:36 INFO - 'MAIL': '/var/mail/cltbld', 04:29:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:36 INFO - 'MOZ_NO_REMOTE': '1', 04:29:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:36 INFO - 'NO_EM_RESTART': '1', 04:29:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:36 INFO - 'PWD': '/builds/slave/test', 04:29:36 INFO - 'SHELL': '/bin/bash', 04:29:36 INFO - 'SHLVL': '1', 04:29:36 INFO - 'TERM': 'linux', 04:29:36 INFO - 'TMOUT': '86400', 04:29:36 INFO - 'USER': 'cltbld', 04:29:36 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995', 04:29:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:36 INFO - '_': '/tools/buildbot/bin/python'} 04:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:29:37 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 04:29:37 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 04:29:37 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 04:29:37 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 04:29:37 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 04:29:37 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 04:29:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:29:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:29:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:29:39 INFO - Installing collected packages: mozsystemmonitor 04:29:39 INFO - Running setup.py install for mozsystemmonitor 04:29:39 INFO - Successfully installed mozsystemmonitor 04:29:39 INFO - Cleaning up... 04:29:39 INFO - Return code: 0 04:29:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:29:39 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')]} 04:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:39 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')]} 04:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:39 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 0x1ca81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f45b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f43290>, '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 0x1f43b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f44040>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995', '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 04:29:39 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 04:29:39 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 04:29:39 INFO - Using env: {'DISPLAY': ':0', 04:29:39 INFO - 'HOME': '/home/cltbld', 04:29:39 INFO - 'LANG': 'en_US.UTF-8', 04:29:39 INFO - 'LANGUAGE': 'en_US:en', 04:29:39 INFO - 'LOGNAME': 'cltbld', 04:29:39 INFO - 'MAIL': '/var/mail/cltbld', 04:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:39 INFO - 'MOZ_NO_REMOTE': '1', 04:29:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:39 INFO - 'NO_EM_RESTART': '1', 04:29:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:39 INFO - 'PWD': '/builds/slave/test', 04:29:39 INFO - 'SHELL': '/bin/bash', 04:29:39 INFO - 'SHLVL': '1', 04:29:39 INFO - 'TERM': 'linux', 04:29:39 INFO - 'TMOUT': '86400', 04:29:39 INFO - 'USER': 'cltbld', 04:29:39 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995', 04:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:39 INFO - '_': '/tools/buildbot/bin/python'} 04:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:39 INFO - Downloading/unpacking jsonschema==2.5.1 04:29:39 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 04:29:39 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 04:29:39 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 04:29:39 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 04:29:39 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 04:29:39 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 04:29:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:29:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:29:41 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 04:29:41 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 04:29:41 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 04:29:41 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 04:29:41 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 04:29:41 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 04:29:41 INFO - Downloading functools32-3.2.3-2.tar.gz 04:29:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:29:41 INFO - warning: no files found matching '*.txt' 04:29:41 INFO - no previously-included directories found matching 'build' 04:29:41 INFO - no previously-included directories found matching 'dist' 04:29:41 INFO - no previously-included directories found matching '.git*' 04:29:41 INFO - Installing collected packages: jsonschema, functools32 04:29:41 INFO - Running setup.py install for functools32 04:29:41 INFO - warning: no files found matching '*.txt' 04:29:41 INFO - no previously-included directories found matching 'build' 04:29:41 INFO - no previously-included directories found matching 'dist' 04:29:41 INFO - no previously-included directories found matching '.git*' 04:29:41 INFO - Successfully installed jsonschema functools32 04:29:41 INFO - Cleaning up... 04:29:41 INFO - Return code: 0 04:29:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:29:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:41 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 0x1ca81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f45b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f43290>, '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 0x1f43b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f44040>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995', '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 04:29:41 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 04:29:41 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 04:29:41 INFO - Using env: {'DISPLAY': ':0', 04:29:41 INFO - 'HOME': '/home/cltbld', 04:29:41 INFO - 'LANG': 'en_US.UTF-8', 04:29:41 INFO - 'LANGUAGE': 'en_US:en', 04:29:41 INFO - 'LOGNAME': 'cltbld', 04:29:41 INFO - 'MAIL': '/var/mail/cltbld', 04:29:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:41 INFO - 'MOZ_NO_REMOTE': '1', 04:29:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:41 INFO - 'NO_EM_RESTART': '1', 04:29:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:41 INFO - 'PWD': '/builds/slave/test', 04:29:41 INFO - 'SHELL': '/bin/bash', 04:29:41 INFO - 'SHLVL': '1', 04:29:41 INFO - 'TERM': 'linux', 04:29:41 INFO - 'TMOUT': '86400', 04:29:41 INFO - 'USER': 'cltbld', 04:29:41 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995', 04:29:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:41 INFO - '_': '/tools/buildbot/bin/python'} 04:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:29:42 INFO - Cleaning up... 04:29:42 INFO - Return code: 0 04:29:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:42 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 0x1ca81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f45b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f43290>, '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 0x1f43b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f44040>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995', '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 04:29:42 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 04:29:42 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 04:29:42 INFO - Using env: {'DISPLAY': ':0', 04:29:42 INFO - 'HOME': '/home/cltbld', 04:29:42 INFO - 'LANG': 'en_US.UTF-8', 04:29:42 INFO - 'LANGUAGE': 'en_US:en', 04:29:42 INFO - 'LOGNAME': 'cltbld', 04:29:42 INFO - 'MAIL': '/var/mail/cltbld', 04:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:42 INFO - 'MOZ_NO_REMOTE': '1', 04:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:42 INFO - 'NO_EM_RESTART': '1', 04:29:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:42 INFO - 'PWD': '/builds/slave/test', 04:29:42 INFO - 'SHELL': '/bin/bash', 04:29:42 INFO - 'SHLVL': '1', 04:29:42 INFO - 'TERM': 'linux', 04:29:42 INFO - 'TMOUT': '86400', 04:29:42 INFO - 'USER': 'cltbld', 04:29:42 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995', 04:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:42 INFO - '_': '/tools/buildbot/bin/python'} 04:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:42 INFO - Downloading/unpacking blobuploader==1.2.4 04:29:42 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 04:29:42 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 04:29:42 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 04:29:42 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 04:29:42 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 04:29:42 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 04:29:44 INFO - Downloading blobuploader-1.2.4.tar.gz 04:29:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:29:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:29:44 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 04:29:44 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 04:29:44 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 04:29:44 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 04:29:44 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 04:29:44 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 04:29:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:29:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:29:44 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 04:29:44 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 04:29:44 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 04:29:44 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 04:29:44 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 04:29:44 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 04:29:45 INFO - Downloading docopt-0.6.1.tar.gz 04:29:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:29:45 INFO - Installing collected packages: blobuploader, requests, docopt 04:29:45 INFO - Running setup.py install for blobuploader 04:29:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:29:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:29:45 INFO - Running setup.py install for requests 04:29:45 INFO - Running setup.py install for docopt 04:29:45 INFO - Successfully installed blobuploader requests docopt 04:29:45 INFO - Cleaning up... 04:29:45 INFO - Return code: 0 04:29:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:45 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 0x1ca81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f45b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f43290>, '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 0x1f43b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f44040>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995', '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 04:29:45 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 04:29:45 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 04:29:45 INFO - Using env: {'DISPLAY': ':0', 04:29:45 INFO - 'HOME': '/home/cltbld', 04:29:45 INFO - 'LANG': 'en_US.UTF-8', 04:29:45 INFO - 'LANGUAGE': 'en_US:en', 04:29:45 INFO - 'LOGNAME': 'cltbld', 04:29:45 INFO - 'MAIL': '/var/mail/cltbld', 04:29:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:45 INFO - 'MOZ_NO_REMOTE': '1', 04:29:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:45 INFO - 'NO_EM_RESTART': '1', 04:29:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:45 INFO - 'PWD': '/builds/slave/test', 04:29:45 INFO - 'SHELL': '/bin/bash', 04:29:45 INFO - 'SHLVL': '1', 04:29:45 INFO - 'TERM': 'linux', 04:29:45 INFO - 'TMOUT': '86400', 04:29:45 INFO - 'USER': 'cltbld', 04:29:45 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995', 04:29:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:45 INFO - '_': '/tools/buildbot/bin/python'} 04:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:29:46 INFO - Running setup.py (path:/tmp/pip-K8pSo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:29:46 INFO - Running setup.py (path:/tmp/pip-_fExZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:29:46 INFO - Running setup.py (path:/tmp/pip-FKcQkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:29:46 INFO - Running setup.py (path:/tmp/pip-1FXjnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:29:46 INFO - Running setup.py (path:/tmp/pip-czofBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:29:46 INFO - Running setup.py (path:/tmp/pip-2fs0TF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:29:46 INFO - Running setup.py (path:/tmp/pip-besauk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:29:46 INFO - Running setup.py (path:/tmp/pip-9km55Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:29:46 INFO - Running setup.py (path:/tmp/pip-PTL8dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:29:46 INFO - Running setup.py (path:/tmp/pip-JnWK1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:29:46 INFO - Running setup.py (path:/tmp/pip-cQvI6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:29:46 INFO - Running setup.py (path:/tmp/pip-sH3Cs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:29:46 INFO - Running setup.py (path:/tmp/pip-Ptlqp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:29:47 INFO - Running setup.py (path:/tmp/pip-miZRlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:47 INFO - Running setup.py (path:/tmp/pip-cUAPnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:29:47 INFO - Running setup.py (path:/tmp/pip-BZQnAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:29:47 INFO - Running setup.py (path:/tmp/pip-cRi8Yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:29:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:29:47 INFO - Running setup.py install for manifestparser 04:29:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:29:47 INFO - Running setup.py install for mozcrash 04:29:47 INFO - Running setup.py install for mozdebug 04:29:47 INFO - Running setup.py install for mozdevice 04:29:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:29:47 INFO - Running setup.py install for mozfile 04:29:47 INFO - Running setup.py install for mozhttpd 04:29:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:29:47 INFO - Running setup.py install for mozinfo 04:29:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:29:48 INFO - Running setup.py install for mozInstall 04:29:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:29:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:29:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:29:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:29:48 INFO - Running setup.py install for mozleak 04:29:48 INFO - Running setup.py install for mozlog 04:29:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:29:48 INFO - Running setup.py install for moznetwork 04:29:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:29:48 INFO - Running setup.py install for mozprocess 04:29:48 INFO - Running setup.py install for mozprofile 04:29:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:29:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:29:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:29:48 INFO - Running setup.py install for mozrunner 04:29:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:29:48 INFO - Running setup.py install for mozscreenshot 04:29:48 INFO - Running setup.py install for moztest 04:29:48 INFO - Running setup.py install for mozversion 04:29:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:29:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:29:49 INFO - Cleaning up... 04:29:49 INFO - Return code: 0 04:29:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:49 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 0x1ca81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f45b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f43290>, '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 0x1f43b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f44040>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995', '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 04:29:49 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 04:29:49 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 04:29:49 INFO - Using env: {'DISPLAY': ':0', 04:29:49 INFO - 'HOME': '/home/cltbld', 04:29:49 INFO - 'LANG': 'en_US.UTF-8', 04:29:49 INFO - 'LANGUAGE': 'en_US:en', 04:29:49 INFO - 'LOGNAME': 'cltbld', 04:29:49 INFO - 'MAIL': '/var/mail/cltbld', 04:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:49 INFO - 'MOZ_NO_REMOTE': '1', 04:29:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:49 INFO - 'NO_EM_RESTART': '1', 04:29:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:49 INFO - 'PWD': '/builds/slave/test', 04:29:49 INFO - 'SHELL': '/bin/bash', 04:29:49 INFO - 'SHLVL': '1', 04:29:49 INFO - 'TERM': 'linux', 04:29:49 INFO - 'TMOUT': '86400', 04:29:49 INFO - 'USER': 'cltbld', 04:29:49 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995', 04:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:49 INFO - '_': '/tools/buildbot/bin/python'} 04:29:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:29:49 INFO - Running setup.py (path:/tmp/pip-UZJzOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:29:49 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)) 04:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:29:49 INFO - Running setup.py (path:/tmp/pip-wBVfem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:29:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 04:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:29:49 INFO - Running setup.py (path:/tmp/pip-VEfB7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:29:49 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)) 04:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:29:49 INFO - Running setup.py (path:/tmp/pip-dmz_3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:29:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 04:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:29:49 INFO - Running setup.py (path:/tmp/pip-ZniePc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:29:49 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)) 04:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:29:49 INFO - Running setup.py (path:/tmp/pip-UIlJSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:29:49 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)) 04:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:29:49 INFO - Running setup.py (path:/tmp/pip-rBVT5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:29:49 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)) 04:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:29:49 INFO - Running setup.py (path:/tmp/pip-MAaxZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:29:49 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)) 04:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:29:49 INFO - Running setup.py (path:/tmp/pip-nlGMsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:29:49 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)) 04:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:29:49 INFO - Running setup.py (path:/tmp/pip-UiZ6rp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:29:50 INFO - Running setup.py (path:/tmp/pip-BXkPHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:29:50 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)) 04:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:29:50 INFO - Running setup.py (path:/tmp/pip-GjVfN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 04:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:29:50 INFO - Running setup.py (path:/tmp/pip-Ce4Jpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:29:50 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)) 04:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:29:50 INFO - Running setup.py (path:/tmp/pip-whHbXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 04:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:50 INFO - Running setup.py (path:/tmp/pip-kvRAk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:50 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)) 04:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:29:50 INFO - Running setup.py (path:/tmp/pip-Kt0hSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 04:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:29:50 INFO - Running setup.py (path:/tmp/pip-F833Pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:29:50 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)) 04:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:29:50 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)) 04:29:50 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:29:50 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:29:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:29:50 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 04:29:50 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 04:29:50 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 04:29:50 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 04:29:50 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 04:29:50 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 04:29:52 INFO - Downloading blessings-1.6.tar.gz 04:29:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:29:52 INFO - Installing collected packages: blessings 04:29:52 INFO - Running setup.py install for blessings 04:29:52 INFO - Successfully installed blessings 04:29:52 INFO - Cleaning up... 04:29:52 INFO - Return code: 0 04:29:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:29:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:29:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:29:53 INFO - Reading from file tmpfile_stdout 04:29:53 INFO - Current package versions: 04:29:53 INFO - argparse == 1.2.1 04:29:53 INFO - blessings == 1.6 04:29:53 INFO - blobuploader == 1.2.4 04:29:53 INFO - docopt == 0.6.1 04:29:53 INFO - functools32 == 3.2.3-2 04:29:53 INFO - jsonschema == 2.5.1 04:29:53 INFO - manifestparser == 1.1 04:29:53 INFO - mozInstall == 1.12 04:29:53 INFO - mozcrash == 1.0 04:29:53 INFO - mozdebug == 0.1 04:29:53 INFO - mozdevice == 0.49 04:29:53 INFO - mozfile == 1.2 04:29:53 INFO - mozhttpd == 0.7 04:29:53 INFO - mozinfo == 0.9 04:29:53 INFO - mozleak == 0.1 04:29:53 INFO - mozlog == 3.4 04:29:53 INFO - moznetwork == 0.27 04:29:53 INFO - mozprocess == 0.25 04:29:53 INFO - mozprofile == 0.28 04:29:53 INFO - mozrunner == 6.13 04:29:53 INFO - mozscreenshot == 0.1 04:29:53 INFO - mozsystemmonitor == 0.3 04:29:53 INFO - moztest == 0.8 04:29:53 INFO - mozversion == 1.4 04:29:53 INFO - psutil == 3.1.1 04:29:53 INFO - requests == 1.2.3 04:29:53 INFO - wsgiref == 0.1.2 04:29:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:53 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 0x1ca81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f45b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f43290>, '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 0x1f43b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f44040>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995', '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 04:29:53 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 04:29:53 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 04:29:53 INFO - Using env: {'DISPLAY': ':0', 04:29:53 INFO - 'HOME': '/home/cltbld', 04:29:53 INFO - 'LANG': 'en_US.UTF-8', 04:29:53 INFO - 'LANGUAGE': 'en_US:en', 04:29:53 INFO - 'LOGNAME': 'cltbld', 04:29:53 INFO - 'MAIL': '/var/mail/cltbld', 04:29:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:53 INFO - 'MOZ_NO_REMOTE': '1', 04:29:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:53 INFO - 'NO_EM_RESTART': '1', 04:29:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:53 INFO - 'PWD': '/builds/slave/test', 04:29:53 INFO - 'SHELL': '/bin/bash', 04:29:53 INFO - 'SHLVL': '1', 04:29:53 INFO - 'TERM': 'linux', 04:29:53 INFO - 'TMOUT': '86400', 04:29:53 INFO - 'USER': 'cltbld', 04:29:53 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995', 04:29:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:53 INFO - '_': '/tools/buildbot/bin/python'} 04:29:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:53 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)) 04:29:53 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)) 04:29:53 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)) 04:29:53 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)) 04:29:53 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)) 04:29:53 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)) 04:29:53 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)) 04:29:53 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)) 04:29:53 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)) 04:29:53 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)) 04:29:53 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)) 04:29:53 INFO - Cleaning up... 04:29:53 INFO - Return code: 0 04:29:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f45b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f43290>, '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 0x1f43b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f44040>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995', '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 04:29:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:29:53 INFO - Using env: {'DISPLAY': ':0', 04:29:53 INFO - 'HOME': '/home/cltbld', 04:29:53 INFO - 'LANG': 'en_US.UTF-8', 04:29:53 INFO - 'LANGUAGE': 'en_US:en', 04:29:53 INFO - 'LOGNAME': 'cltbld', 04:29:53 INFO - 'MAIL': '/var/mail/cltbld', 04:29:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:53 INFO - 'MOZ_NO_REMOTE': '1', 04:29:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:53 INFO - 'NO_EM_RESTART': '1', 04:29:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:53 INFO - 'PWD': '/builds/slave/test', 04:29:53 INFO - 'SHELL': '/bin/bash', 04:29:53 INFO - 'SHLVL': '1', 04:29:53 INFO - 'TERM': 'linux', 04:29:53 INFO - 'TMOUT': '86400', 04:29:53 INFO - 'USER': 'cltbld', 04:29:53 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995', 04:29:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:53 INFO - '_': '/tools/buildbot/bin/python'} 04:29:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:29:53 INFO - Cleaning up... 04:29:53 INFO - Return code: 0 04:29:53 INFO - Running post-action listener: _resource_record_post_action 04:29:53 INFO - Running post-action listener: _start_resource_monitoring 04:29:53 INFO - Starting resource monitoring. 04:29:53 INFO - [mozharness: 2017-03-31 11:29:53.495764Z] Finished create-virtualenv step (success) 04:29:53 INFO - [mozharness: 2017-03-31 11:29:53.496225Z] Running install step. 04:29:53 INFO - Running pre-action listener: _resource_record_pre_action 04:29:53 INFO - Running main action method: install 04:29:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:29:53 INFO - Reading from file tmpfile_stdout 04:29:53 INFO - Detecting whether we're running mozinstall >=1.0... 04:29:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:29:53 INFO - Reading from file tmpfile_stdout 04:29:53 INFO - Output received: 04:29:53 INFO - Usage: mozinstall [options] installer 04:29:53 INFO - Options: 04:29:53 INFO - -h, --help show this help message and exit 04:29:53 INFO - -d DEST, --destination=DEST 04:29:53 INFO - Directory to install application into. [default: 04:29:53 INFO - "/builds/slave/test"] 04:29:53 INFO - --app=APP Application being installed. [default: firefox] 04:29:53 INFO - mkdir: /builds/slave/test/build/application 04:29:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:30:09 INFO - Reading from file tmpfile_stdout 04:30:09 INFO - Output received: 04:30:09 INFO - /builds/slave/test/build/application/firefox/firefox 04:30:09 INFO - Running post-action listener: _resource_record_post_action 04:30:09 INFO - [mozharness: 2017-03-31 11:30:09.451097Z] Finished install step (success) 04:30:09 INFO - [mozharness: 2017-03-31 11:30:09.451371Z] Running run-tests step. 04:30:09 INFO - Running pre-action listener: _resource_record_pre_action 04:30:09 INFO - Running main action method: run_tests 04:30:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:30:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:30:09 INFO - Python 2.7.3 04:30:09 INFO - Return code: 0 04:30:09 INFO - grabbing minidump binary from tooltool 04:30: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')]} 04:30:09 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 0x1f43290>, '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 0x1f43b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f44040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:30:09 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 04:30:09 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 04:30:09 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 04:30:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:30:09 INFO - Return code: 0 04:30:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:30:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:30:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:30:09 INFO - ENV: RUST_BACKTRACE is now 1 04:30:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:30:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:30:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 04:30:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 04:30:09 INFO - Using env: {'DISPLAY': ':0', 04:30:09 INFO - 'HOME': '/home/cltbld', 04:30:09 INFO - 'LANG': 'en_US.UTF-8', 04:30:09 INFO - 'LANGUAGE': 'en_US:en', 04:30:09 INFO - 'LOGNAME': 'cltbld', 04:30:09 INFO - 'MAIL': '/var/mail/cltbld', 04:30:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:30:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:09 INFO - 'MOZ_NO_REMOTE': '1', 04:30:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:09 INFO - 'NO_EM_RESTART': '1', 04:30:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:09 INFO - 'PWD': '/builds/slave/test', 04:30:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:30:09 INFO - 'RUST_BACKTRACE': '1', 04:30:09 INFO - 'SHELL': '/bin/bash', 04:30:09 INFO - 'SHLVL': '1', 04:30:09 INFO - 'TERM': 'linux', 04:30:09 INFO - 'TMOUT': '86400', 04:30:09 INFO - 'USER': 'cltbld', 04:30:09 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995', 04:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:09 INFO - '_': '/tools/buildbot/bin/python'} 04:30:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 04:30:09 INFO - mozversion application_buildid: 20170330114804 04:30:09 INFO - mozversion application_changeset: 03d602fd723ad6ff4588c04855884ffa1dee9410 04:30:09 INFO - mozversion application_display_name: Nightly 04:30:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:30:09 INFO - mozversion application_name: Firefox 04:30:09 INFO - mozversion application_remotingname: firefox 04:30:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:30:09 INFO - mozversion application_vendor: Mozilla 04:30:09 INFO - mozversion application_version: 55.0a1 04:30:09 INFO - mozversion platform_buildid: 20170330114804 04:30:09 INFO - mozversion platform_changeset: 03d602fd723ad6ff4588c04855884ffa1dee9410 04:30:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:30:09 INFO - mozversion platform_version: 55.0a1 04:30:09 INFO - using testdate: 1490959809 04:30:09 INFO - actual date: 1490959809 04:30:09 INFO - starting webserver on 'localhost:56359' 04:30:09 INFO - SUITE-START | Running 2 tests 04:30:09 INFO - TEST-START | dromaeo_css 04:30:09 INFO - operating with platform_type : linux_ 04:30:09 INFO - Initialising browser for dromaeo_css test... 04:30:09 INFO - TEST-INFO | started process 14152 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJNdczq/profile http://localhost:56359/getInfo.html) 04:30:14 INFO - PID 14152 | __metrics Screen width/height:1600/1200 04:30:14 INFO - PID 14152 | colorDepth:24 04:30:14 INFO - PID 14152 | Browser inner width/height: 1024/697 04:30:14 INFO - PID 14152 | __metrics 04:30:15 ERROR - PID 14152 | 1490959815002 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6382:36 < canClose@browser.js:5233:12 < forceQuit@jar:file:///tmp/tmpJNdczq/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmpJNdczq/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmpJNdczq/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmpJNdczq/profile/extensions/talos-powers@TalosPowersService.js:55:9 04:30:15 ERROR - PID 14152 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 04:30:16 INFO - TEST-INFO | 14152: exit 0 04:30:16 INFO - Browser initialized. 04:30:16 INFO - Running cycle 1/1 for dromaeo_css test... 04:30:16 INFO - TEST-INFO | started process 14283 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJNdczq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:30:28 INFO - PID 14283 | RSS: Main: 155697152 04:30:28 INFO - PID 14283 | 04:33:32 INFO - PID 14283 | Cycle 1(1): loaded http://localhost:56359/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56359/tests/dromaeo/cssquery-ext.html) 04:33:34 INFO - PID 14283 | RSS: Main: 165679104 04:33:34 INFO - PID 14283 | 04:35:16 INFO - PID 14283 | ************************* 04:35:16 INFO - PID 14283 | A coding exception was thrown and uncaught in a Task. 04:35:16 INFO - PID 14283 | 04:35:16 ERROR - PID 14283 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:35:16 INFO - PID 14283 | Full stack: 04:35:16 INFO - PID 14283 | ************************* 04:35:16 INFO - PID 14283 | ************************* 04:35:16 INFO - PID 14283 | A coding exception was thrown and uncaught in a Task. 04:35:16 INFO - PID 14283 | 04:35:16 ERROR - PID 14283 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:35:16 INFO - PID 14283 | Full stack: 04:35:16 INFO - PID 14283 | ************************* 04:35:16 INFO - PID 14283 | ************************* 04:35:16 INFO - PID 14283 | A coding exception was thrown and uncaught in a Task. 04:35:16 INFO - PID 14283 | 04:35:16 ERROR - PID 14283 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:35:16 INFO - PID 14283 | Full stack: 04:35:16 INFO - PID 14283 | ************************* 04:35:16 INFO - PID 14283 | ************************* 04:35:16 INFO - PID 14283 | A coding exception was thrown and uncaught in a Task. 04:35:16 INFO - PID 14283 | 04:35:16 ERROR - PID 14283 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:35:16 INFO - PID 14283 | Full stack: 04:35:16 INFO - PID 14283 | ************************* 04:36:37 INFO - PID 14283 | Cycle 1(1): loaded http://localhost:56359/tests/dromaeo/cssquery-ext.html (next: http://localhost:56359/tests/dromaeo/cssquery-jquery.html) 04:36:37 INFO - PID 14283 | RSS: Main: 161775616 04:36:37 INFO - PID 14283 | 04:39:39 INFO - PID 14283 | Cycle 1(1): loaded http://localhost:56359/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56359/tests/dromaeo/cssquery-mootools.html) 04:39:40 INFO - PID 14283 | RSS: Main: 169750528 04:39:40 INFO - PID 14283 | 04:42:42 INFO - PID 14283 | Cycle 1(1): loaded http://localhost:56359/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56359/tests/dromaeo/cssquery-prototype.html) 04:42:42 INFO - PID 14283 | RSS: Main: 162553856 04:42:42 INFO - PID 14283 | 04:45:45 INFO - PID 14283 | Cycle 1(1): loaded http://localhost:56359/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56359/tests/dromaeo/cssquery-yui.html) 04:45:46 INFO - PID 14283 | RSS: Main: 168845312 04:45:46 INFO - PID 14283 | 04:48:49 INFO - PID 14283 | Cycle 1(1): loaded http://localhost:56359/tests/dromaeo/cssquery-yui.html (next: http://localhost:56359/tests/dromaeo/cssquery-dojo.html) 04:48:49 INFO - PID 14283 | RSS: Main: 162291712 04:48:49 INFO - PID 14283 | 04:48:49 INFO - PID 14283 | __start_tp_report 04:48:49 INFO - PID 14283 | _x_x_mozilla_page_load 04:48:49 INFO - PID 14283 | _x_x_mozilla_page_load_details 04:48:49 INFO - PID 14283 | |i|pagename|runs| 04:48:49 INFO - PID 14283 | |0;dojo.html;2628.947421051579;2705.891764329427;2714.837109773414;2736.890524379025;2744.821586596871;5099.949000509994;5134.871628209292;5179.922301165476;5211.482623402281;5265.394479634843;5151.175811870102;5159.871003224921;5164.9741751291285;5226.738663066841;5258.13240815265;4741.217699079656;4798.4001999750035;4798.736069516175;4807.687500312486;4812.951870481285;4793.4487533933525;4811.398575178103;4839.032193561285;4840.903181936359;4898.093852637274;4696.201645720235;4716.38686970695;4743.501932297094;4759.4764575896625;4763.14263432582;4761.333413322138;4763.49983251757;4793.664443488957;4823.734694591796;4841.7337046462435;4653.930191047137;4732.219183834663;4736.928946065812;4765.642576806753;4781.258904869751;5047.924281135786;5119.667221630582;5158.535731784157;5215.24378965048;5271.077561426735;5515.641483303572;5528.198411230389;5536.390996990328;5573.777048918038;5601.215829783833;5616.887662246773;5640.435956404368;5651.350094739117;5651.660900345993;5671.801486947937;5093.439721630618;5210.609204309654;5233.188855727369;5244.265802787613;5289.947100528945;5657.4059723728415;5690.6870122142855;5748.281464816898;5748.396418376094;5779.884402312015;5372.946270537244;5443.34679838414;5443.755031023614;5451.345838499326;5458.754356053987;5465.344158700981;5505.532029777513;5534;5550.028744969695;5553.111502159635;5485.067538518461;5495.010898038311;5498.202760599691;5502.944970550323;5510.228568000483;5484.643498172606;5490.039243132515;5490.725463726878;5491.148871924858;5506.889862202734;4686.039361930864;4699.060187962421;4699.342092107107;4703.035877645143;4708.505606911293;4080.1685871856016;4090.1615168890307;4097.467329247238;4099;4132.40080188371;4692.718436893797;4776.689515181502;4812.614990800727;4815.9886423851385;4827.879303017382;5528.861778455571;5575.69333686643;5620.016497112989;5638.802641907513;5653.406392328829;4831.299461578122;4838.927416088762;4839.274108883696;4856.490068542823;4880.682755620874;5017.648764586517;5025.195968644999;5032.974835125874;5034.119029169808;5034.521720436553;5085.669431486942;5165.199394093921;5224.50367215114;5294.708791016531;5300.9734951325;5658.434156584309;5669.801556945487;5674.4892959633835;5674.858128546819;5721.22763426932;5223.973880130575;5253.737313134252;5265.578753699619;5273.31446911899;5328;5411.2153737708595;5467.58993075513;5473.917891231555;5526.088195447706;5535.308086489189;5612.298462692163;5616.606837521498;5636.971815140898;5652.886942261214;5682.77268909239;5408.161734931092;5437.048516509516;5446.782128714807;5450.1007333789485;5450.264214331173;5281.287026251561;5336.73316334174;5395.325584301962;5433.022056029952;5479.589030822624;5227.372715274191;5360.892782144413;5391.892162156656;5402.486763757437;5434.619576629756;5483.972580137074;5490.231367608618;5496.7526461308535;5523.143912693539;5535.059039963136;5170.844874653766;5245.239440281061;5329.57363410934;5399.379071406838;5403.081476149143 04:48:49 INFO - PID 14283 | |1;ext.html;665.3712241931373;686.7356067913855;1077.0521940692195;1086.7500474890776;1196.78457877582;34317;35796.46305305423;35802.10494737633;35921.640783592185;35946.640533594655;32816.67183328166;33298;33300.833495832485;33335.49996750051;33399.4990075149;6945.479089068327;7104.7513337033215;7255.201927787965;7441.441891858105;7442.144153422345;7503.549787012769;7597.392208623324;7597.620118994056;7604.429667774912;7605.543667379948;7606.04924384452;7659.6936122555035;7686.807829804244;7689.269519395676;7689.346405555534;7522.172561018284;7618.504797188193;7641.541507509512;7643.0828300603725;7644.6942122315595;7232.855342893113;7295.52579082358;7297.708091676326;7302.598357090358;7326.3040011198855;34196.82901585501;34371.312573748386;34383.14042148966;34511.16843641867;34654.653453465646;2423.297243799296;2475.220305603747;2494.3140636324974;2498.8625625590585;2541.4789968056502;23505.41236469085;23512.294631160923;23604.64593031106;24218.39454013646;24421.267361979168;2618.56793629051;2692.5998480790076;2715.2261605442354;2718.687350954646;2720.224735950245;173052;174261.99999999872;174507;175305;175575;42192.578074218865;42429;42499;42503;45471;47034.76482617565;47258.52741472541;47296.290555641695;47339.763301183964;47755;13204.60386188416;13208.207507549385;13326.267055311857;13327.133736307109;13348.6662833428;10582.100521455608;10637.9468102659;10638.840417393745;10640.521176547074;10774.461276936121;13373.331333433483;13512.256825874474;13524.391402386917;13586.864131358758;13665.18008919468;5411.377691565521;5491.588130890199;5532.474414930575;5647.435256474319;5663.150527420919;847.5931552854664;885.3271513649672;897.0715309654606;898.510311880027;914.8078903430354;19247.15662495229;20224.494387640425;20367.59264814725;20426.69359959602;20679.483012924495;971.3249291742312;975.4001289207087;988.5996171550534;990.782027953849;1014.325473560089;10636.202284828669;10886.727831804268;10988.066014388867;11008.449577521093;11015.449227538591;249863;250407;251628;253119;253489;43281.35077973833;43537.78231108824;43613;43651.34522982158;43687.78156109199;1210.6368089573093;1251.8622951475331;1260.7289432772181;1262.072376803049;1265.7658333208385;19107.140178691716;19297.710534341717;19956;20082.09630566599;20174.193032278545;31718;31786.841065794524;31972.84013579917;32014;32057.519137212494;222738;223684;224119;224233;224821;30164.062265678578;32280.515792262664;32649;32723;32895;37489.437658435694;37789.4331585032;38572;38999.41500877546;41299;30316.24209394783;30646.233844154074;30985.845070774503;31110.844445777628;31413.80103392832;30691.232719181306;30713.692863071083;30734.69265307408;31090.22274443157;31904.521432179;33572.66427335695;34183.145421364665;34553.30893382068;34638.480422794186;34787;30439;30539.2365190872;30638.84680576583;31103.2317489869;31229.68770312268;21608.783912160678;22496.887515562317;22500.549989000454;22501.774982250623;22633.321000370015 04:48:49 INFO - PID 14283 | |2;jquery.html;380.63839352615025;389.7077192105921;421.73430738634664;426.3902619254467;432.27809558038075;13698.794518082237;17821.28714851406;18500.722489162657;18623.534411639732;19067.14197861096;16062.196890155505;16394.09832459214;16484.752728709078;16799.24403401847;17013.404530841424;5520;5623.240862483573;5726.914096288559;5766.769329226826;5808.56435767317;5564.916526252109;5573.442655734435;5685.37460879305;5689.431056894319;5698.287714035746;5767.279090113736;5783.103618939072;5786.392428794979;5787.276590426197;5799.304083509985;5709.486146246816;5741.368449470576;5759.654420734749;5763.221965034709;5779.162021506879;5189.532942035235;5222.060029194743;5222.843314700565;5225.764840582183;5226.189940559219;21932;22382.440438988993;22386.440338991655;22635.66046509304;22779.08883644652;1499.737545929469;1511.4785399037314;1529.350026238844;1568.6470544127594;1570.46604154588;13927.303634818218;14027.579172624837;14097.85902140986;14322.212278324689;15061.698766024618;1748.7901451825735;1772.884762490434;1781.901995390253;1782.189103957696;1794.1836464408664;87173;91961.54019229928;92221;93023;94648.52675736646;10887.83668244977;10920.672379828618;11070.335779853074;11118.722031949266;11452.312861228353;15002.549923502313;15410.6147346315;15456.690866182613;15502.9224853875;15524.844751552566;7349.30181632744;7462.888056679154;7576.734814281584;7604.163542010375;7625.161232264447;6749.0551322814845;6877.828054298582;7023.92976070243;7053.083099197174;7069.646517674096;6920.854535094137;7041.823954401181;7054.894176587355;7081.716731330792;7267;2060.1450398084926;2085.3326935380533;2091.8431117666237;2145.3885642591786;2288.4622113803243;828.2545708862073;862.3747782857504;870.7083127152475;877.5831480046927;885.8208806336356;15992.92003539975;16377.590560236089;16585.91707041457;16780;16846.410375636795;883.3860466975519;883.4787475389551;884.4648987362682;886.7472770260574;887.4586502233632;8709.825803483895;9123.908760912438;9186.081391860895;9268.490233037113;9334.953325233331;443781;444385;448712;450115;452808;90049;91776;92427;93505.53247233856;95630;999.7550600103021;1042;1064.0264158295074;1065.4086981725218;1078.8489611454402;14533.27333633293;17054;18894.3386981455;18951.90524047426;19016.429507114808;42146.57853421549;43927.560724392344;44111;45548.31677524906;45909;52691.73654131705;53309;53983.460165397846;54418;56186;8169;8227.753167404988;8240.876386854321;8485.266482747571;8573.142685731376;13422.865771342162;13469.259190744604;13474.19154850712;13644.590662280147;14226.430942762174;10447.791044179226;10479;10970.451477426257;11129.721756956142;11546.19176657626;10220.846687299547;10512;10516.68449946503;10840.132789376989;10904.182186335898;10478.214133940137;10913.39976301311;11034;11343.602973895873;11376.919192676682;8317.701057673023;8387.329013679013;8416.915830841857;8541.914580854113;8670.653173872974;10378.169746420419;10529.684109476728;11070.446477676245;11080.445977700922;11651.941740291244 04:48:49 INFO - PID 14283 | |3;mootools.html;1247.9812802807958;1314.2837153751204;1320.5774152271276;1328.2561765411365;1330.8802207801295;8980.640774369025;9270.953645231773;9282.721518354452;9664.565094570744;9921.950390248057;9627.903720962788;9809.068138526847;9816.852747208797;9819.459929703864;9820.11618954294;2214.9667754983648;2254.5152792149684;2255.2557655973487;2255.5376147889724;2256.8533045352083;2101.2015434135083;2180.509385388291;2212.2699509162017;2225.9666105008437;2229.1640634761966;2154.676798480225;2197.2968650031994;2254.695616091823;2261.1407665087245;2273.2498275569105;2156.493224092337;2200.7689192634703;2203.4821816873023;2210.071769856656;2218.6339254023146;1829.2225804033367;1898.4968983219458;2093.2778191524053;2160.34109596573;2179.9564008719735;9532.666356677482;9640;9656.613735450574;9681.70954871355;9687;5302.310699609065;5571.832845014656;5578.721063946827;5582.413846546095;5605.299337582802;3252.9674703253136;3365.444701624229;3384.2047118927035;3415.112070861594;3424.6575342465803;1009.6516701737888;1024.293237666008;1037.2428127466917;1048.783411242962;1063.9627613033506;13231.404586793617;13267.867321326856;13279.5432844924;13335.133216341004;13360.398782054734;4725.713585691535;4756.191447453941;4789.114013907439;4902.41171059468;4918.532739389752;10385.63650272252;10468.110210632029;10490.475476226158;10529.157667386591;10535.789284214427;5366.704831234241;5432.619716619799;5437.755301011464;5448.155535891943;5448.673079615236;4841.975790121097;4850.417949846041;4972.453030166679;5015.14742493777;5079.974600126976;3758.9248215035545;3824.158685089276;3910.354791459434;3962.9603703962593;4017.6183262590007;1167.3696204049718;1170.9238899471507;1172.3141961952354;1179.6578992092368;1186.6262127430005;673.5689158938284;689.0491122251361;690.908007981172;693.9340762627543;709.3970125393374;5055.4328158271055;5069.518395752398;5159.458256883048;5211.530962213419;5227;524.9737513124328;549.3106151779491;554.9056660367747;559.3986464550543;563.7942151114895;3405.4721518164724;3545.982270088633;3607.9098022549647;3639.4358874374516;3704.5554533456157;12013.819792703116;12714.173578717353;12714.300713460849;12729.936350318188;12746.044046696536;12164.14850960442;12277.263364198177;12479.625611231677;12660.17708848922;12681.048921330937;9039.45763254207;9094.36339456245;9120.49837258957;9215.63137474507;9219.631214751469;5371.382291036581;5445.101558242845;5449.1826226066405;5474.42518535564;5576.776928922797;10946.17903657213;11035.613753518588;11079.61221357281;11158.442077896236;11168.441577920908;11290.266132701348;11390.715232118931;11638;11664.066874650178;11775.411229438665;7525.510841795266;7541.283578060075;7566.886496702664;7596.202398748052;7618.8095297618;8940.508272044839;9047.411918225294;9115;9122.635094596142;9127.726168214964;7335.1197856257595;7505.662245199088;7519.511231769918;7566.432517561315;7712.768616941501;7084.893726594209;7137.571745695275;7186.1376634804155;7346.045014148127;7439.442041846992;6267.874642507033;6301.6219026858535;6352.269489008823;6357.268914074941;6361.395667411589;4797.18447863857;4889.364382630235;4919.827806026772;4950.430700469492;4966.453690094159;4905;4932.334134891744;4955.380577427822;5094.414142373675;5095.923561146512 04:48:49 INFO - PID 14283 | |4;prototype.html;353.8407716527562;368.3186105704449;378.8389934277933;395.636014866323;400.2335527464904;5567.220589117522;5574.832755017356;5670.68811215383;5671.914921276184;5685.260916080914;5497.257870187524;5545.722713864311;5548.085910360929;5551.3893471718075;5564.4991950724425;4160.356659119646;4239.618434340909;4276.123394704094;4407.647388208944;4427.070315233805;4262.552431994643;4264.808083636244;4272.658187345005;4278.593533614302;4281.929517620595;4243.130158317553;4244.214820258262;4254.383114448418;4274.700770946035;4278.229918614648;4090.284200264942;4227.619514243733;4271.209826182151;4271.78641067947;4277.144571085764;3659.1035196376793;3704.9629503704887;3714.312852122366;3714.832832522516;3727.589965103836;5357.196420536911;5360.946390536123;5384.3538775346815;5386.165144402624;5389.272448219479;4652.395188625457;4878.902421951577;4904.313396124546;4910.140725373046;4920.188168952119;5752.309722833245;5763.827085187451;5771.682557459338;5786.537077033827;5798.246227990377;4035.535913369971;4058.79706014701;4070.715049946505;4074.4092106644666;4079.3473044313064;5953.702314884238;6097.542684298695;6144.600600960968;6181.9690901545655;6190.7403797614;4161.83352665896;4180.47744031996;4183.330667093251;4193.077522944947;4202.600752928467;4209.957900421018;4215.178040282116;4246.49042114942;4249.150169966019;4262.850800221977;4761.928571071437;4862.610991120772;4875.9512404875495;4876.439209490883;4876.780544875489;5837.562182836305;5843.824685259449;5855.707214639251;5874.73563689635;5876.529877609781;1442.2428225181864;1449.6738233897288;1451.4049239811627;1453.7310597539279;1454.7672372420361;941.4445477168504;990.6334656177116;991.7818080022383;998.8801343838786;1009.4296722351847;5097.731509478246;5109.4379618241965;5112.667676601009;5113.642045056885;5114.28400023997;6018.849528761816;6048.758049677964;6059.969700151471;6081.695915204222;6085.196752029981;4848.327327072155;5016.749162541858;5042.596592272609;5068.341115654941;5086.237064440364;3219.9839000804845;3228.741700663941;3238.789478683878;3238.8218647974586;3251.2847173621767;5518.558515318765;5636.746346414421;5637.520810731134;5654.575906807006;5672.7730890763905;6067.423594758579;6184.257889053252;6187.752489900444;6212.409821066992;6219.751209951642;5604.467575580314;5615.3823079462045;5624.634398764068;5625.409332020243;5626.859328516738;5767.2502574666705;6052.606580572248;6057.636541807506;6063.423974722395;6077.453029227391;5960.433758792908;5970.641761494324;5974.850628734316;5978.342382338026;5996.400359963969;5469.781208751764;5633.8309850704545;5641.464060914206;5675.432456754292;5693.430656934273;4098.118904435561;4102.5692302307825;4109.486314210723;4113.321301985139;4119.485064366954;6026.184731733898;6126.724297406717;6145.324014358506;6148.985417406078;6153.84615384619;5903.321118071477;5908.9228432381515;5917.6745279010065;5920.2933667735115;5928.199693041557;5888.234529511136;5892.882142357214;5896.528277737856;5900;5920.407959204217;5648;5763.924987004759;5797.449242321973;5823.602335439548;5845.736941837713;5909.640782619936;5921.348651648402;5925.103966730605;5947.613405128653;5959.539912721411;5626.58067465315;5757.165211044291;5763.711814409179;5782.508486778671;5801.738921748616 04:48:49 INFO - PID 14283 | |5;yui.html;601.4556826072406;603.1977469964949;612.2775125352084;618.190170876152;636.3763511758476;13524.594262172139;13783.310834458262;14254.358553865075;14268.215248161347;14551.854481455182;13451.192928424301;13540.999999999975;13660.726785464285;13670.794938075913;13675.863241367584;654.8821212181817;775.6393277126135;920.2499962530517;943.9669611563596;944.6929747831948;950.7432993091861;952.4999375327939;955.3742298794301;955.6894009446958;957.0238356875982;982.4449186209804;984.271638987148;984.758734110144;985.4136788610765;986.3490096536287;965.4593427680486;968.1915600473578;968.7142293023539;968.8159249742527;968.9321747477679;711.3064761857199;712.0423031023265;716.4053835316727;716.9390601798854;719.543090137761;13097.083204175711;13148.86851131486;13159.342032898317;13196;13272.270025148613;13104.475820967149;13248.006399519978;13283.535076272285;13416.127951683207;13430.127041742255;9281.58232879522;10783.137349012139;11072.667819965414;11276.94361528187;11332.955302872046;3861.5054317914714;3889.0666240102455;3899.181171953893;3905.1994341159993;3946.2241991103833;61007.694961525354;61537.231384307845;62961.68519157421;63629.68185159091;64351.356486435005;9114.772130696785;9286;9379.249660027317;9389.906100938902;9596.23230141587;20676.793232067488;20708.689369659467;20742.377728668165;20767.68848467274;20802.47993800167;5813.680247586423;5832.62087964281;5911.083782013795;5941.881162376728;6007.879842403127;3022.3804120155314;3054.3127796246113;3111.284404586958;3170.793898396597;3179.7933134346194;3590.784552926833;3662.5421822272215;3692.1138926657945;3700.870469533553;3714;577.2985822225932;578.9015867302569;591.8549955260903;594.1207013619867;594.378874076591;455.81311662218997;461.85451582751324;462.2926921809637;477.84231203702694;478.258699016523;7219.963900180465;7397.334239918433;7559.842086852209;7561.3194812466045;7806.570638614817;461.2228395154176;464.48906203176233;467.2967184387475;468.48232702863527;478.5836322399535;3445.966210136999;3481.808500532444;3516.3494753470177;3569.839357228879;3617.0234036809916;63420;63763.6811815938;63916.68041659855;64861.675691622186;64879;53790.46209537933;53794;54110;56226;56506.7174664124;49223.75388123036;49483.02067917315;49583.256251156265;49963.75018124886;51244.74377628088;6863.210730766026;7011.298870112948;7091.290870912868;7217.170025446931;7240.312170343809;26010;26112.608310874974;26456.867715661298;26924.192274231806;27229.591556126277;31388.372232555677;31881;32025.839870800497;32779.344413111125;33183.834080830406;8366.498010119412;8433.915660843559;8453.66185352579;8481.933481683973;8481.957590212009;8646.740597782076;8828.690995815115;8863.955680221816;8882.189354705655;8941.46351218929;8425.519621857651;8433.536155511505;8465.61904714277;8561.743147705578;8616.052234254352;8163.993576653856;8225.588720564068;8307.335413167053;8354.5405002723;8430.578471076544;8260.173982601691;8286.958565207135;8322.45904016237;8407.411481196257;8494.660213591635;6962.477814163856;8700.292769540038;8765.912340876765;8795.824083518422;9077.863832042656;9517.52412379392;9933.705356027798;9934.254930880068;10008.398656214971;10150.746231344276 04:48:49 INFO - PID 14283 | __end_tp_report 04:48:49 INFO - PID 14283 | __start_cc_report 04:48:49 INFO - PID 14283 | _x_x_mozilla_cycle_collect,385 04:48:49 INFO - PID 14283 | __end_cc_report 04:48:49 INFO - PID 14283 | __startTimestamp1490960929500__endTimestamp 04:48:49 INFO - PID 14283 | 04:48:49 INFO - PID 14283 | ------- Summary: start ------- 04:48:49 INFO - PID 14283 | Number of tests: 6 04:48:49 INFO - PID 14283 | 04:48:49 INFO - PID 14283 | [#0] dojo.html Cycles:165 Average:5138.54 Median:5271.08 stddev:570.21 (10.8%) stddev-sans-first:536.90 04:48:49 INFO - PID 14283 | Values: 2628.9 2705.9 2714.8 2736.9 2744.8 5099.9 5134.9 5179.9 5211.5 5265.4 5151.2 5159.9 5165.0 5226.7 5258.1 4741.2 4798.4 4798.7 4807.7 4813.0 4793.4 4811.4 4839.0 4840.9 4898.1 4696.2 4716.4 4743.5 4759.5 4763.1 4761.3 4763.5 4793.7 4823.7 4841.7 4653.9 4732.2 4736.9 4765.6 4781.3 5047.9 5119.7 5158.5 5215.2 5271.1 5515.6 5528.2 5536.4 5573.8 5601.2 5616.9 5640.4 5651.4 5651.7 5671.8 5093.4 5210.6 5233.2 5244.3 5289.9 5657.4 5690.7 5748.3 5748.4 5779.9 5372.9 5443.3 5443.8 5451.3 5458.8 5465.3 5505.5 5534.0 5550.0 5553.1 5485.1 5495.0 5498.2 5502.9 5510.2 5484.6 5490.0 5490.7 5491.1 5506.9 4686.0 4699.1 4699.3 4703.0 4708.5 4080.2 4090.2 4097.5 4099.0 4132.4 4692.7 4776.7 4812.6 4816.0 4827.9 5528.9 5575.7 5620.0 5638.8 5653.4 4831.3 4838.9 4839.3 4856.5 4880.7 5017.6 5025.2 5033.0 5034.1 5034.5 5085.7 5165.2 5224.5 5294.7 5301.0 5658.4 5669.8 5674.5 5674.9 5721.2 5224.0 5253.7 5265.6 5273.3 5328.0 5411.2 5467.6 5473.9 5526.1 5535.3 5612.3 5616.6 5637.0 5652.9 5682.8 5408.2 5437.0 5446.8 5450.1 5450.3 5281.3 5336.7 5395.3 5433.0 5479.6 5227.4 5360.9 5391.9 5402.5 5434.6 5484.0 5490.2 5496.8 5523.1 5535.1 5170.8 5245.2 5329.6 5399.4 5403.1 04:48:49 INFO - PID 14283 | 04:48:49 INFO - PID 14283 | [#1] ext.html Cycles:180 Average:36219.46 Median:31845.68 stddev:57087.55 (179.3%) stddev-sans-first:57185.28 04:48:49 INFO - PID 14283 | Values: 665.4 686.7 1077.1 1086.8 1196.8 34317.0 35796.5 35802.1 35921.6 35946.6 32816.7 33298.0 33300.8 33335.5 33399.5 6945.5 7104.8 7255.2 7441.4 7442.1 7503.5 7597.4 7597.6 7604.4 7605.5 7606.0 7659.7 7686.8 7689.3 7689.3 7522.2 7618.5 7641.5 7643.1 7644.7 7232.9 7295.5 7297.7 7302.6 7326.3 34196.8 34371.3 34383.1 34511.2 34654.7 2423.3 2475.2 2494.3 2498.9 2541.5 23505.4 23512.3 23604.6 24218.4 24421.3 2618.6 2692.6 2715.2 2718.7 2720.2 173052.0 174262.0 174507.0 175305.0 175575.0 42192.6 42429.0 42499.0 42503.0 45471.0 47034.8 47258.5 47296.3 47339.8 47755.0 13204.6 13208.2 13326.3 13327.1 13348.7 10582.1 10637.9 10638.8 10640.5 10774.5 13373.3 13512.3 13524.4 13586.9 13665.2 5411.4 5491.6 5532.5 5647.4 5663.2 847.6 885.3 897.1 898.5 914.8 19247.2 20224.5 20367.6 20426.7 20679.5 971.3 975.4 988.6 990.8 1014.3 10636.2 10886.7 10988.1 11008.4 11015.4 249863.0 250407.0 251628.0 253119.0 253489.0 43281.4 43537.8 43613.0 43651.3 43687.8 1210.6 1251.9 1260.7 1262.1 1265.8 19107.1 19297.7 19956.0 20082.1 20174.2 31718.0 31786.8 31972.8 32014.0 32057.5 222738.0 223684.0 224119.0 224233.0 224821.0 30164.1 32280.5 32649.0 32723.0 32895.0 37489.4 37789.4 38572.0 38999.4 41299.0 30316.2 30646.2 30985.8 31110.8 31413.8 30691.2 30713.7 30734.7 31090.2 31904.5 33572.7 34183.1 34553.3 34638.5 34787.0 30439.0 30539.2 30638.8 31103.2 31229.7 21608.8 22496.9 22500.5 22501.8 22633.3 04:48:49 INFO - PID 14283 | 04:48:49 INFO - PID 14283 | [#2] jquery.html Cycles:180 Average:27881.21 Median:44019.28 stddev:74382.10 (169.0%) stddev-sans-first:74562.10 04:48:49 INFO - PID 14283 | Values: 380.6 389.7 421.7 426.4 432.3 13698.8 17821.3 18500.7 18623.5 19067.1 16062.2 16394.1 16484.8 16799.2 17013.4 5520.0 5623.2 5726.9 5766.8 5808.6 5564.9 5573.4 5685.4 5689.4 5698.3 5767.3 5783.1 5786.4 5787.3 5799.3 5709.5 5741.4 5759.7 5763.2 5779.2 5189.5 5222.1 5222.8 5225.8 5226.2 21932.0 22382.4 22386.4 22635.7 22779.1 1499.7 1511.5 1529.4 1568.6 1570.5 13927.3 14027.6 14097.9 14322.2 15061.7 1748.8 1772.9 1781.9 1782.2 1794.2 87173.0 91961.5 92221.0 93023.0 94648.5 10887.8 10920.7 11070.3 11118.7 11452.3 15002.5 15410.6 15456.7 15502.9 15524.8 7349.3 7462.9 7576.7 7604.2 7625.2 6749.1 6877.8 7023.9 7053.1 7069.6 6920.9 7041.8 7054.9 7081.7 7267.0 2060.1 2085.3 2091.8 2145.4 2288.5 828.3 862.4 870.7 877.6 885.8 15992.9 16377.6 16585.9 16780.0 16846.4 883.4 883.5 884.5 886.7 887.5 8709.8 9123.9 9186.1 9268.5 9335.0 443781.0 444385.0 448712.0 450115.0 452808.0 90049.0 91776.0 92427.0 93505.5 95630.0 999.8 1042.0 1064.0 1065.4 1078.8 14533.3 17054.0 18894.3 18951.9 19016.4 42146.6 43927.6 44111.0 45548.3 45909.0 52691.7 53309.0 53983.5 54418.0 56186.0 8169.0 8227.8 8240.9 8485.3 8573.1 13422.9 13469.3 13474.2 13644.6 14226.4 10447.8 10479.0 10970.5 11129.7 11546.2 10220.8 10512.0 10516.7 10840.1 10904.2 10478.2 10913.4 11034.0 11343.6 11376.9 8317.7 8387.3 8416.9 8541.9 8670.7 10378.2 10529.7 11070.4 11080.4 11651.9 04:48:49 INFO - PID 14283 | 04:48:49 INFO - PID 14283 | [#3] mootools.html Cycles:180 Average:5969.28 Median:4869.89 stddev:3754.15 (77.1%) stddev-sans-first:3747.92 04:48:49 INFO - PID 14283 | Values: 1248.0 1314.3 1320.6 1328.3 1330.9 8980.6 9271.0 9282.7 9664.6 9922.0 9627.9 9809.1 9816.9 9819.5 9820.1 2215.0 2254.5 2255.3 2255.5 2256.9 2101.2 2180.5 2212.3 2226.0 2229.2 2154.7 2197.3 2254.7 2261.1 2273.2 2156.5 2200.8 2203.5 2210.1 2218.6 1829.2 1898.5 2093.3 2160.3 2180.0 9532.7 9640.0 9656.6 9681.7 9687.0 5302.3 5571.8 5578.7 5582.4 5605.3 3253.0 3365.4 3384.2 3415.1 3424.7 1009.7 1024.3 1037.2 1048.8 1064.0 13231.4 13267.9 13279.5 13335.1 13360.4 4725.7 4756.2 4789.1 4902.4 4918.5 10385.6 10468.1 10490.5 10529.2 10535.8 5366.7 5432.6 5437.8 5448.2 5448.7 4842.0 4850.4 4972.5 5015.1 5080.0 3758.9 3824.2 3910.4 3963.0 4017.6 1167.4 1170.9 1172.3 1179.7 1186.6 673.6 689.0 690.9 693.9 709.4 5055.4 5069.5 5159.5 5211.5 5227.0 525.0 549.3 554.9 559.4 563.8 3405.5 3546.0 3607.9 3639.4 3704.6 12013.8 12714.2 12714.3 12729.9 12746.0 12164.1 12277.3 12479.6 12660.2 12681.0 9039.5 9094.4 9120.5 9215.6 9219.6 5371.4 5445.1 5449.2 5474.4 5576.8 10946.2 11035.6 11079.6 11158.4 11168.4 11290.3 11390.7 11638.0 11664.1 11775.4 7525.5 7541.3 7566.9 7596.2 7618.8 8940.5 9047.4 9115.0 9122.6 9127.7 7335.1 7505.7 7519.5 7566.4 7712.8 7084.9 7137.6 7186.1 7346.0 7439.4 6267.9 6301.6 6352.3 6357.3 6361.4 4797.2 4889.4 4919.8 4950.4 4966.5 4905.0 4932.3 4955.4 5094.4 5095.9 04:48:49 INFO - PID 14283 | 04:48:49 INFO - PID 14283 | [#4] prototype.html Cycles:180 Average:4833.40 Median:5549.74 stddev:1428.38 (25.7%) stddev-sans-first:1392.26 04:48:49 INFO - PID 14283 | Values: 353.8 368.3 378.8 395.6 400.2 5567.2 5574.8 5670.7 5671.9 5685.3 5497.3 5545.7 5548.1 5551.4 5564.5 4160.4 4239.6 4276.1 4407.6 4427.1 4262.6 4264.8 4272.7 4278.6 4281.9 4243.1 4244.2 4254.4 4274.7 4278.2 4090.3 4227.6 4271.2 4271.8 4277.1 3659.1 3705.0 3714.3 3714.8 3727.6 5357.2 5360.9 5384.4 5386.2 5389.3 4652.4 4878.9 4904.3 4910.1 4920.2 5752.3 5763.8 5771.7 5786.5 5798.2 4035.5 4058.8 4070.7 4074.4 4079.3 5953.7 6097.5 6144.6 6182.0 6190.7 4161.8 4180.5 4183.3 4193.1 4202.6 4210.0 4215.2 4246.5 4249.2 4262.9 4761.9 4862.6 4876.0 4876.4 4876.8 5837.6 5843.8 5855.7 5874.7 5876.5 1442.2 1449.7 1451.4 1453.7 1454.8 941.4 990.6 991.8 998.9 1009.4 5097.7 5109.4 5112.7 5113.6 5114.3 6018.8 6048.8 6060.0 6081.7 6085.2 4848.3 5016.7 5042.6 5068.3 5086.2 3220.0 3228.7 3238.8 3238.8 3251.3 5518.6 5636.7 5637.5 5654.6 5672.8 6067.4 6184.3 6187.8 6212.4 6219.8 5604.5 5615.4 5624.6 5625.4 5626.9 5767.3 6052.6 6057.6 6063.4 6077.5 5960.4 5970.6 5974.9 5978.3 5996.4 5469.8 5633.8 5641.5 5675.4 5693.4 4098.1 4102.6 4109.5 4113.3 4119.5 6026.2 6126.7 6145.3 6149.0 6153.8 5903.3 5908.9 5917.7 5920.3 5928.2 5888.2 5892.9 5896.5 5900.0 5920.4 5648.0 5763.9 5797.4 5823.6 5845.7 5909.6 5921.3 5925.1 5947.6 5959.5 5626.6 5757.2 5763.7 5782.5 5801.7 04:48:49 INFO - PID 14283 | 04:48:49 INFO - PID 14283 | [#5] yui.html Cycles:180 Average:13542.89 Median:3304.67 stddev:17363.30 (525.4%) stddev-sans-first:17384.81 04:48:49 INFO - PID 14283 | Values: 601.5 603.2 612.3 618.2 636.4 13524.6 13783.3 14254.4 14268.2 14551.9 13451.2 13541.0 13660.7 13670.8 13675.9 654.9 775.6 920.2 944.0 944.7 950.7 952.5 955.4 955.7 957.0 982.4 984.3 984.8 985.4 986.3 965.5 968.2 968.7 968.8 968.9 711.3 712.0 716.4 716.9 719.5 13097.1 13148.9 13159.3 13196.0 13272.3 13104.5 13248.0 13283.5 13416.1 13430.1 9281.6 10783.1 11072.7 11276.9 11333.0 3861.5 3889.1 3899.2 3905.2 3946.2 61007.7 61537.2 62961.7 63629.7 64351.4 9114.8 9286.0 9379.2 9389.9 9596.2 20676.8 20708.7 20742.4 20767.7 20802.5 5813.7 5832.6 5911.1 5941.9 6007.9 3022.4 3054.3 3111.3 3170.8 3179.8 3590.8 3662.5 3692.1 3700.9 3714.0 577.3 578.9 591.9 594.1 594.4 455.8 461.9 462.3 477.8 478.3 7220.0 7397.3 7559.8 7561.3 7806.6 461.2 464.5 467.3 468.5 478.6 3446.0 3481.8 3516.3 3569.8 3617.0 63420.0 63763.7 63916.7 64861.7 64879.0 53790.5 53794.0 54110.0 56226.0 56506.7 49223.8 49483.0 49583.3 49963.8 51244.7 6863.2 7011.3 7091.3 7217.2 7240.3 26010.0 26112.6 26456.9 26924.2 27229.6 31388.4 31881.0 32025.8 32779.3 33183.8 8366.5 8433.9 8453.7 8481.9 8482.0 8646.7 8828.7 8864.0 8882.2 8941.5 8425.5 8433.5 8465.6 8561.7 8616.1 8164.0 8225.6 8307.3 8354.5 8430.6 8260.2 8287.0 8322.5 8407.4 8494.7 6962.5 8700.3 8765.9 8795.8 9077.9 9517.5 9933.7 9934.3 10008.4 10150.7 04:48:49 INFO - PID 14283 | -------- Summary: end -------- 04:48:49 INFO - PID 14283 | 04:48:50 INFO - TEST-INFO | 14283: exit 0 04:48:50 INFO - TEST-OK | dromaeo_css | took 1120624ms 04:48:50 INFO - TEST-START | kraken 04:48:50 INFO - operating with platform_type : linux_ 04:48:50 INFO - Initialising browser for kraken test... 04:48:50 INFO - TEST-INFO | started process 14659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYFXCcC/profile http://localhost:56359/getInfo.html) 04:48:54 INFO - PID 14659 | __metrics Screen width/height:1600/1200 04:48:54 INFO - PID 14659 | colorDepth:24 04:48:54 INFO - PID 14659 | Browser inner width/height: 1024/697 04:48:54 INFO - PID 14659 | __metrics 04:48:55 ERROR - PID 14659 | 1490960935438 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6382:36 < canClose@browser.js:5233:12 < forceQuit@jar:file:///tmp/tmpYFXCcC/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmpYFXCcC/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmpYFXCcC/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmpYFXCcC/profile/extensions/talos-powers@TalosPowersService.js:55:9 04:48:55 ERROR - PID 14659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 04:48:56 INFO - TEST-INFO | 14659: exit 0 04:48:56 INFO - Browser initialized. 04:48:56 INFO - Running cycle 1/1 for kraken test... 04:48:56 INFO - TEST-INFO | started process 14792 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYFXCcC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:49:08 INFO - PID 14792 | RSS: Main: 155983872 04:49:08 INFO - PID 14792 | 04:49:11 INFO - PID 14792 | Cycle 1(1): loaded http://localhost:56359/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56359/tests/kraken/driver.html?testName=audio-beat-detection) 04:49:12 INFO - PID 14792 | RSS: Main: 162734080 04:49:12 INFO - PID 14792 | 04:49:15 INFO - PID 14792 | Cycle 1(1): loaded http://localhost:56359/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56359/tests/kraken/driver.html?testName=audio-dft) 04:49:15 INFO - PID 14792 | RSS: Main: 161583104 04:49:15 INFO - PID 14792 | 04:49:18 INFO - PID 14792 | Cycle 1(1): loaded http://localhost:56359/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56359/tests/kraken/driver.html?testName=audio-fft) 04:49:19 INFO - PID 14792 | RSS: Main: 158519296 04:49:19 INFO - PID 14792 | 04:49:21 INFO - PID 14792 | Cycle 1(1): loaded http://localhost:56359/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56359/tests/kraken/driver.html?testName=audio-oscillator) 04:49:22 INFO - PID 14792 | RSS: Main: 158814208 04:49:22 INFO - PID 14792 | 04:49:24 INFO - PID 14792 | Cycle 1(1): loaded http://localhost:56359/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56359/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:49:25 INFO - PID 14792 | RSS: Main: 158965760 04:49:25 INFO - PID 14792 | 04:49:28 INFO - PID 14792 | Cycle 1(1): loaded http://localhost:56359/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56359/tests/kraken/driver.html?testName=imaging-darkroom) 04:49:28 INFO - PID 14792 | RSS: Main: 164044800 04:49:28 INFO - PID 14792 | 04:49:32 INFO - PID 14792 | Cycle 1(1): loaded http://localhost:56359/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56359/tests/kraken/driver.html?testName=imaging-desaturate) 04:49:33 INFO - PID 14792 | RSS: Main: 161509376 04:49:33 INFO - PID 14792 | 04:49:36 INFO - PID 14792 | Cycle 1(1): loaded http://localhost:56359/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56359/tests/kraken/driver.html?testName=json-parse-financial) 04:49:36 INFO - PID 14792 | RSS: Main: 162521088 04:49:36 INFO - PID 14792 | 04:49:38 INFO - PID 14792 | Cycle 1(1): loaded http://localhost:56359/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56359/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:49:39 INFO - PID 14792 | RSS: Main: 163082240 04:49:39 INFO - PID 14792 | 04:49:41 INFO - PID 14792 | Cycle 1(1): loaded http://localhost:56359/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56359/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:49:41 INFO - PID 14792 | RSS: Main: 162709504 04:49:41 INFO - PID 14792 | 04:49:43 INFO - PID 14792 | Cycle 1(1): loaded http://localhost:56359/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56359/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:49:44 INFO - PID 14792 | RSS: Main: 163430400 04:49:44 INFO - PID 14792 | 04:49:47 INFO - PID 14792 | Cycle 1(1): loaded http://localhost:56359/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:49:48 INFO - PID 14792 | RSS: Main: 163725312 04:49:48 INFO - PID 14792 | 04:49:51 INFO - PID 14792 | Cycle 1(1): loaded http://localhost:56359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:49:51 INFO - PID 14792 | RSS: Main: 163618816 04:49:51 INFO - PID 14792 | 04:49:53 INFO - PID 14792 | Cycle 1(1): loaded http://localhost:56359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56359/tests/kraken/driver.html?testName=ai-astar) 04:49:54 INFO - PID 14792 | RSS: Main: 165765120 04:49:54 INFO - PID 14792 | 04:49:54 INFO - PID 14792 | __start_tp_report 04:49:54 INFO - PID 14792 | _x_x_mozilla_page_load 04:49:54 INFO - PID 14792 | _x_x_mozilla_page_load_details 04:49:54 INFO - PID 14792 | |i|pagename|runs| 04:49:54 INFO - PID 14792 | |0;ai-astar;105;112;112;112;112;111;112;112;114;114 04:49:54 INFO - PID 14792 | |1;audio-beat-detection;151;128;127;165;138;126;127;126;147;127 04:49:54 INFO - PID 14792 | |2;audio-dft;170;165;171;174;169;174;166;165;165;165 04:49:54 INFO - PID 14792 | |3;audio-fft;80;83;81;113;78;77;78;75;100;76 04:49:54 INFO - PID 14792 | |4;audio-oscillator;85;93;104;85;92;85;101;88;94;107 04:49:54 INFO - PID 14792 | |5;imaging-gaussian-blur;115;115;115;115;115;116;115;124;115;115 04:49:54 INFO - PID 14792 | |6;imaging-darkroom;152;152;151;151;152;152;152;153;152;150 04:49:54 INFO - PID 14792 | |7;imaging-desaturate;96;103;96;96;95;96;96;95;95;94 04:49:54 INFO - PID 14792 | |8;json-parse-financial;67;67;69;67;68;69;69;68;68;68 04:49:54 INFO - PID 14792 | |9;json-stringify-tinderbox;62;55;56;55;55;56;59;55;56;56 04:49:54 INFO - PID 14792 | |10;stanford-crypto-aes;83;86;84;84;83;84;94;85;85;83 04:49:54 INFO - PID 14792 | |11;stanford-crypto-ccm;147;133;135;146;144;139;143;142;184;135 04:49:54 INFO - PID 14792 | |12;stanford-crypto-pbkdf2;187;196;194;201;205;195;195;197;207;200 04:49:54 INFO - PID 14792 | |13;stanford-crypto-sha256-iterative;74;77;74;73;72;78;75;71;71;70 04:49:54 INFO - PID 14792 | __end_tp_report 04:49:54 INFO - PID 14792 | __start_cc_report 04:49:54 INFO - PID 14792 | _x_x_mozilla_cycle_collect,891 04:49:54 INFO - PID 14792 | __end_cc_report 04:49:54 INFO - PID 14792 | __startTimestamp1490960994087__endTimestamp 04:49:54 INFO - PID 14792 | 04:49:54 INFO - PID 14792 | ------- Summary: start ------- 04:49:54 INFO - PID 14792 | Number of tests: 14 04:49:54 INFO - PID 14792 | 04:49:54 INFO - PID 14792 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:2.50 (2.2%) stddev-sans-first:1.00 04:49:54 INFO - PID 14792 | Values: 105.0 112.0 112.0 112.0 112.0 111.0 112.0 112.0 114.0 114.0 04:49:54 INFO - PID 14792 | 04:49:54 INFO - PID 14792 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:133.00 stddev:13.73 (10.3%) stddev-sans-first:13.48 04:49:54 INFO - PID 14792 | Values: 151.0 128.0 127.0 165.0 138.0 126.0 127.0 126.0 147.0 127.0 04:49:54 INFO - PID 14792 | 04:49:54 INFO - PID 14792 | [#2] audio-dft Cycles:10 Average:168.40 Median:169.50 stddev:3.72 (2.2%) stddev-sans-first:3.90 04:49:54 INFO - PID 14792 | Values: 170.0 165.0 171.0 174.0 169.0 174.0 166.0 165.0 165.0 165.0 04:49:54 INFO - PID 14792 | 04:49:54 INFO - PID 14792 | [#3] audio-fft Cycles:10 Average:84.10 Median:78.00 stddev:12.42 (15.9%) stddev-sans-first:13.09 04:49:54 INFO - PID 14792 | Values: 80.0 83.0 81.0 113.0 78.0 77.0 78.0 75.0 100.0 76.0 04:49:54 INFO - PID 14792 | 04:49:54 INFO - PID 14792 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:86.50 stddev:8.15 (9.4%) stddev-sans-first:8.06 04:49:54 INFO - PID 14792 | Values: 85.0 93.0 104.0 85.0 92.0 85.0 101.0 88.0 94.0 107.0 04:49:54 INFO - PID 14792 | 04:49:54 INFO - PID 14792 | [#5] imaging-gaussian-blur Cycles:10 Average:116.00 Median:115.00 stddev:2.83 (2.5%) stddev-sans-first:2.98 04:49:54 INFO - PID 14792 | Values: 115.0 115.0 115.0 115.0 115.0 116.0 115.0 124.0 115.0 115.0 04:49:54 INFO - PID 14792 | 04:49:54 INFO - PID 14792 | [#6] imaging-darkroom Cycles:10 Average:151.70 Median:152.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 04:49:54 INFO - PID 14792 | Values: 152.0 152.0 151.0 151.0 152.0 152.0 152.0 153.0 152.0 150.0 04:49:54 INFO - PID 14792 | 04:49:54 INFO - PID 14792 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:2.49 (2.6%) stddev-sans-first:2.64 04:49:54 INFO - PID 14792 | Values: 96.0 103.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 94.0 04:49:54 INFO - PID 14792 | 04:49:54 INFO - PID 14792 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 04:49:54 INFO - PID 14792 | Values: 67.0 67.0 69.0 67.0 68.0 69.0 69.0 68.0 68.0 68.0 04:49:54 INFO - PID 14792 | 04:49:54 INFO - PID 14792 | [#9] json-stringify-tinderbox Cycles:10 Average:56.50 Median:56.00 stddev:2.27 (4.1%) stddev-sans-first:1.27 04:49:54 INFO - PID 14792 | Values: 62.0 55.0 56.0 55.0 55.0 56.0 59.0 55.0 56.0 56.0 04:49:54 INFO - PID 14792 | 04:49:54 INFO - PID 14792 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:84.50 stddev:3.28 (3.9%) stddev-sans-first:3.39 04:49:54 INFO - PID 14792 | Values: 83.0 86.0 84.0 84.0 83.0 84.0 94.0 85.0 85.0 83.0 04:49:54 INFO - PID 14792 | 04:49:54 INFO - PID 14792 | [#11] stanford-crypto-ccm Cycles:10 Average:144.80 Median:143.50 stddev:14.60 (10.2%) stddev-sans-first:15.47 04:49:54 INFO - PID 14792 | Values: 147.0 133.0 135.0 146.0 144.0 139.0 143.0 142.0 184.0 135.0 04:49:54 INFO - PID 14792 | 04:49:54 INFO - PID 14792 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.70 Median:198.50 stddev:5.79 (2.9%) stddev-sans-first:4.68 04:49:54 INFO - PID 14792 | Values: 187.0 196.0 194.0 201.0 205.0 195.0 195.0 197.0 207.0 200.0 04:49:54 INFO - PID 14792 | 04:49:54 INFO - PID 14792 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.50 Median:74.00 stddev:2.64 (3.6%) stddev-sans-first:2.79 04:49:54 INFO - PID 14792 | Values: 74.0 77.0 74.0 73.0 72.0 78.0 75.0 71.0 71.0 70.0 04:49:54 INFO - PID 14792 | -------- Summary: end -------- 04:49:54 INFO - PID 14792 | 04:49:55 INFO - TEST-INFO | 14792: exit 0 04:49:55 INFO - TEST-OK | kraken | took 65027ms 04:49:55 INFO - SUITE-END | took 1185s 04:49:55 INFO - Completed test suite (00:19:45) 04:49:55 INFO - javascript benchmark 04:49:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6595.810321080548, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2628.947421051579, 2705.891764329427, 2714.837109773414, 2736.890524379025, 2744.821586596871, 5099.949000509994, 5134.871628209292, 5179.922301165476, 5211.482623402281, 5265.394479634843, 5151.175811870102, 5159.871003224921, 5164.9741751291285, 5226.738663066841, 5258.13240815265, 4741.217699079656, 4798.4001999750035, 4798.736069516175, 4807.687500312486, 4812.951870481285, 4793.4487533933525, 4811.398575178103, 4839.032193561285, 4840.903181936359, 4898.093852637274, 4696.201645720235, 4716.38686970695, 4743.501932297094, 4759.4764575896625, 4763.14263432582, 4761.333413322138, 4763.49983251757, 4793.664443488957, 4823.734694591796, 4841.7337046462435, 4653.930191047137, 4732.219183834663, 4736.928946065812, 4765.642576806753, 4781.258904869751, 5047.924281135786, 5119.667221630582, 5158.535731784157, 5215.24378965048, 5271.077561426735, 5515.641483303572, 5528.198411230389, 5536.390996990328, 5573.777048918038, 5601.215829783833, 5616.887662246773, 5640.435956404368, 5651.350094739117, 5651.660900345993, 5671.801486947937, 5093.439721630618, 5210.609204309654, 5233.188855727369, 5244.265802787613, 5289.947100528945, 5657.4059723728415, 5690.6870122142855, 5748.281464816898, 5748.396418376094, 5779.884402312015, 5372.946270537244, 5443.34679838414, 5443.755031023614, 5451.345838499326, 5458.754356053987, 5465.344158700981, 5505.532029777513, 5534.0, 5550.028744969695, 5553.111502159635, 5485.067538518461, 5495.010898038311, 5498.202760599691, 5502.944970550323, 5510.228568000483, 5484.643498172606, 5490.039243132515, 5490.725463726878, 5491.148871924858, 5506.889862202734, 4686.039361930864, 4699.060187962421, 4699.342092107107, 4703.035877645143, 4708.505606911293, 4080.1685871856016, 4090.1615168890307, 4097.467329247238, 4099.0, 4132.40080188371, 4692.718436893797, 4776.689515181502, 4812.614990800727, 4815.9886423851385, 4827.879303017382, 5528.861778455571, 5575.69333686643, 5620.016497112989, 5638.802641907513, 5653.406392328829, 4831.299461578122, 4838.927416088762, 4839.274108883696, 4856.490068542823, 4880.682755620874, 5017.648764586517, 5025.195968644999, 5032.974835125874, 5034.119029169808, 5034.521720436553, 5085.669431486942, 5165.199394093921, 5224.50367215114, 5294.708791016531, 5300.9734951325, 5658.434156584309, 5669.801556945487, 5674.4892959633835, 5674.858128546819, 5721.22763426932, 5223.973880130575, 5253.737313134252, 5265.578753699619, 5273.31446911899, 5328.0, 5411.2153737708595, 5467.58993075513, 5473.917891231555, 5526.088195447706, 5535.308086489189, 5612.298462692163, 5616.606837521498, 5636.971815140898, 5652.886942261214, 5682.77268909239, 5408.161734931092, 5437.048516509516, 5446.782128714807, 5450.1007333789485, 5450.264214331173, 5281.287026251561, 5336.73316334174, 5395.325584301962, 5433.022056029952, 5479.589030822624, 5227.372715274191, 5360.892782144413, 5391.892162156656, 5402.486763757437, 5434.619576629756, 5483.972580137074, 5490.231367608618, 5496.7526461308535, 5523.143912693539, 5535.059039963136, 5170.844874653766, 5245.239440281061, 5329.57363410934, 5399.379071406838, 5403.081476149143], "value": 5098.487615497026, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.3712241931373, 686.7356067913855, 1077.0521940692195, 1086.7500474890776, 1196.78457877582, 34317.0, 35796.46305305423, 35802.10494737633, 35921.640783592185, 35946.640533594655, 32816.67183328166, 33298.0, 33300.833495832485, 33335.49996750051, 33399.4990075149, 6945.479089068327, 7104.7513337033215, 7255.201927787965, 7441.441891858105, 7442.144153422345, 7503.549787012769, 7597.392208623324, 7597.620118994056, 7604.429667774912, 7605.543667379948, 7606.04924384452, 7659.6936122555035, 7686.807829804244, 7689.269519395676, 7689.346405555534, 7522.172561018284, 7618.504797188193, 7641.541507509512, 7643.0828300603725, 7644.6942122315595, 7232.855342893113, 7295.52579082358, 7297.708091676326, 7302.598357090358, 7326.3040011198855, 34196.82901585501, 34371.312573748386, 34383.14042148966, 34511.16843641867, 34654.653453465646, 2423.297243799296, 2475.220305603747, 2494.3140636324974, 2498.8625625590585, 2541.4789968056502, 23505.41236469085, 23512.294631160923, 23604.64593031106, 24218.39454013646, 24421.267361979168, 2618.56793629051, 2692.5998480790076, 2715.2261605442354, 2718.687350954646, 2720.224735950245, 173052.0, 174261.99999999872, 174507.0, 175305.0, 175575.0, 42192.578074218865, 42429.0, 42499.0, 42503.0, 45471.0, 47034.76482617565, 47258.52741472541, 47296.290555641695, 47339.763301183964, 47755.0, 13204.60386188416, 13208.207507549385, 13326.267055311857, 13327.133736307109, 13348.6662833428, 10582.100521455608, 10637.9468102659, 10638.840417393745, 10640.521176547074, 10774.461276936121, 13373.331333433483, 13512.256825874474, 13524.391402386917, 13586.864131358758, 13665.18008919468, 5411.377691565521, 5491.588130890199, 5532.474414930575, 5647.435256474319, 5663.150527420919, 847.5931552854664, 885.3271513649672, 897.0715309654606, 898.510311880027, 914.8078903430354, 19247.15662495229, 20224.494387640425, 20367.59264814725, 20426.69359959602, 20679.483012924495, 971.3249291742312, 975.4001289207087, 988.5996171550534, 990.782027953849, 1014.325473560089, 10636.202284828669, 10886.727831804268, 10988.066014388867, 11008.449577521093, 11015.449227538591, 249863.0, 250407.0, 251628.0, 253119.0, 253489.0, 43281.35077973833, 43537.78231108824, 43613.0, 43651.34522982158, 43687.78156109199, 1210.6368089573093, 1251.8622951475331, 1260.7289432772181, 1262.072376803049, 1265.7658333208385, 19107.140178691716, 19297.710534341717, 19956.0, 20082.09630566599, 20174.193032278545, 31718.0, 31786.841065794524, 31972.84013579917, 32014.0, 32057.519137212494, 222738.0, 223684.0, 224119.0, 224233.0, 224821.0, 30164.062265678578, 32280.515792262664, 32649.0, 32723.0, 32895.0, 37489.437658435694, 37789.4331585032, 38572.0, 38999.41500877546, 41299.0, 30316.24209394783, 30646.233844154074, 30985.845070774503, 31110.844445777628, 31413.80103392832, 30691.232719181306, 30713.692863071083, 30734.69265307408, 31090.22274443157, 31904.521432179, 33572.66427335695, 34183.145421364665, 34553.30893382068, 34638.480422794186, 34787.0, 30439.0, 30539.2365190872, 30638.84680576583, 31103.2317489869, 31229.68770312268, 21608.783912160678, 22496.887515562317, 22500.549989000454, 22501.774982250623, 22633.321000370015], "value": 15407.173112751767, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.63839352615025, 389.7077192105921, 421.73430738634664, 426.3902619254467, 432.27809558038075, 13698.794518082237, 17821.28714851406, 18500.722489162657, 18623.534411639732, 19067.14197861096, 16062.196890155505, 16394.09832459214, 16484.752728709078, 16799.24403401847, 17013.404530841424, 5520.0, 5623.240862483573, 5726.914096288559, 5766.769329226826, 5808.56435767317, 5564.916526252109, 5573.442655734435, 5685.37460879305, 5689.431056894319, 5698.287714035746, 5767.279090113736, 5783.103618939072, 5786.392428794979, 5787.276590426197, 5799.304083509985, 5709.486146246816, 5741.368449470576, 5759.654420734749, 5763.221965034709, 5779.162021506879, 5189.532942035235, 5222.060029194743, 5222.843314700565, 5225.764840582183, 5226.189940559219, 21932.0, 22382.440438988993, 22386.440338991655, 22635.66046509304, 22779.08883644652, 1499.737545929469, 1511.4785399037314, 1529.350026238844, 1568.6470544127594, 1570.46604154588, 13927.303634818218, 14027.579172624837, 14097.85902140986, 14322.212278324689, 15061.698766024618, 1748.7901451825735, 1772.884762490434, 1781.901995390253, 1782.189103957696, 1794.1836464408664, 87173.0, 91961.54019229928, 92221.0, 93023.0, 94648.52675736646, 10887.83668244977, 10920.672379828618, 11070.335779853074, 11118.722031949266, 11452.312861228353, 15002.549923502313, 15410.6147346315, 15456.690866182613, 15502.9224853875, 15524.844751552566, 7349.30181632744, 7462.888056679154, 7576.734814281584, 7604.163542010375, 7625.161232264447, 6749.0551322814845, 6877.828054298582, 7023.92976070243, 7053.083099197174, 7069.646517674096, 6920.854535094137, 7041.823954401181, 7054.894176587355, 7081.716731330792, 7267.0, 2060.1450398084926, 2085.3326935380533, 2091.8431117666237, 2145.3885642591786, 2288.4622113803243, 828.2545708862073, 862.3747782857504, 870.7083127152475, 877.5831480046927, 885.8208806336356, 15992.92003539975, 16377.590560236089, 16585.91707041457, 16780.0, 16846.410375636795, 883.3860466975519, 883.4787475389551, 884.4648987362682, 886.7472770260574, 887.4586502233632, 8709.825803483895, 9123.908760912438, 9186.081391860895, 9268.490233037113, 9334.953325233331, 443781.0, 444385.0, 448712.0, 450115.0, 452808.0, 90049.0, 91776.0, 92427.0, 93505.53247233856, 95630.0, 999.7550600103021, 1042.0, 1064.0264158295074, 1065.4086981725218, 1078.8489611454402, 14533.27333633293, 17054.0, 18894.3386981455, 18951.90524047426, 19016.429507114808, 42146.57853421549, 43927.560724392344, 44111.0, 45548.31677524906, 45909.0, 52691.73654131705, 53309.0, 53983.460165397846, 54418.0, 56186.0, 8169.0, 8227.753167404988, 8240.876386854321, 8485.266482747571, 8573.142685731376, 13422.865771342162, 13469.259190744604, 13474.19154850712, 13644.590662280147, 14226.430942762174, 10447.791044179226, 10479.0, 10970.451477426257, 11129.721756956142, 11546.19176657626, 10220.846687299547, 10512.0, 10516.68449946503, 10840.132789376989, 10904.182186335898, 10478.214133940137, 10913.39976301311, 11034.0, 11343.602973895873, 11376.919192676682, 8317.701057673023, 8387.329013679013, 8416.915830841857, 8541.914580854113, 8670.653173872974, 10378.169746420419, 10529.684109476728, 11070.446477676245, 11080.445977700922, 11651.941740291244], "value": 8979.026531666024, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1247.9812802807958, 1314.2837153751204, 1320.5774152271276, 1328.2561765411365, 1330.8802207801295, 8980.640774369025, 9270.953645231773, 9282.721518354452, 9664.565094570744, 9921.950390248057, 9627.903720962788, 9809.068138526847, 9816.852747208797, 9819.459929703864, 9820.11618954294, 2214.9667754983648, 2254.5152792149684, 2255.2557655973487, 2255.5376147889724, 2256.8533045352083, 2101.2015434135083, 2180.509385388291, 2212.2699509162017, 2225.9666105008437, 2229.1640634761966, 2154.676798480225, 2197.2968650031994, 2254.695616091823, 2261.1407665087245, 2273.2498275569105, 2156.493224092337, 2200.7689192634703, 2203.4821816873023, 2210.071769856656, 2218.6339254023146, 1829.2225804033367, 1898.4968983219458, 2093.2778191524053, 2160.34109596573, 2179.9564008719735, 9532.666356677482, 9640.0, 9656.613735450574, 9681.70954871355, 9687.0, 5302.310699609065, 5571.832845014656, 5578.721063946827, 5582.413846546095, 5605.299337582802, 3252.9674703253136, 3365.444701624229, 3384.2047118927035, 3415.112070861594, 3424.6575342465803, 1009.6516701737888, 1024.293237666008, 1037.2428127466917, 1048.783411242962, 1063.9627613033506, 13231.404586793617, 13267.867321326856, 13279.5432844924, 13335.133216341004, 13360.398782054734, 4725.713585691535, 4756.191447453941, 4789.114013907439, 4902.41171059468, 4918.532739389752, 10385.63650272252, 10468.110210632029, 10490.475476226158, 10529.157667386591, 10535.789284214427, 5366.704831234241, 5432.619716619799, 5437.755301011464, 5448.155535891943, 5448.673079615236, 4841.975790121097, 4850.417949846041, 4972.453030166679, 5015.14742493777, 5079.974600126976, 3758.9248215035545, 3824.158685089276, 3910.354791459434, 3962.9603703962593, 4017.6183262590007, 1167.3696204049718, 1170.9238899471507, 1172.3141961952354, 1179.6578992092368, 1186.6262127430005, 673.5689158938284, 689.0491122251361, 690.908007981172, 693.9340762627543, 709.3970125393374, 5055.4328158271055, 5069.518395752398, 5159.458256883048, 5211.530962213419, 5227.0, 524.9737513124328, 549.3106151779491, 554.9056660367747, 559.3986464550543, 563.7942151114895, 3405.4721518164724, 3545.982270088633, 3607.9098022549647, 3639.4358874374516, 3704.5554533456157, 12013.819792703116, 12714.173578717353, 12714.300713460849, 12729.936350318188, 12746.044046696536, 12164.14850960442, 12277.263364198177, 12479.625611231677, 12660.17708848922, 12681.048921330937, 9039.45763254207, 9094.36339456245, 9120.49837258957, 9215.63137474507, 9219.631214751469, 5371.382291036581, 5445.101558242845, 5449.1826226066405, 5474.42518535564, 5576.776928922797, 10946.17903657213, 11035.613753518588, 11079.61221357281, 11158.442077896236, 11168.441577920908, 11290.266132701348, 11390.715232118931, 11638.0, 11664.066874650178, 11775.411229438665, 7525.510841795266, 7541.283578060075, 7566.886496702664, 7596.202398748052, 7618.8095297618, 8940.508272044839, 9047.411918225294, 9115.0, 9122.635094596142, 9127.726168214964, 7335.1197856257595, 7505.662245199088, 7519.511231769918, 7566.432517561315, 7712.768616941501, 7084.893726594209, 7137.571745695275, 7186.1376634804155, 7346.045014148127, 7439.442041846992, 6267.874642507033, 6301.6219026858535, 6352.269489008823, 6357.268914074941, 6361.395667411589, 4797.18447863857, 4889.364382630235, 4919.827806026772, 4950.430700469492, 4966.453690094159, 4905.0, 4932.334134891744, 4955.380577427822, 5094.414142373675, 5095.923561146512], "value": 4515.588165016629, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.8407716527562, 368.3186105704449, 378.8389934277933, 395.636014866323, 400.2335527464904, 5567.220589117522, 5574.832755017356, 5670.68811215383, 5671.914921276184, 5685.260916080914, 5497.257870187524, 5545.722713864311, 5548.085910360929, 5551.3893471718075, 5564.4991950724425, 4160.356659119646, 4239.618434340909, 4276.123394704094, 4407.647388208944, 4427.070315233805, 4262.552431994643, 4264.808083636244, 4272.658187345005, 4278.593533614302, 4281.929517620595, 4243.130158317553, 4244.214820258262, 4254.383114448418, 4274.700770946035, 4278.229918614648, 4090.284200264942, 4227.619514243733, 4271.209826182151, 4271.78641067947, 4277.144571085764, 3659.1035196376793, 3704.9629503704887, 3714.312852122366, 3714.832832522516, 3727.589965103836, 5357.196420536911, 5360.946390536123, 5384.3538775346815, 5386.165144402624, 5389.272448219479, 4652.395188625457, 4878.902421951577, 4904.313396124546, 4910.140725373046, 4920.188168952119, 5752.309722833245, 5763.827085187451, 5771.682557459338, 5786.537077033827, 5798.246227990377, 4035.535913369971, 4058.79706014701, 4070.715049946505, 4074.4092106644666, 4079.3473044313064, 5953.702314884238, 6097.542684298695, 6144.600600960968, 6181.9690901545655, 6190.7403797614, 4161.83352665896, 4180.47744031996, 4183.330667093251, 4193.077522944947, 4202.600752928467, 4209.957900421018, 4215.178040282116, 4246.49042114942, 4249.150169966019, 4262.850800221977, 4761.928571071437, 4862.610991120772, 4875.9512404875495, 4876.439209490883, 4876.780544875489, 5837.562182836305, 5843.824685259449, 5855.707214639251, 5874.73563689635, 5876.529877609781, 1442.2428225181864, 1449.6738233897288, 1451.4049239811627, 1453.7310597539279, 1454.7672372420361, 941.4445477168504, 990.6334656177116, 991.7818080022383, 998.8801343838786, 1009.4296722351847, 5097.731509478246, 5109.4379618241965, 5112.667676601009, 5113.642045056885, 5114.28400023997, 6018.849528761816, 6048.758049677964, 6059.969700151471, 6081.695915204222, 6085.196752029981, 4848.327327072155, 5016.749162541858, 5042.596592272609, 5068.341115654941, 5086.237064440364, 3219.9839000804845, 3228.741700663941, 3238.789478683878, 3238.8218647974586, 3251.2847173621767, 5518.558515318765, 5636.746346414421, 5637.520810731134, 5654.575906807006, 5672.7730890763905, 6067.423594758579, 6184.257889053252, 6187.752489900444, 6212.409821066992, 6219.751209951642, 5604.467575580314, 5615.3823079462045, 5624.634398764068, 5625.409332020243, 5626.859328516738, 5767.2502574666705, 6052.606580572248, 6057.636541807506, 6063.423974722395, 6077.453029227391, 5960.433758792908, 5970.641761494324, 5974.850628734316, 5978.342382338026, 5996.400359963969, 5469.781208751764, 5633.8309850704545, 5641.464060914206, 5675.432456754292, 5693.430656934273, 4098.118904435561, 4102.5692302307825, 4109.486314210723, 4113.321301985139, 4119.485064366954, 6026.184731733898, 6126.724297406717, 6145.324014358506, 6148.985417406078, 6153.84615384619, 5903.321118071477, 5908.9228432381515, 5917.6745279010065, 5920.2933667735115, 5928.199693041557, 5888.234529511136, 5892.882142357214, 5896.528277737856, 5900.0, 5920.407959204217, 5648.0, 5763.924987004759, 5797.449242321973, 5823.602335439548, 5845.736941837713, 5909.640782619936, 5921.348651648402, 5925.103966730605, 5947.613405128653, 5959.539912721411, 5626.58067465315, 5757.165211044291, 5763.711814409179, 5782.508486778671, 5801.738921748616], "value": 4389.637482251973, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.4556826072406, 603.1977469964949, 612.2775125352084, 618.190170876152, 636.3763511758476, 13524.594262172139, 13783.310834458262, 14254.358553865075, 14268.215248161347, 14551.854481455182, 13451.192928424301, 13540.999999999975, 13660.726785464285, 13670.794938075913, 13675.863241367584, 654.8821212181817, 775.6393277126135, 920.2499962530517, 943.9669611563596, 944.6929747831948, 950.7432993091861, 952.4999375327939, 955.3742298794301, 955.6894009446958, 957.0238356875982, 982.4449186209804, 984.271638987148, 984.758734110144, 985.4136788610765, 986.3490096536287, 965.4593427680486, 968.1915600473578, 968.7142293023539, 968.8159249742527, 968.9321747477679, 711.3064761857199, 712.0423031023265, 716.4053835316727, 716.9390601798854, 719.543090137761, 13097.083204175711, 13148.86851131486, 13159.342032898317, 13196.0, 13272.270025148613, 13104.475820967149, 13248.006399519978, 13283.535076272285, 13416.127951683207, 13430.127041742255, 9281.58232879522, 10783.137349012139, 11072.667819965414, 11276.94361528187, 11332.955302872046, 3861.5054317914714, 3889.0666240102455, 3899.181171953893, 3905.1994341159993, 3946.2241991103833, 61007.694961525354, 61537.231384307845, 62961.68519157421, 63629.68185159091, 64351.356486435005, 9114.772130696785, 9286.0, 9379.249660027317, 9389.906100938902, 9596.23230141587, 20676.793232067488, 20708.689369659467, 20742.377728668165, 20767.68848467274, 20802.47993800167, 5813.680247586423, 5832.62087964281, 5911.083782013795, 5941.881162376728, 6007.879842403127, 3022.3804120155314, 3054.3127796246113, 3111.284404586958, 3170.793898396597, 3179.7933134346194, 3590.784552926833, 3662.5421822272215, 3692.1138926657945, 3700.870469533553, 3714.0, 577.2985822225932, 578.9015867302569, 591.8549955260903, 594.1207013619867, 594.378874076591, 455.81311662218997, 461.85451582751324, 462.2926921809637, 477.84231203702694, 478.258699016523, 7219.963900180465, 7397.334239918433, 7559.842086852209, 7561.3194812466045, 7806.570638614817, 461.2228395154176, 464.48906203176233, 467.2967184387475, 468.48232702863527, 478.5836322399535, 3445.966210136999, 3481.808500532444, 3516.3494753470177, 3569.839357228879, 3617.0234036809916, 63420.0, 63763.6811815938, 63916.68041659855, 64861.675691622186, 64879.0, 53790.46209537933, 53794.0, 54110.0, 56226.0, 56506.7174664124, 49223.75388123036, 49483.02067917315, 49583.256251156265, 49963.75018124886, 51244.74377628088, 6863.210730766026, 7011.298870112948, 7091.290870912868, 7217.170025446931, 7240.312170343809, 26010.0, 26112.608310874974, 26456.867715661298, 26924.192274231806, 27229.591556126277, 31388.372232555677, 31881.0, 32025.839870800497, 32779.344413111125, 33183.834080830406, 8366.498010119412, 8433.915660843559, 8453.66185352579, 8481.933481683973, 8481.957590212009, 8646.740597782076, 8828.690995815115, 8863.955680221816, 8882.189354705655, 8941.46351218929, 8425.519621857651, 8433.536155511505, 8465.61904714277, 8561.743147705578, 8616.052234254352, 8163.993576653856, 8225.588720564068, 8307.335413167053, 8354.5405002723, 8430.578471076544, 8260.173982601691, 8286.958565207135, 8322.45904016237, 8407.411481196257, 8494.660213591635, 6962.477814163856, 8700.292769540038, 8765.912340876765, 8795.824083518422, 9077.863832042656, 9517.52412379392, 9933.705356027798, 9934.254930880068, 10008.398656214971, 10150.746231344276], "value": 5888.936307758119, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1583.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 112.0, 112.0, 112.0, 111.0, 112.0, 112.0, 114.0, 114.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 128.0, 127.0, 165.0, 138.0, 126.0, 127.0, 126.0, 147.0, 127.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 165.0, 171.0, 174.0, 169.0, 174.0, 166.0, 165.0, 165.0, 165.0], "value": 168.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 81.0, 113.0, 78.0, 77.0, 78.0, 75.0, 100.0, 76.0], "value": 84.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 93.0, 104.0, 85.0, 92.0, 85.0, 101.0, 88.0, 94.0, 107.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 115.0, 115.0, 115.0, 116.0, 115.0, 124.0, 115.0, 115.0], "value": 116.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 151.0, 151.0, 152.0, 152.0, 152.0, 153.0, 152.0, 150.0], "value": 151.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 103.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 94.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 69.0, 67.0, 68.0, 69.0, 69.0, 68.0, 68.0, 68.0], "value": 68.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 55.0, 56.0, 55.0, 55.0, 56.0, 59.0, 55.0, 56.0, 56.0], "value": 56.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 84.0, 84.0, 83.0, 84.0, 94.0, 85.0, 85.0, 83.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 133.0, 135.0, 146.0, 144.0, 139.0, 143.0, 142.0, 184.0, 135.0], "value": 144.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 196.0, 194.0, 201.0, 205.0, 195.0, 195.0, 197.0, 207.0, 200.0], "value": 197.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 74.0, 73.0, 72.0, 78.0, 75.0, 71.0, 71.0, 70.0], "value": 73.5, "unit": "score"}]}]} 04:49:55 INFO - Return code: 0 04:49:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:49:55 ERROR - # TBPL SUCCESS # 04:49:55 INFO - Running post-action listener: _resource_record_post_action 04:49:55 INFO - [mozharness: 2017-03-31 11:49:55.898796Z] Finished run-tests step (success) 04:49:55 INFO - Running post-run listener: _resource_record_post_run 04:49:55 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 378294272; Read time: 40; Write time: 236296 04:49:55 INFO - TinderboxPrint: CPU usage
13.3% 04:49:55 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 40 04:49:55 INFO - TinderboxPrint: I/O write bytes / time
378,294,272 / 236,296 04:49:55 INFO - TinderboxPrint: CPU idle
8,312.0 (86.6%) 04:49:55 INFO - TinderboxPrint: CPU user
1,221.2 (12.7%) 04:49:55 INFO - TinderboxPrint: Swap in / out
0 / 0 04:49:55 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 119357440; Read time: 0; Write time: 84984 04:49:56 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 258936832; Read time: 40; Write time: 151312 04:49:56 INFO - Running post-run listener: _upload_blobber_files 04:49:56 INFO - Blob upload gear active. 04:49:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:49:56 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 04:49:56 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:49:56 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:49:56 INFO - (blobuploader) - INFO - Open directory for files ... 04:49:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:49:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:49:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:50:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:50:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:50:00 INFO - (blobuploader) - INFO - Done attempting. 04:50:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:50:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:50:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:50:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:50:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:50:00 INFO - (blobuploader) - INFO - Done attempting. 04:50:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:50:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:50:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:50:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:50:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:50:01 INFO - (blobuploader) - INFO - Done attempting. 04:50:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:50:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:50:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:50:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:50:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:50:02 INFO - (blobuploader) - INFO - Done attempting. 04:50:02 INFO - (blobuploader) - INFO - Iteration through files over. 04:50:02 INFO - Return code: 0 04:50:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:50:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:50:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/49d2bca987d24bbc66b6b1eb6200496ef05783623494f0c98701da349ab3709f5a4406d6bd5a2e6d2e3d1d9075209f07d74ae0021cbb91573187377f989f2100", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87ca8cedc0f6b081a5375fb93a9cce7c7120da3bca6553b292a30e198916cb67e5fed3f26906159e95c3e1122797a47f1159babecd3fbf68ac710c720b6b08a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ebf9439ab6401c940ff709fdf0a1d9f052eb0d9704302bc5691a10897e0cb16baf4601a458506f726d80e947151457a60d3c225e2849760bbe0dad1566eb0c3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8084bbee8c784301be89b7a0a06d3c8090776e20c8d7f3708ca53732778e1a0895430cc1707e2ab793c58aa6a3f368b61565afeb1acdd7139a7a803b7d8c225f"} 04:50:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:50:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:50:02 INFO - Contents: 04:50:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/49d2bca987d24bbc66b6b1eb6200496ef05783623494f0c98701da349ab3709f5a4406d6bd5a2e6d2e3d1d9075209f07d74ae0021cbb91573187377f989f2100", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87ca8cedc0f6b081a5375fb93a9cce7c7120da3bca6553b292a30e198916cb67e5fed3f26906159e95c3e1122797a47f1159babecd3fbf68ac710c720b6b08a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ebf9439ab6401c940ff709fdf0a1d9f052eb0d9704302bc5691a10897e0cb16baf4601a458506f726d80e947151457a60d3c225e2849760bbe0dad1566eb0c3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8084bbee8c784301be89b7a0a06d3c8090776e20c8d7f3708ca53732778e1a0895430cc1707e2ab793c58aa6a3f368b61565afeb1acdd7139a7a803b7d8c225f"} 04:50:02 INFO - Running post-run listener: copy_logs_to_upload_dir 04:50:02 INFO - Copying logs to upload dir... 04:50:02 INFO - mkdir: /builds/slave/test/build/upload/logs 04:50:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.393757 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-31 04:50:02.836447) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 04:50:02.840412) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995 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/Firefox-Non-PGO/sha512/49d2bca987d24bbc66b6b1eb6200496ef05783623494f0c98701da349ab3709f5a4406d6bd5a2e6d2e3d1d9075209f07d74ae0021cbb91573187377f989f2100", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87ca8cedc0f6b081a5375fb93a9cce7c7120da3bca6553b292a30e198916cb67e5fed3f26906159e95c3e1122797a47f1159babecd3fbf68ac710c720b6b08a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ebf9439ab6401c940ff709fdf0a1d9f052eb0d9704302bc5691a10897e0cb16baf4601a458506f726d80e947151457a60d3c225e2849760bbe0dad1566eb0c3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8084bbee8c784301be89b7a0a06d3c8090776e20c8d7f3708ca53732778e1a0895430cc1707e2ab793c58aa6a3f368b61565afeb1acdd7139a7a803b7d8c225f"} build_url:https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011267 build_url: 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/49d2bca987d24bbc66b6b1eb6200496ef05783623494f0c98701da349ab3709f5a4406d6bd5a2e6d2e3d1d9075209f07d74ae0021cbb91573187377f989f2100", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87ca8cedc0f6b081a5375fb93a9cce7c7120da3bca6553b292a30e198916cb67e5fed3f26906159e95c3e1122797a47f1159babecd3fbf68ac710c720b6b08a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ebf9439ab6401c940ff709fdf0a1d9f052eb0d9704302bc5691a10897e0cb16baf4601a458506f726d80e947151457a60d3c225e2849760bbe0dad1566eb0c3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8084bbee8c784301be89b7a0a06d3c8090776e20c8d7f3708ca53732778e1a0895430cc1707e2ab793c58aa6a3f368b61565afeb1acdd7139a7a803b7d8c225f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 04:50:02.869770) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:50:02.870156) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1490959740.116504-1170407995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.48 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:50:03.353911) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 04:50:03.354337) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 04:50:03.359038) ========= ========= Total master_lag: 0.87 =========