builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-073 starttime: 1490277443.13 results: success (0) revision: fcfdeb52c2b2f020631fd47b5b02ea0be50d4027 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 06:57:23.125841) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 06:57:23.126343) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 06:57:23.126646) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 06:57:23.141457) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 06:57:23.141798) ========= 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=0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-23 06:57:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.6M=0s 2017-03-23 06:57:23 (40.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087381 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 06:57:23.243040) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 06:57:23.243343) ========= 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=0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017283 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 06:57:23.292689) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 06:57:23.293012) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fcfdeb52c2b2f020631fd47b5b02ea0be50d4027 --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 fcfdeb52c2b2f020631fd47b5b02ea0be50d4027 --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=0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-23 06:57:23,810 truncating revision to first 12 chars 2017-03-23 06:57:23,811 Setting DEBUG logging. 2017-03-23 06:57:23,811 attempt 1/10 2017-03-23 06:57:23,811 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fcfdeb52c2b2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-23 06:57:24,808 unpacking tar archive at: mozilla-central-fcfdeb52c2b2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.311987 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 06:57:24.618275) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 06:57:24.618662) ========= script_repo_revision: fcfdeb52c2b2f020631fd47b5b02ea0be50d4027 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 06:57:24.619108) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 06:57:24.619369) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 06:57:24.629000) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-23 06:57:24.629396) ========= /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=0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:57:25 INFO - MultiFileLogger online at 20170323 06:57:25 in /builds/slave/test 06:57:25 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 06:57:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:57:25 INFO - {'append_to_log': False, 06:57:25 INFO - 'base_work_dir': '/builds/slave/test', 06:57:25 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:57:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:57:25 INFO - 'branch': 'Firefox-Non-PGO', 06:57:25 INFO - 'buildbot_json_path': 'buildprops.json', 06:57:25 INFO - 'config_files': ('talos/linux_config.py',), 06:57:25 INFO - 'default_actions': ('clobber', 06:57:25 INFO - 'read-buildbot-config', 06:57:25 INFO - 'download-and-extract', 06:57:25 INFO - 'populate-webroot', 06:57:25 INFO - 'create-virtualenv', 06:57:25 INFO - 'install', 06:57:25 INFO - 'run-tests'), 06:57:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:57:25 INFO - 'download_minidump_stackwalk': True, 06:57:25 INFO - 'download_symbols': 'ondemand', 06:57:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:57:25 INFO - 'tooltool.py': '/tools/tooltool.py', 06:57:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:57:25 INFO - '/tools/misc-python/virtualenv.py')}, 06:57:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:57:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:57:25 INFO - 'gecko_profile': False, 06:57:25 INFO - 'gecko_profile_interval': 0, 06:57:25 INFO - 'installer_path': 'installer.exe', 06:57:25 INFO - 'log_level': 'info', 06:57:25 INFO - 'log_name': 'talos', 06:57:25 INFO - 'log_to_console': True, 06:57:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:57:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:57:25 INFO - 'opt_config_files': (), 06:57:25 INFO - 'pip_index': False, 06:57:25 INFO - 'suite': 'dromaeojs-e10s', 06:57:25 INFO - 'system_bits': '32', 06:57:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:57:25 INFO - 'title': 'talos-linux64-ix-073', 06:57:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:57:25 INFO - 'use_talos_json': True, 06:57:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:57:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:57:25 INFO - 'work_dir': 'build'} 06:57:25 INFO - [mozharness: 2017-03-23 13:57:25.252561Z] Running clobber step. 06:57:25 INFO - Running pre-action listener: _resource_record_pre_action 06:57:25 INFO - Running main action method: clobber 06:57:25 INFO - rmtree: /builds/slave/test/build 06:57:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:57:26 INFO - Running post-action listener: _resource_record_post_action 06:57:26 INFO - [mozharness: 2017-03-23 13:57:26.701764Z] Finished clobber step (success) 06:57:26 INFO - [mozharness: 2017-03-23 13:57:26.701861Z] Running read-buildbot-config step. 06:57:26 INFO - Running pre-action listener: _resource_record_pre_action 06:57:26 INFO - Running main action method: read_buildbot_config 06:57:26 INFO - Using buildbot properties: 06:57:26 INFO - { 06:57:26 INFO - "project": "", 06:57:26 INFO - "product": "firefox", 06:57:26 INFO - "who": "cbook@mozilla.com", 06:57:26 INFO - "installer_path": "public/build/target.tar.bz2", 06:57:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:57:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:57:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 06:57:26 INFO - "stage_platform": "linux64", 06:57:26 INFO - "basedir": "/builds/slave/test", 06:57:26 INFO - "buildnumber": 732, 06:57:26 INFO - "platform": "ubuntu64_hw", 06:57:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:57:26 INFO - "slavebuilddir": "test", 06:57:26 INFO - "taskId": "bmzo7CWtThWvzHTAnczwow", 06:57:26 INFO - "branch": "mozilla-central", 06:57:26 INFO - "script_repo_revision": "production", 06:57:26 INFO - "revision": "fcfdeb52c2b2f020631fd47b5b02ea0be50d4027", 06:57:26 INFO - "slavename": "talos-linux64-ix-073", 06:57:26 INFO - "repo_path": "mozilla-central" 06:57:26 INFO - } 06:57:26 INFO - Finding installer, test and symbols from parent task. 06:57:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bmzo7CWtThWvzHTAnczwow'}, attempt #1 06:57:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bmzo7CWtThWvzHTAnczwow'}, attempt #1 06:57:27 INFO - Task dependencies: AdQ6ImFxRnyZb_jkjM3hHQ 06:57:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AdQ6ImFxRnyZb_jkjM3hHQ'}, attempt #1 06:57:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/AdQ6ImFxRnyZb_jkjM3hHQ/artifacts/public/build/target.tar.bz2 06:57:28 INFO - Set test_url: https://queue.taskcluster.net/v1/task/AdQ6ImFxRnyZb_jkjM3hHQ/artifacts/public/build/test_packages.json 06:57:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/AdQ6ImFxRnyZb_jkjM3hHQ/artifacts/public/build/target.crashreporter-symbols.zip 06:57:28 INFO - Running post-action listener: _resource_record_post_action 06:57:28 INFO - [mozharness: 2017-03-23 13:57:28.089475Z] Finished read-buildbot-config step (success) 06:57:28 INFO - [mozharness: 2017-03-23 13:57:28.089782Z] Running download-and-extract step. 06:57:28 INFO - Running pre-action listener: _resource_record_pre_action 06:57:28 INFO - Running main action method: download_and_extract 06:57:28 INFO - mkdir: /builds/slave/test/build/tests 06:57:28 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')]} 06:57:28 INFO - trying https://queue.taskcluster.net/v1/task/AdQ6ImFxRnyZb_jkjM3hHQ/artifacts/public/build/target.test_packages.json 06:57:28 INFO - Downloading https://queue.taskcluster.net/v1/task/AdQ6ImFxRnyZb_jkjM3hHQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:57:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AdQ6ImFxRnyZb_jkjM3hHQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:57:28 INFO - Downloaded 986 bytes. 06:57:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:57:28 INFO - Using the following test package requirements: 06:57:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:57:28 INFO - u'common': [u'target.common.tests.zip'], 06:57:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:57:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:57:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:57:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:57:28 INFO - u'mozbase': [u'target.common.tests.zip'], 06:57:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:57:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:57:28 INFO - u'web-platform': [u'target.common.tests.zip', 06:57:28 INFO - u'target.web-platform.tests.zip'], 06:57:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:57:28 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:57:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AdQ6ImFxRnyZb_jkjM3hHQ/artifacts/public/build/target.common.tests.zip 06:57:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AdQ6ImFxRnyZb_jkjM3hHQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:57:28 INFO - Fetch https://queue.taskcluster.net/v1/task/AdQ6ImFxRnyZb_jkjM3hHQ/artifacts/public/build/target.common.tests.zip into memory 06:57:29 INFO - Expected file size: 58125532 06:57:29 INFO - Obtained file size: 58125532 06:57:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:57:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AdQ6ImFxRnyZb_jkjM3hHQ/artifacts/public/build/target.common.tests.zip 06:57:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AdQ6ImFxRnyZb_jkjM3hHQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:57:39 INFO - Fetch https://queue.taskcluster.net/v1/task/AdQ6ImFxRnyZb_jkjM3hHQ/artifacts/public/build/target.common.tests.zip into memory 06:57:40 INFO - Expected file size: 58125532 06:57:40 INFO - Obtained file size: 58125532 06:57:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AdQ6ImFxRnyZb_jkjM3hHQ/artifacts/public/build/target.talos.tests.zip 06:57:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AdQ6ImFxRnyZb_jkjM3hHQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:57:51 INFO - Fetch https://queue.taskcluster.net/v1/task/AdQ6ImFxRnyZb_jkjM3hHQ/artifacts/public/build/target.talos.tests.zip into memory 06:57:52 INFO - Expected file size: 14404171 06:57:52 INFO - Obtained file size: 14404171 06:57:52 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')]} 06:57:52 INFO - trying https://queue.taskcluster.net/v1/task/AdQ6ImFxRnyZb_jkjM3hHQ/artifacts/public/build/target.tar.bz2 06:57:52 INFO - Downloading https://queue.taskcluster.net/v1/task/AdQ6ImFxRnyZb_jkjM3hHQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:57:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AdQ6ImFxRnyZb_jkjM3hHQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:57:53 INFO - Downloaded 62570998 bytes. 06:57:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AdQ6ImFxRnyZb_jkjM3hHQ/artifacts/public/build/target.tar.bz2 06:57:53 INFO - mkdir: /builds/slave/test/properties 06:57:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:57:53 INFO - Writing to file /builds/slave/test/properties/build_url 06:57:53 INFO - Contents: 06:57:53 INFO - build_url:https://queue.taskcluster.net/v1/task/AdQ6ImFxRnyZb_jkjM3hHQ/artifacts/public/build/target.tar.bz2 06:57:53 INFO - Running post-action listener: _resource_record_post_action 06:57:53 INFO - Running post-action listener: set_extra_try_arguments 06:57:53 INFO - [mozharness: 2017-03-23 13:57:53.627248Z] Finished download-and-extract step (success) 06:57:53 INFO - [mozharness: 2017-03-23 13:57:53.627344Z] Running populate-webroot step. 06:57:53 INFO - Running pre-action listener: _resource_record_pre_action 06:57:53 INFO - Running main action method: populate_webroot 06:57:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:57:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:57:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:57:53 INFO - '--tppagecycles', 06:57:53 INFO - '7'], 06:57:53 INFO - 'tests': ['tsvgm']}}, 06:57:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:57:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:57:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:57:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:57:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:57:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:57:53 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:57:53 INFO - 'talos_options': ['--disable-e10s'], 06:57:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:57:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:57:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:57:53 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:57:53 INFO - 'talos_options': ['--disable-e10s'], 06:57:53 INFO - 'tests': ['damp', 'tps']}, 06:57:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:57:53 INFO - 'tests': ['damp', 'tps']}, 06:57:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:57:53 INFO - 'tests': ['dromaeo_dom']}, 06:57:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:57:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:57:53 INFO - 'tests': ['basic_compositor_video']}, 06:57:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:57:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:57:53 INFO - 'tests': ['a11yr', 06:57:53 INFO - 'ts_paint', 06:57:53 INFO - 'tpaint', 06:57:53 INFO - 'sessionrestore', 06:57:53 INFO - 'sessionrestore_no_auto_restore', 06:57:53 INFO - 'tabpaint']}, 06:57:53 INFO - 'other-e10s': {'tests': ['a11yr', 06:57:53 INFO - 'ts_paint', 06:57:53 INFO - 'tpaint', 06:57:53 INFO - 'sessionrestore', 06:57:53 INFO - 'sessionrestore_no_auto_restore', 06:57:53 INFO - 'tabpaint']}, 06:57:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:57:53 INFO - 'ts_paint', 06:57:53 INFO - 'tpaint', 06:57:53 INFO - 'sessionrestore', 06:57:53 INFO - 'sessionrestore_no_auto_restore', 06:57:53 INFO - 'tabpaint']}, 06:57:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:57:53 INFO - 'ts_paint', 06:57:53 INFO - 'tpaint', 06:57:53 INFO - 'sessionrestore', 06:57:53 INFO - 'sessionrestore_no_auto_restore', 06:57:53 INFO - 'tabpaint']}, 06:57:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:57:53 INFO - 'tests': ['a11yr', 06:57:53 INFO - 'ts_paint', 06:57:53 INFO - 'tpaint', 06:57:53 INFO - 'sessionrestore', 06:57:53 INFO - 'sessionrestore_no_auto_restore', 06:57:53 INFO - 'tabpaint']}, 06:57:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:57:53 INFO - 'tests': ['a11yr', 06:57:53 INFO - 'ts_paint', 06:57:53 INFO - 'tpaint', 06:57:53 INFO - 'sessionrestore', 06:57:53 INFO - 'sessionrestore_no_auto_restore', 06:57:53 INFO - 'tabpaint']}, 06:57:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:57:53 INFO - 'tests': ['tsvgx', 06:57:53 INFO - 'tsvgr_opacity', 06:57:53 INFO - 'tart', 06:57:53 INFO - 'tscrollx', 06:57:53 INFO - 'cart', 06:57:53 INFO - 'tsvg_static']}, 06:57:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:57:53 INFO - 'tsvgr_opacity', 06:57:53 INFO - 'tart', 06:57:53 INFO - 'tscrollx', 06:57:53 INFO - 'cart', 06:57:53 INFO - 'tsvg_static']}, 06:57:53 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:57:53 INFO - 'talos_options': ['--disable-e10s'], 06:57:53 INFO - 'tests': ['tp5o']}, 06:57:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:57:53 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:57:53 INFO - 'talos_options': ['--disable-e10s', 06:57:53 INFO - '--xperf_path', 06:57:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:57:53 INFO - 'tests': ['tp5n']}, 06:57:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:57:53 INFO - 'talos_options': ['--xperf_path', 06:57:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:57:53 INFO - 'tests': ['tp5n']}}, 06:57:53 INFO - 'talos.zip': {'path': '', 06:57:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:57:53 INFO - Running post-action listener: _resource_record_post_action 06:57:53 INFO - [mozharness: 2017-03-23 13:57:53.640400Z] Finished populate-webroot step (success) 06:57:53 INFO - [mozharness: 2017-03-23 13:57:53.640490Z] Running create-virtualenv step. 06:57:53 INFO - Running pre-action listener: _resource_record_pre_action 06:57:53 INFO - Running main action method: create_virtualenv 06:57:53 INFO - Creating virtualenv /builds/slave/test/build/venv 06:57:53 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 06:57:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:57:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:57:53 INFO - Using real prefix '/usr' 06:57:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:57:54 INFO - Installing distribute.............................................................................................................................................................................................done. 06:57:56 INFO - Installing pip.................done. 06:57:56 INFO - Return code: 0 06:57:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:57:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:57:56 INFO - Reading from file tmpfile_stdout 06:57:56 INFO - Output received: 06:57:56 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) 06:57:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2867b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2865290>, '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 0x2865b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866040>, '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': '0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240', '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 06:57:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:57:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:57:56 INFO - Using env: {'DISPLAY': ':0', 06:57:56 INFO - 'HOME': '/home/cltbld', 06:57:56 INFO - 'LANG': 'en_US.UTF-8', 06:57:56 INFO - 'LANGUAGE': 'en_US:en', 06:57:56 INFO - 'LOGNAME': 'cltbld', 06:57:56 INFO - 'MAIL': '/var/mail/cltbld', 06:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:56 INFO - 'MOZ_NO_REMOTE': '1', 06:57:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:56 INFO - 'NO_EM_RESTART': '1', 06:57:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:56 INFO - 'PWD': '/builds/slave/test', 06:57:56 INFO - 'SHELL': '/bin/bash', 06:57:56 INFO - 'SHLVL': '1', 06:57:56 INFO - 'TERM': 'linux', 06:57:56 INFO - 'TMOUT': '86400', 06:57:56 INFO - 'USER': 'cltbld', 06:57:56 INFO - 'XDG_SESSION_COOKIE': '0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240', 06:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:56 INFO - '_': '/tools/buildbot/bin/python'} 06:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:56 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 06:57:56 INFO - Cleaning up... 06:57:56 INFO - Return code: 0 06:57:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2867b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2865290>, '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 0x2865b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866040>, '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': '0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240', '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 06:57:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:57:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:57:56 INFO - Using env: {'DISPLAY': ':0', 06:57:56 INFO - 'HOME': '/home/cltbld', 06:57:56 INFO - 'LANG': 'en_US.UTF-8', 06:57:56 INFO - 'LANGUAGE': 'en_US:en', 06:57:56 INFO - 'LOGNAME': 'cltbld', 06:57:56 INFO - 'MAIL': '/var/mail/cltbld', 06:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:56 INFO - 'MOZ_NO_REMOTE': '1', 06:57:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:56 INFO - 'NO_EM_RESTART': '1', 06:57:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:56 INFO - 'PWD': '/builds/slave/test', 06:57:56 INFO - 'SHELL': '/bin/bash', 06:57:56 INFO - 'SHLVL': '1', 06:57:56 INFO - 'TERM': 'linux', 06:57:56 INFO - 'TMOUT': '86400', 06:57:56 INFO - 'USER': 'cltbld', 06:57:56 INFO - 'XDG_SESSION_COOKIE': '0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240', 06:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:56 INFO - '_': '/tools/buildbot/bin/python'} 06:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:56 INFO - Downloading/unpacking psutil>=3.1.1 06:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:57:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:57:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:57:59 INFO - Installing collected packages: psutil 06:57:59 INFO - Running setup.py install for psutil 06:57:59 INFO - building 'psutil._psutil_linux' extension 06:57:59 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 06:57:59 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 06:57:59 INFO - building 'psutil._psutil_posix' extension 06:57:59 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 06:57:59 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 06:57:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:57:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:57:59 INFO - Successfully installed psutil 06:57:59 INFO - Cleaning up... 06:57:59 INFO - Return code: 0 06:57:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:59 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 0x25ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2867b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2865290>, '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 0x2865b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866040>, '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': '0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240', '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 06:57:59 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 06:57:59 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 06:57:59 INFO - Using env: {'DISPLAY': ':0', 06:57:59 INFO - 'HOME': '/home/cltbld', 06:57:59 INFO - 'LANG': 'en_US.UTF-8', 06:57:59 INFO - 'LANGUAGE': 'en_US:en', 06:57:59 INFO - 'LOGNAME': 'cltbld', 06:57:59 INFO - 'MAIL': '/var/mail/cltbld', 06:57:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:59 INFO - 'MOZ_NO_REMOTE': '1', 06:57:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:59 INFO - 'NO_EM_RESTART': '1', 06:57:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:59 INFO - 'PWD': '/builds/slave/test', 06:57:59 INFO - 'SHELL': '/bin/bash', 06:57:59 INFO - 'SHLVL': '1', 06:57:59 INFO - 'TERM': 'linux', 06:57:59 INFO - 'TMOUT': '86400', 06:57:59 INFO - 'USER': 'cltbld', 06:57:59 INFO - 'XDG_SESSION_COOKIE': '0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240', 06:57:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:59 INFO - '_': '/tools/buildbot/bin/python'} 06:57:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:57:59 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 06:57:59 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 06:57:59 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 06:57:59 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 06:57:59 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 06:57:59 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 06:58:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:58:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:58:01 INFO - Installing collected packages: mozsystemmonitor 06:58:01 INFO - Running setup.py install for mozsystemmonitor 06:58:02 INFO - Successfully installed mozsystemmonitor 06:58:02 INFO - Cleaning up... 06:58:02 INFO - Return code: 0 06:58:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:02 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 0x25ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2867b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2865290>, '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 0x2865b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866040>, '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': '0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240', '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 06:58:02 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 06:58:02 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 06:58:02 INFO - Using env: {'DISPLAY': ':0', 06:58:02 INFO - 'HOME': '/home/cltbld', 06:58:02 INFO - 'LANG': 'en_US.UTF-8', 06:58:02 INFO - 'LANGUAGE': 'en_US:en', 06:58:02 INFO - 'LOGNAME': 'cltbld', 06:58:02 INFO - 'MAIL': '/var/mail/cltbld', 06:58:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:02 INFO - 'MOZ_NO_REMOTE': '1', 06:58:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:02 INFO - 'NO_EM_RESTART': '1', 06:58:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:02 INFO - 'PWD': '/builds/slave/test', 06:58:02 INFO - 'SHELL': '/bin/bash', 06:58:02 INFO - 'SHLVL': '1', 06:58:02 INFO - 'TERM': 'linux', 06:58:02 INFO - 'TMOUT': '86400', 06:58:02 INFO - 'USER': 'cltbld', 06:58:02 INFO - 'XDG_SESSION_COOKIE': '0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240', 06:58:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:02 INFO - '_': '/tools/buildbot/bin/python'} 06:58:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:02 INFO - Downloading/unpacking jsonschema==2.5.1 06:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:58:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:04 INFO - Downloading functools32-3.2.3-2.tar.gz 06:58:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:58:04 INFO - warning: no files found matching '*.txt' 06:58:04 INFO - no previously-included directories found matching 'build' 06:58:04 INFO - no previously-included directories found matching 'dist' 06:58:04 INFO - no previously-included directories found matching '.git*' 06:58:04 INFO - Installing collected packages: jsonschema, functools32 06:58:04 INFO - Running setup.py install for functools32 06:58:04 INFO - warning: no files found matching '*.txt' 06:58:04 INFO - no previously-included directories found matching 'build' 06:58:04 INFO - no previously-included directories found matching 'dist' 06:58:04 INFO - no previously-included directories found matching '.git*' 06:58:04 INFO - Successfully installed jsonschema functools32 06:58:04 INFO - Cleaning up... 06:58:04 INFO - Return code: 0 06:58:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2867b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2865290>, '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 0x2865b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866040>, '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': '0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240', '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 06:58:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:58:04 INFO - Using env: {'DISPLAY': ':0', 06:58:04 INFO - 'HOME': '/home/cltbld', 06:58:04 INFO - 'LANG': 'en_US.UTF-8', 06:58:04 INFO - 'LANGUAGE': 'en_US:en', 06:58:04 INFO - 'LOGNAME': 'cltbld', 06:58:04 INFO - 'MAIL': '/var/mail/cltbld', 06:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:04 INFO - 'MOZ_NO_REMOTE': '1', 06:58:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:04 INFO - 'NO_EM_RESTART': '1', 06:58:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:04 INFO - 'PWD': '/builds/slave/test', 06:58:04 INFO - 'SHELL': '/bin/bash', 06:58:04 INFO - 'SHLVL': '1', 06:58:04 INFO - 'TERM': 'linux', 06:58:04 INFO - 'TMOUT': '86400', 06:58:04 INFO - 'USER': 'cltbld', 06:58:04 INFO - 'XDG_SESSION_COOKIE': '0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240', 06:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:04 INFO - '_': '/tools/buildbot/bin/python'} 06:58:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:58:05 INFO - Cleaning up... 06:58:05 INFO - Return code: 0 06:58:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:58: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')]} 06:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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')]} 06:58:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:05 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 0x25ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2867b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2865290>, '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 0x2865b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866040>, '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': '0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240', '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 06:58:05 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 06:58:05 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 06:58:05 INFO - Using env: {'DISPLAY': ':0', 06:58:05 INFO - 'HOME': '/home/cltbld', 06:58:05 INFO - 'LANG': 'en_US.UTF-8', 06:58:05 INFO - 'LANGUAGE': 'en_US:en', 06:58:05 INFO - 'LOGNAME': 'cltbld', 06:58:05 INFO - 'MAIL': '/var/mail/cltbld', 06:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:05 INFO - 'MOZ_NO_REMOTE': '1', 06:58:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:05 INFO - 'NO_EM_RESTART': '1', 06:58:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:05 INFO - 'PWD': '/builds/slave/test', 06:58:05 INFO - 'SHELL': '/bin/bash', 06:58:05 INFO - 'SHLVL': '1', 06:58:05 INFO - 'TERM': 'linux', 06:58:05 INFO - 'TMOUT': '86400', 06:58:05 INFO - 'USER': 'cltbld', 06:58:05 INFO - 'XDG_SESSION_COOKIE': '0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240', 06:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:05 INFO - '_': '/tools/buildbot/bin/python'} 06:58:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:05 INFO - Downloading/unpacking blobuploader==1.2.4 06:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:08 INFO - Downloading blobuploader-1.2.4.tar.gz 06:58:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:58:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:58:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:08 INFO - Downloading docopt-0.6.1.tar.gz 06:58:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:58:09 INFO - Installing collected packages: blobuploader, requests, docopt 06:58:09 INFO - Running setup.py install for blobuploader 06:58:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:58:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:58:09 INFO - Running setup.py install for requests 06:58:09 INFO - Running setup.py install for docopt 06:58:09 INFO - Successfully installed blobuploader requests docopt 06:58:09 INFO - Cleaning up... 06:58:09 INFO - Return code: 0 06:58:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58: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')]} 06:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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')]} 06:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:09 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 0x25ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2867b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2865290>, '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 0x2865b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866040>, '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': '0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240', '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 06:58:09 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 06:58:09 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 06:58:09 INFO - Using env: {'DISPLAY': ':0', 06:58:09 INFO - 'HOME': '/home/cltbld', 06:58:09 INFO - 'LANG': 'en_US.UTF-8', 06:58:09 INFO - 'LANGUAGE': 'en_US:en', 06:58:09 INFO - 'LOGNAME': 'cltbld', 06:58:09 INFO - 'MAIL': '/var/mail/cltbld', 06:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:09 INFO - 'MOZ_NO_REMOTE': '1', 06:58:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:09 INFO - 'NO_EM_RESTART': '1', 06:58:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:09 INFO - 'PWD': '/builds/slave/test', 06:58:09 INFO - 'SHELL': '/bin/bash', 06:58:09 INFO - 'SHLVL': '1', 06:58:09 INFO - 'TERM': 'linux', 06:58:09 INFO - 'TMOUT': '86400', 06:58:09 INFO - 'USER': 'cltbld', 06:58:09 INFO - 'XDG_SESSION_COOKIE': '0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240', 06:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:09 INFO - '_': '/tools/buildbot/bin/python'} 06:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:58:09 INFO - Running setup.py (path:/tmp/pip-fTuNyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:58:09 INFO - Running setup.py (path:/tmp/pip-idBmNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:58:10 INFO - Running setup.py (path:/tmp/pip-NCk0OC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:58:10 INFO - Running setup.py (path:/tmp/pip-11CkIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:58:10 INFO - Running setup.py (path:/tmp/pip-UHejYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:58:10 INFO - Running setup.py (path:/tmp/pip-iIOVC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:58:10 INFO - Running setup.py (path:/tmp/pip-b7Qoc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:58:10 INFO - Running setup.py (path:/tmp/pip-BJrtZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:58:10 INFO - Running setup.py (path:/tmp/pip-dRo41O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:58:10 INFO - Running setup.py (path:/tmp/pip-m1BLve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:58:10 INFO - Running setup.py (path:/tmp/pip-jt9RYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:58:10 INFO - Running setup.py (path:/tmp/pip-Dv2HPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:58:10 INFO - Running setup.py (path:/tmp/pip-JMfQp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:58:10 INFO - Running setup.py (path:/tmp/pip-dCvMOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:10 INFO - Running setup.py (path:/tmp/pip-0qQ1K7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:58:10 INFO - Running setup.py (path:/tmp/pip-xpYakv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:58:11 INFO - Running setup.py (path:/tmp/pip-4kiXfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:58:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:58:11 INFO - Running setup.py install for manifestparser 06:58:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:58:11 INFO - Running setup.py install for mozcrash 06:58:11 INFO - Running setup.py install for mozdebug 06:58:11 INFO - Running setup.py install for mozdevice 06:58:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:58:11 INFO - Running setup.py install for mozfile 06:58:11 INFO - Running setup.py install for mozhttpd 06:58:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:58:11 INFO - Running setup.py install for mozinfo 06:58:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:58:11 INFO - Running setup.py install for mozInstall 06:58:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:58:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:58:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:58:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:58:11 INFO - Running setup.py install for mozleak 06:58:11 INFO - Running setup.py install for mozlog 06:58:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:58:12 INFO - Running setup.py install for moznetwork 06:58:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:58:12 INFO - Running setup.py install for mozprocess 06:58:12 INFO - Running setup.py install for mozprofile 06:58:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:58:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:58:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:58:12 INFO - Running setup.py install for mozrunner 06:58:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:58:12 INFO - Running setup.py install for mozscreenshot 06:58:12 INFO - Running setup.py install for moztest 06:58:12 INFO - Running setup.py install for mozversion 06:58:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:58:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:58:12 INFO - Cleaning up... 06:58:12 INFO - Return code: 0 06:58:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:12 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 0x25ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2867b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2865290>, '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 0x2865b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866040>, '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': '0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240', '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 06:58:12 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 06:58:12 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 06:58:12 INFO - Using env: {'DISPLAY': ':0', 06:58:12 INFO - 'HOME': '/home/cltbld', 06:58:12 INFO - 'LANG': 'en_US.UTF-8', 06:58:12 INFO - 'LANGUAGE': 'en_US:en', 06:58:12 INFO - 'LOGNAME': 'cltbld', 06:58:12 INFO - 'MAIL': '/var/mail/cltbld', 06:58:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:12 INFO - 'MOZ_NO_REMOTE': '1', 06:58:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:12 INFO - 'NO_EM_RESTART': '1', 06:58:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:12 INFO - 'PWD': '/builds/slave/test', 06:58:12 INFO - 'SHELL': '/bin/bash', 06:58:12 INFO - 'SHLVL': '1', 06:58:12 INFO - 'TERM': 'linux', 06:58:12 INFO - 'TMOUT': '86400', 06:58:12 INFO - 'USER': 'cltbld', 06:58:12 INFO - 'XDG_SESSION_COOKIE': '0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240', 06:58:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:12 INFO - '_': '/tools/buildbot/bin/python'} 06:58:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:58:13 INFO - Running setup.py (path:/tmp/pip-tEHHXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:58:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:58:13 INFO - Running setup.py (path:/tmp/pip-VEOjk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:58:13 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)) 06:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:58:13 INFO - Running setup.py (path:/tmp/pip-_aTtW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:58:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:58:13 INFO - Running setup.py (path:/tmp/pip-CPvHP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:58:13 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)) 06:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:58:13 INFO - Running setup.py (path:/tmp/pip-jssQAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:58:13 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)) 06:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:58:13 INFO - Running setup.py (path:/tmp/pip-VFVYCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:58:13 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)) 06:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:58:13 INFO - Running setup.py (path:/tmp/pip-lmCVNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:58:13 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)) 06:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:58:13 INFO - Running setup.py (path:/tmp/pip-_S8vLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:58:13 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)) 06:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:58:13 INFO - Running setup.py (path:/tmp/pip-RNzmQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:58:13 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)) 06:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:58:13 INFO - Running setup.py (path:/tmp/pip-pMuTGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:58:13 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)) 06:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:58:13 INFO - Running setup.py (path:/tmp/pip-5AI5rm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:58:13 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)) 06:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:58:13 INFO - Running setup.py (path:/tmp/pip-RMMN6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:58:13 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)) 06:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:58:13 INFO - Running setup.py (path:/tmp/pip-VYrMrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:58:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:58:14 INFO - Running setup.py (path:/tmp/pip-lgsnYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:58:14 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)) 06:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:14 INFO - Running setup.py (path:/tmp/pip-XTKc8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:58:14 INFO - Running setup.py (path:/tmp/pip-bjztI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:58:14 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)) 06:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:58:14 INFO - Running setup.py (path:/tmp/pip-Cx3xR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:58:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:58:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:58:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:58:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:58:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:58:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:58:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:16 INFO - Downloading blessings-1.6.tar.gz 06:58:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:58:16 INFO - Installing collected packages: blessings 06:58:16 INFO - Running setup.py install for blessings 06:58:16 INFO - Successfully installed blessings 06:58:16 INFO - Cleaning up... 06:58:16 INFO - Return code: 0 06:58:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:58:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:58:16 INFO - Reading from file tmpfile_stdout 06:58:16 INFO - Current package versions: 06:58:16 INFO - argparse == 1.2.1 06:58:16 INFO - blessings == 1.6 06:58:16 INFO - blobuploader == 1.2.4 06:58:16 INFO - docopt == 0.6.1 06:58:16 INFO - functools32 == 3.2.3-2 06:58:16 INFO - jsonschema == 2.5.1 06:58:16 INFO - manifestparser == 1.1 06:58:16 INFO - mozInstall == 1.12 06:58:16 INFO - mozcrash == 1.0 06:58:16 INFO - mozdebug == 0.1 06:58:16 INFO - mozdevice == 0.49 06:58:16 INFO - mozfile == 1.2 06:58:16 INFO - mozhttpd == 0.7 06:58:16 INFO - mozinfo == 0.9 06:58:16 INFO - mozleak == 0.1 06:58:16 INFO - mozlog == 3.4 06:58:16 INFO - moznetwork == 0.27 06:58:16 INFO - mozprocess == 0.25 06:58:16 INFO - mozprofile == 0.28 06:58:16 INFO - mozrunner == 6.13 06:58:16 INFO - mozscreenshot == 0.1 06:58:16 INFO - mozsystemmonitor == 0.3 06:58:16 INFO - moztest == 0.8 06:58:16 INFO - mozversion == 1.4 06:58:16 INFO - psutil == 3.1.1 06:58:16 INFO - requests == 1.2.3 06:58:16 INFO - wsgiref == 0.1.2 06:58:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58:16 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')]} 06:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:16 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')]} 06:58:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:16 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 0x25ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2867b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2865290>, '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 0x2865b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866040>, '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': '0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240', '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 06:58:16 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 06:58:16 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 06:58:16 INFO - Using env: {'DISPLAY': ':0', 06:58:16 INFO - 'HOME': '/home/cltbld', 06:58:16 INFO - 'LANG': 'en_US.UTF-8', 06:58:16 INFO - 'LANGUAGE': 'en_US:en', 06:58:16 INFO - 'LOGNAME': 'cltbld', 06:58:16 INFO - 'MAIL': '/var/mail/cltbld', 06:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:16 INFO - 'MOZ_NO_REMOTE': '1', 06:58:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:16 INFO - 'NO_EM_RESTART': '1', 06:58:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:16 INFO - 'PWD': '/builds/slave/test', 06:58:16 INFO - 'SHELL': '/bin/bash', 06:58:16 INFO - 'SHLVL': '1', 06:58:16 INFO - 'TERM': 'linux', 06:58:16 INFO - 'TMOUT': '86400', 06:58:16 INFO - 'USER': 'cltbld', 06:58:16 INFO - 'XDG_SESSION_COOKIE': '0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240', 06:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:16 INFO - '_': '/tools/buildbot/bin/python'} 06:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:16 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)) 06:58:16 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)) 06:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:58:17 INFO - Cleaning up... 06:58:17 INFO - Return code: 0 06:58:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2867b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2865290>, '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 0x2865b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866040>, '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': '0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240', '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 06:58:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:58:17 INFO - Using env: {'DISPLAY': ':0', 06:58:17 INFO - 'HOME': '/home/cltbld', 06:58:17 INFO - 'LANG': 'en_US.UTF-8', 06:58:17 INFO - 'LANGUAGE': 'en_US:en', 06:58:17 INFO - 'LOGNAME': 'cltbld', 06:58:17 INFO - 'MAIL': '/var/mail/cltbld', 06:58:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:17 INFO - 'MOZ_NO_REMOTE': '1', 06:58:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:17 INFO - 'NO_EM_RESTART': '1', 06:58:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:17 INFO - 'PWD': '/builds/slave/test', 06:58:17 INFO - 'SHELL': '/bin/bash', 06:58:17 INFO - 'SHLVL': '1', 06:58:17 INFO - 'TERM': 'linux', 06:58:17 INFO - 'TMOUT': '86400', 06:58:17 INFO - 'USER': 'cltbld', 06:58:17 INFO - 'XDG_SESSION_COOKIE': '0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240', 06:58:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:17 INFO - '_': '/tools/buildbot/bin/python'} 06:58:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:58:17 INFO - Cleaning up... 06:58:17 INFO - Return code: 0 06:58:17 INFO - Running post-action listener: _resource_record_post_action 06:58:17 INFO - Running post-action listener: _start_resource_monitoring 06:58:17 INFO - Starting resource monitoring. 06:58:17 INFO - [mozharness: 2017-03-23 13:58:17.272999Z] Finished create-virtualenv step (success) 06:58:17 INFO - [mozharness: 2017-03-23 13:58:17.273590Z] Running install step. 06:58:17 INFO - Running pre-action listener: _resource_record_pre_action 06:58:17 INFO - Running main action method: install 06:58:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:58:17 INFO - Reading from file tmpfile_stdout 06:58:17 INFO - Detecting whether we're running mozinstall >=1.0... 06:58:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:58:17 INFO - Reading from file tmpfile_stdout 06:58:17 INFO - Output received: 06:58:17 INFO - Usage: mozinstall [options] installer 06:58:17 INFO - Options: 06:58:17 INFO - -h, --help show this help message and exit 06:58:17 INFO - -d DEST, --destination=DEST 06:58:17 INFO - Directory to install application into. [default: 06:58:17 INFO - "/builds/slave/test"] 06:58:17 INFO - --app=APP Application being installed. [default: firefox] 06:58:17 INFO - mkdir: /builds/slave/test/build/application 06:58:17 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'] 06:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:58:33 INFO - Reading from file tmpfile_stdout 06:58:33 INFO - Output received: 06:58:33 INFO - /builds/slave/test/build/application/firefox/firefox 06:58:33 INFO - Running post-action listener: _resource_record_post_action 06:58:33 INFO - [mozharness: 2017-03-23 13:58:33.212827Z] Finished install step (success) 06:58:33 INFO - [mozharness: 2017-03-23 13:58:33.213097Z] Running run-tests step. 06:58:33 INFO - Running pre-action listener: _resource_record_pre_action 06:58:33 INFO - Running main action method: run_tests 06:58:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:58:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:58:33 INFO - Python 2.7.3 06:58:33 INFO - Return code: 0 06:58:33 INFO - grabbing minidump binary from tooltool 06:58: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')]} 06:58:33 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 0x2865290>, '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 0x2865b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:58:33 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 06:58:33 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 06:58:33 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 06:58:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:58:33 INFO - Return code: 0 06:58:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:58:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:58:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:58:33 INFO - ENV: RUST_BACKTRACE is now 1 06:58:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:58:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:58:33 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/AdQ6ImFxRnyZb_jkjM3hHQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-073', '--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 06:58:33 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/AdQ6ImFxRnyZb_jkjM3hHQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-073 --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 06:58:33 INFO - Using env: {'DISPLAY': ':0', 06:58:33 INFO - 'HOME': '/home/cltbld', 06:58:33 INFO - 'LANG': 'en_US.UTF-8', 06:58:33 INFO - 'LANGUAGE': 'en_US:en', 06:58:33 INFO - 'LOGNAME': 'cltbld', 06:58:33 INFO - 'MAIL': '/var/mail/cltbld', 06:58:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:58:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:58:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:33 INFO - 'MOZ_NO_REMOTE': '1', 06:58:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:58:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:33 INFO - 'NO_EM_RESTART': '1', 06:58:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:33 INFO - 'PWD': '/builds/slave/test', 06:58:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:58:33 INFO - 'RUST_BACKTRACE': '1', 06:58:33 INFO - 'SHELL': '/bin/bash', 06:58:33 INFO - 'SHLVL': '1', 06:58:33 INFO - 'TERM': 'linux', 06:58:33 INFO - 'TMOUT': '86400', 06:58:33 INFO - 'USER': 'cltbld', 06:58:33 INFO - 'XDG_SESSION_COOKIE': '0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240', 06:58:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:33 INFO - '_': '/tools/buildbot/bin/python'} 06:58:33 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/AdQ6ImFxRnyZb_jkjM3hHQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-073', '--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 06:58:33 INFO - mozversion application_buildid: 20170323132834 06:58:33 INFO - mozversion application_changeset: fcfdeb52c2b2f020631fd47b5b02ea0be50d4027 06:58:33 INFO - mozversion application_display_name: Nightly 06:58:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:58:33 INFO - mozversion application_name: Firefox 06:58:33 INFO - mozversion application_remotingname: firefox 06:58:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:58:33 INFO - mozversion application_vendor: Mozilla 06:58:33 INFO - mozversion application_version: 55.0a1 06:58:33 INFO - mozversion platform_buildid: 20170323132834 06:58:33 INFO - mozversion platform_changeset: fcfdeb52c2b2f020631fd47b5b02ea0be50d4027 06:58:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:58:33 INFO - mozversion platform_version: 55.0a1 06:58:33 INFO - using testdate: 1490277513 06:58:33 INFO - actual date: 1490277513 06:58:33 INFO - starting webserver on 'localhost:48266' 06:58:33 INFO - SUITE-START | Running 2 tests 06:58:33 INFO - TEST-START | dromaeo_css 06:58:33 INFO - operating with platform_type : linux_ 06:58:33 INFO - Initialising browser for dromaeo_css test... 06:58:33 INFO - TEST-INFO | started process 15677 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpggvnO2/profile http://localhost:48266/getInfo.html) 06:58:38 INFO - PID 15677 | __metrics Screen width/height:1600/1200 06:58:38 INFO - PID 15677 | colorDepth:24 06:58:38 INFO - PID 15677 | Browser inner width/height: 1024/697 06:58:38 INFO - PID 15677 | __metrics 06:58:39 ERROR - PID 15677 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3388: TypeError: this.tabs is undefined 06:58:40 INFO - TEST-INFO | 15677: exit 0 06:58:40 INFO - Browser initialized. 06:58:40 INFO - Running cycle 1/1 for dromaeo_css test... 06:58:40 INFO - TEST-INFO | started process 15807 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpggvnO2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:58:52 INFO - PID 15807 | RSS: Main: 155238400 06:58:52 INFO - PID 15807 | 07:01:57 INFO - PID 15807 | Cycle 1(1): loaded http://localhost:48266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48266/tests/dromaeo/cssquery-ext.html) 07:01:59 INFO - PID 15807 | RSS: Main: 166408192 07:01:59 INFO - PID 15807 | 07:03:41 INFO - PID 15807 | ************************* 07:03:41 INFO - PID 15807 | A coding exception was thrown and uncaught in a Task. 07:03:41 INFO - PID 15807 | 07:03:41 ERROR - PID 15807 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:03:41 INFO - PID 15807 | Full stack: 07:03:41 INFO - PID 15807 | ************************* 07:05:01 INFO - PID 15807 | Cycle 1(1): loaded http://localhost:48266/tests/dromaeo/cssquery-ext.html (next: http://localhost:48266/tests/dromaeo/cssquery-jquery.html) 07:05:02 INFO - PID 15807 | RSS: Main: 160161792 07:05:02 INFO - PID 15807 | 07:08:04 INFO - PID 15807 | Cycle 1(1): loaded http://localhost:48266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48266/tests/dromaeo/cssquery-mootools.html) 07:08:04 INFO - PID 15807 | RSS: Main: 168562688 07:08:04 INFO - PID 15807 | 07:11:06 INFO - PID 15807 | Cycle 1(1): loaded http://localhost:48266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48266/tests/dromaeo/cssquery-prototype.html) 07:11:07 INFO - PID 15807 | RSS: Main: 160251904 07:11:07 INFO - PID 15807 | 07:14:10 INFO - PID 15807 | Cycle 1(1): loaded http://localhost:48266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48266/tests/dromaeo/cssquery-yui.html) 07:14:10 INFO - PID 15807 | RSS: Main: 167841792 07:14:10 INFO - PID 15807 | 07:17:14 INFO - PID 15807 | Cycle 1(1): loaded http://localhost:48266/tests/dromaeo/cssquery-yui.html (next: http://localhost:48266/tests/dromaeo/cssquery-dojo.html) 07:17:14 INFO - PID 15807 | RSS: Main: 161574912 07:17:14 INFO - PID 15807 | 07:17:14 INFO - PID 15807 | __start_tp_report 07:17:14 INFO - PID 15807 | _x_x_mozilla_page_load 07:17:14 INFO - PID 15807 | _x_x_mozilla_page_load_details 07:17:14 INFO - PID 15807 | |i|pagename|runs| 07:17:14 INFO - PID 15807 | |0;dojo.html;2685.624012638231;2701.2166471723203;2711.579705145702;2736.247531928718;2743.698193198748;5016.698998060119;5175.30133431987;5214.967556308162;5235.607329450297;5259.947400525998;5143.922841157376;5156.097682905495;5191.688498690081;5233.450487698794;5273.024490469256;4682.648801339896;4706.5293470653005;4728.716277023373;4736.692115012514;4762.404699412574;4730.574248317651;4733.83431579893;4775.164346239411;4788.497207793183;4812.278158276252;4687.5781179693995;4689.7655117244;4696.365990591261;4725.31482934976;4732.739699316537;4699.107169637758;4705.270683044134;4710.246360582325;4738.47876733559;4752.5247475252545;4614.838480653161;4663.790129444184;4666.766661666903;4675.298705194214;4721.6458765592715;5006.874828129289;5033.395992480889;5114.820981265675;5135.075686376451;5204.115300398941;5579.107342825169;5597.580181486364;5603.719814009283;5624.3531993820825;5652.802151924663;5607.046802043662;5611.186377975211;5614.9157762633595;5622.297212848394;5623.8594035149035;5028.446870844277;5060.822871199491;5079.339685840817;5199.766010529535;5256.737163141827;5520.53075488588;5539.224508568723;5586.050371436865;5590.91613625796;5593.412691667398;5373.408925018245;5397.325334333208;5449.373322067933;5459.344878614592;5476.698781567052;5512.641678290898;5533.059379905426;5539.639923404966;5584.692841893735;5586.581006424453;5509.201165831012;5511.58663100269;5522.199281104297;5535;5591.245181900473;5293.947060529423;5338.412774594792;5493.23094766733;5522.861928451821;5549.361823390281;4640.930386044212;4645.74448405341;4646.907061858744;4665.626749860071;4668.719876807402;3966.3852102924093;3971.126352202569;3993.4808474898077;4005.339119045325;4031.9193616127513;4677.602403795716;4740.6444516660695;4813.855584332476;4845.9030819383415;4874.390701162355;5582.665040097607;5593.188987596775;5600.243967064475;5604.6917419542315;5645.548356131581;4785.665003449794;4824.252240902666;4826.348442960226;4826.61387089032;4868.683535570177;4830.3479030331155;4834.709917404896;4883.584895283941;4944.134776414113;4944.826931057396;5079.060373830853;5125.743712814419;5129.358830146231;5131.640785145004;5132.384113906355;5484.61607687474;5491.341039075177;5493.038718224375;5495.230667706604;5495.862603434786;5113.130767769414;5117.309163262912;5124.359455068116;5128.230765385222;5129.615278854176;5432.076546986943;5479.753411096431;5487.122060470306;5523.834284971457;5537.640053396516;5530.474604912527;5587.329520457409;5609.775608975759;5615.494605485526;5619.129034999582;5426.593005524523;5429.321334833146;5437.945620543744;5443.401225865073;5497.3952865184;5257.737113144404;5271.8682032947945;5292;5311.973440132774;5421.83734487966;5207.140821764367;5313.654612450178;5314.043472175045;5314.62797604164;5321.228421878728;5422.15956526739;5443.673379597237;5463.562914966873;5473.726313684379;5520.171974203901;5167.844964651066;5177.0940085485645;5224.817131400383;5268.736563171749;5268.76290566933 07:17:14 INFO - PID 15807 | |1;ext.html;607.1984979826627;659.2715049869894;684.0013580172947;1086.608820824503;1098.1105304703185;29130.81518886084;30050.699493005064;30077.849610751917;30119.698803011965;30126.246843828914;28837.279068023257;29019.709802901965;29173;29248.853755731245;29282;7017.438604911607;7146.821329466753;7188.9281107189045;7232.1683006454405;7238.312360325761;7205.927940720604;7312.1225452945455;7315.707371705125;7325.816854578651;7332.670029848643;7296.562206267615;7311.086114235721;7347.559146451204;7356.705731770723;7375.778726638209;7303.926960730404;7307.561546307212;7329.890051649176;7332.8900066499045;7371.705131794722;7126.144862616467;7177.641117944134;7189;7194.13670359555;7200.135983681992;30964.535531967038;31106.377872442423;31269.68730312713;31399.84300078485;31430.214244643837;2558.808089393303;2595.9870200649066;2607.3090630982806;2629.4609605030923;2641.749033841782;21903.780962190493;21906.89046554773;21987.670184947237;22767.43081422961;22787.31638050861;2867.5411934090444;2938.911832645024;2943.6467623885055;2960.6151200343816;2970.6138202033812;111567;114648;131931;133476;160354;37349.253014939546;38006.809965950546;38040.23919521594;38197.42703859444;38235.61764382321;46088.769556152;46608.97041692279;46638.76680616575;46705.5329446708;46707.766461168154;13044.608661740163;13171.67070823237;13174.802377964339;13195.934020330029;13211.207327560378;10656.62701805433;10685.946570267099;10711.73220669474;10752.784944301071;10812.67561973142;13372.933135334455;13373.331333433289;13494.190348579117;13511.729765404834;13656.93171534136;5717.22817419643;5788.218590490314;5806.912896306559;5860.736266868002;5914.970425147847;849.7195925344621;865.2558799432483;887.1882227761525;893.1782759860944;908.6274627402734;21798;22266.75860563621;23449.17927872516;23456;23505;971.1502435369052;975.9264808710503;981.293468702533;1000.6047611193537;1000.9749756256152;11329.206955513035;11779.941100294443;11784.823227651592;11785;11795.882041179479;226843;228302;228779;229492;229509;42949.35575966363;43241.78379108147;43282;43317.99999999937;43336.78331608385;1182.4365626207295;1215.398377802993;1217.0385395537426;1225.240350982379;1230.7784598772307;20332;20361;21563;21739.782602174408;21769.00665164082;31673.8416307917;31922.680773191973;31955.68044319527;31961.520577190895;31974.68025319717;241059;241546;241577;242724;242851;28112.859435703507;28119;28966.85516572488;29024;29859.402811944074;33012.339753205284;33150;33319.50020749739;33337;34010.14974625555;25353.239402817944;25857;26277.4744505105;26321.473570528866;27096.1871143866;27922.16233512998;27952.44095118127;28140.43719125647;28164.295892602848;29204.123876283746;30599.388012240077;31630.525542117346;31790.52314215335;31831.204219894687;31876.840615796773;27636.14720761813;27901.860490697418;28067.859660701564;28180.295492612848;28366.14901552957;20884.582308353445;22224.77763723011;22578.774212257667;22586.66120008234;22600.773992260525 07:17:14 INFO - PID 15807 | |2;jquery.html;406.36201164172223;410.68787721331796;419.8320671731307;423.6907057847771;439.8064851465355;11570.53717851287;16040.83959160408;16290.674186516277;16874.240659170337;16899.746503802453;16014.279357428915;16053.598660033476;16299.674006519863;17722.113894305297;17929.64140717185;5554.333479982408;5565.9443405565835;5608.214849921014;5751.309842818868;5755.107958266454;5562.137868630349;5630.211770352154;5653.095504719246;5660.830175094754;5665.971670141644;5602.187682785993;5607.7476513556985;5608.747606357723;5654.321481422215;5657.066584013633;5444.96545656326;5610.803621873235;5613.775448982035;5617.157426386034;5622.887542249132;4895.559399654048;5006.499350065001;5042.092423363793;5085.211792172182;5100.719460429675;21334.359969200792;21482.35552933399;21534.246301379535;21806.78193218079;21828.45428864275;1441.819772528434;1478.8521147885233;1485.5023567105034;1488.672492051747;1523.7104950059454;13986.580402587939;14060;14105.2242126683;14208.715825683532;14694.412223511046;1509.1397903195073;1576.6294920693629;1587.904725716449;1596.106180538902;1609.7343938250174;75421;75663.24336756617;76379.99999999945;77200.27997200347;77495.61252193703;10902.291351062155;11021.779564408667;11188.552457901755;11275.154363422776;11401.48693308803;13039.413226404835;15693.293801778947;15702.528924132293;15752.212389380486;15760.68478630421;6702.36327548882;7078.590680808994;7109.1824440189;7364.594947277844;7418.591977441185;6740.561863478858;6746.460283177334;6947.7220911162985;6950.6177160256675;6956.5478243914995;6719.260881303053;6811.182658080963;6816.556923799937;6949.548279361826;7045.92954070463;1967.3802752133033;2029.5839352932614;2033.8474614403979;2050.92821751238;2060.2994981706292;836.2891542189091;860.6901515454431;861.2033868671454;867.7287773411982;880.8942926848691;16436.260368283456;16646.08446535428;17331.393401230896;17480.47558573245;17822.287108515775;885.9059062058353;915.2449229385784;915.4690279637794;918.8483900156399;921.2675922641516;8710;9454;9515.952420237854;9521.28590355726;9556.808863822685;433038;440078;440119;449267;452502;92174;92496;92520;94192.52903735437;95044.52477737567;1047.6280920273346;1063.3407287481812;1098.6813823991113;1105.4583254205543;1106.2753896198003;15861.682766344838;17588.91205543964;17819;17978.5505362367;18018.567493388226;41690.79154604208;41877.371839423045;42120.3681944765;42807.785961069996;43696.56303436925;38262.10219021542;44748;49822;53246;56640;7925.841483170419;8201.507909525448;8206.507609543447;8378.748637540884;8670.393072484865;12958.676033099247;12997.805032924325;13010.869891300967;13244.404001820134;13291.401886915306;11054.889451105386;11204.775904482029;11220.270682405617;11271.49278282463;11674.241174323643;10270.33242839213;10331.431771252654;10450.843237351597;10456.68629941103;10548.525316360628;11324.490397931948;11491.597794077166;11500.712482188012;11746.530138794353;11955.820662689892;7846.293833555007;7873.133955264801;8066.7579972600915;8186.345092392713;8195.344372450309;9767.21862251004;9835.459049752046;10008.599656013677;10203.081722644998;10995.120390368911 07:17:14 INFO - PID 15807 | |3;mootools.html;1250.9061820363472;1306.9085164038522;1309.7576948264573;1321.881030707236;1330.0689517337862;9318.580663870125;9653.613855445774;9671.564779584918;9847.507624618776;10164.08523232909;9949.602015919372;10083.747906302346;10085.142762865147;10119.494025298742;10131.392116472998;2193.024104273603;2227.532218234173;2228.9331320060423;2235.854669446489;2237.2281562860785;2087.342487116561;2153.4616345913523;2164.935051948436;2196.53872686736;2199.417154454071;2126.5959467701086;2168.5988092202915;2185.311626837549;2186.5736181444627;2193.451637090727;2092.98953505233;2104.5790841831617;2105.1158513424243;2106.1259577275414;2106.494441334084;1790.973135402957;1862.608852141052;1991.3528103366464;2040.438879308202;2041.7549894012666;9680.322377433582;9908.405495670211;9998.700038998843;10003.399796012263;10011.048950349705;5190.429052804188;5349.063913815066;5381.730913454312;5406.16204488301;5409.513143817076;3226.451503244454;3233.4018206631613;3253.2029652734996;3312.0726196664973;3375.206826395795;1020.9591616335338;1036.3574583758043;1064.7072055184885;1066.72798436399;1085.3216739537788;14571.489997850025;14615.561533153916;14684.48604298855;14688.926555367154;14736.115833049944;4459.7547134907245;4749.3588365570895;4815.253635686474;4848.781804818792;4898.118338698997;10812.567497300177;10818.29681070728;10840.72898177536;10841.566337346576;10882.455877206266;5239.449857764956;5273.945210957824;5282.920756188661;5287.41838397776;5293.391260005072;4700.694454860423;4856.150173719656;4863.562279394871;4921.990991846663;4931.408231012301;3532.434810430319;3636.072801435617;3645.3802853514435;3665.9185540265685;3680.227152297994;1094.7755710079414;1110.5280255891214;1110.7556337605713;1134.8638163420442;1138.0895283773114;600.8703637162195;613.4601550635501;617.3363634093367;630.331848240857;635.0474288567149;5052.267421223902;5100.336956195671;5104.923426148611;5113.718745469035;5303.602229832778;538.4857461124695;540.3947578711868;551.9254900588369;552.7070652554153;553.8283132228942;3993.341098718679;4036.737612055207;4049.4735684360844;4068.3287257602756;4097.467329247179;12541.686457838627;12855.614331569881;12879.29163895976;12959.416826242841;12964.675883102998;12093.093018023508;12785.296808675426;12801.551945682042;12811.743765124646;12830.486780528861;9058.456492610465;9224.631014759334;9290.256779457763;9293.953530232306;9294.814103718023;5736.196932429547;5872.735726892385;5938.7135107720605;6014.939850601613;6080.969595151996;11669.708257293296;11926.940365298118;11998.220115692453;12156.939215303866;12190.329531875832;11801.40992950332;12209.69475763113;12293.87706122963;12365.876341236473;12392.211752355648;7688.538687678757;7938.682452701827;7956.482828616122;7961.164077771982;7961.72133975308;9035.322350823582;9065.093490650883;9089.136532029446;9118.589663465293;9203.493807840632;8138;8170.795730106557;8248.83502329962;8292.33661307106;8439.493630382196;7804.141544429995;7881.251281128284;7908.248716371935;8039.718609848627;8113.269805717514;7008.4042856355745;7207.171175314906;7215.67529461186;7219;7229;4839.2983017462975;4985.52637499437;5073.188289873602;5080.187170052774;5104.387473503203;4786.593139583035;4910.631702622389;4936.160852654985;4938.38270216223;5004.949950500594 07:17:14 INFO - PID 15807 | |4;prototype.html;376.8436099018907;389.239037681333;393.96848252139824;395.86540576204084;397.24523405529493;5383;5539.393575863005;5628.493435590796;5656.236408084912;5679.488846003859;5337.279467271917;5462;5522.889542209164;5531.2532808071;5547.833564993057;4394.187075391047;4397.141857792444;4403.977980110095;4406.700023493077;4409.250427427345;4314.762688052156;4321.395004699345;4333.458317710286;4404.559544045585;4422.137683151786;4327.394164816928;4346.391505189276;4347.3696314034605;4348.173846969065;4365.36702178184;4332.696711230215;4369.43197384338;4372.038151606642;4375;4390.714603550759;3837.270918525499;3956.7032472564383;3969.563348031714;3969.563348031714;3974.205158968189;5352.812651557177;5364.704941228231;5403.324584426947;5404.6486978346675;5434.91847622286;5077.923831142536;5093.821716239951;5096.369161868203;5101.489851014906;5119.6160287978555;5700.2589663343915;5814.5057670098095;5869.325027621835;5877.000909845294;5877.9412205877825;4328;4342.609165175149;4347.891302717426;4351.412559304516;4355.760433176174;5912.645241285493;6011.188489553898;6075.392460753934;6145.354737752561;6155.952803362319;4430.955690443118;4436.800343984529;4437.622802061861;4441.733495990251;4445.488768791565;4450.243458611979;4483.461984561874;4485.439320084989;4487.685861989695;4509.346144808985;4563.201439748031;4811.254255590389;4828.637852161031;5016.19740841471;5057.544820966057;5793.913091303634;5815.389384114607;5826.82519524415;5833;5835.883282334329;1440.897713249365;1451.7459444597152;1460.0947412604253;1467.097734893033;1471.5144002479155;970.5001924009141;978.2418625565101;982.2583949118513;984.6307634637011;995.5221493682928;5063.873403164876;5100.540951314325;5118.38579370478;5126.102931986888;5148.047611191867;6031.819045428644;6043.909341359883;6058.697065146725;6067.666278354644;6089.695515224221;4844.394450693663;5054.368203974504;5109.3613298337705;5109.489051094861;5165.509276618715;3186.9362612747614;3200.447782825328;3204.926349672839;3218.7907785993834;3218.9839050805062;5454.636141453376;5612.186232996274;5621.747021384048;5623.943760562423;5670.943290567124;6150.661713605705;6199.938000620026;6224.9377506224355;6226.719797609118;6253.155823963798;5610.551155907518;5615.298087739033;5617.775288988395;5622.004188513019;5642.153676948491;5635.577331700221;6018.157457955802;6039.48664363534;6042.244719410074;6051.031834906394;5703.401142879938;5988.311344195473;6002.489788368038;6022.36765139654;6032.788852390146;5472.781088756565;5493.450654934474;5598.552115830642;5633.802816901389;5634.492895639412;4120.7733574653685;4136.751794892196;4163;4163.188178305322;4164.583541645932;5993.220881285405;6005.39946005396;6028.156058151774;6112.663803490673;6132.448079672851;5829.125631155361;5860.765569377178;5883.646981181143;5891.734871930687;5900.203472531153;5842.795502157404;5856.267966504187;5858.47273745365;5883.2057672215415;5897.734601943009;5554.194641776839;5744.253247077853;5752.13717942312;5776.393478684678;5796.246487956707;5874.471297583067;5917.881642367042;5919.319278283053;5920.79277225295;5946.821595352147;5478.479544443271;5714.885702285847;5742.3347229303035;5756.597038207286;5777.162311464898 07:17:14 INFO - PID 15807 | |5;yui.html;602.7769725201676;635.177445208455;684.0764967294153;695.0755495191395;727.15286691005;11319.094472442206;11784.7643047139;12398.380080995938;12407.751844963106;12452;11902.7619447611;12297.446614902328;12360.690982725437;12421;12430.316332601704;806.2058872011064;819.9098099209082;832.1221111727156;832.5753865528594;833.4166083741375;797.960101994898;827.0819390476566;827.3960009193293;828.1180542722012;830.219593582034;878.9868151977726;885.9822803543925;886.007671408024;887.5961437545933;888.1828717579842;868.431177578687;870.851955167623;876.0538618292229;876.5792419638609;877.4209022045419;638.1735652330198;645.8288553533317;645.8385403649088;648.0344287012317;650.7559665125578;12862.421191046426;12993.935030324788;13225.470981160743;13371.26458044807;13381.330933453386;12916.41876115577;13033.674158146123;13062.804057939138;13303.800442993363;13596.456141754317;9126.178643922012;9372.484513351763;9440.433573985583;9559.283053770925;9568.712938611852;2449.2529778417575;2472.1471092473066;2502.7121880983555;2507.962380564293;2583.3929026678716;47985.04029919417;48889.26666100011;49667.50332496665;50251.24623130656;50991;9908.900910990942;10054.64808731691;10127.59489620407;10198.847017294747;10211.869459792515;19154.233830646896;19158.71261931072;19381.806181938282;19455.805441945682;19679.803201967796;6397.968010160012;6546.345365463416;6568.408843204134;6573.737050517926;6790.287019862942;3346.6486018968144;3401.9149521262166;3419.6238413774463;3461.3769521486374;3533.8586456541966;3434.3303055903857;3458.239187378773;3463.9307213856086;3470.201853573692;3517.1558825882116;644.7421031587309;648.740503798475;649.7238673563717;665.0987911380107;670.4334837062675;501.2456253338702;524.6327570700448;525.4062908912904;530.1808705549935;537.6397318732234;8144.633491492897;8402.789930251793;8497.957510212533;8543.829123417498;8734.620227437177;491.6582974832457;495.09891996565904;496.6275293529853;503.8866255092575;505.9215821547666;3783.0920579060826;3840.251151025579;3863.2466668999277;3921.862734804325;4093.3655283431117;62745;63575;63625.363746361945;64810.35189648043;64984;42287.78856105761;45447.77276113664;45636;52779;54496.72751636296;39532.604673953465;40952.1809563813;42445.57554424416;42619.57380426156;43228;9089.227415669478;9621.326507144433;9630.229581633312;9677.225821934087;9697.709068727949;24621.876890615433;25023.749762502142;25172.874135629936;25426.491470170862;25949.35126621774;31267.84366078246;31281.8435907819;31421;31756.523652145697;31812.5228121583;11853.111016673956;11856.22934509254;11921.34432606215;11924.523019079139;12001;11980.820287695517;12252.816207757069;12424.34692215058;12512.434950835239;13082.672933176747;11098.889011109786;11410.372429516456;12052.337121458404;12252.693682658004;13098.2141071536;11562.595309164139;11824.172307938361;11972.32796922671;12115.697107572381;12742;11184;11415.258008229439;11443.427828608703;11711.590094346657;11718.945294923156;8387.203215694499;8436.704715334934;8685.696000639948;8723.607437665194;8854.690085846965;9440.622375104918;9474.478903660365;9541.809163816546;9569.904300956901;9623.56693948788 07:17:14 INFO - PID 15807 | __end_tp_report 07:17:14 INFO - PID 15807 | __start_cc_report 07:17:14 INFO - PID 15807 | _x_x_mozilla_cycle_collect,378 07:17:14 INFO - PID 15807 | __end_cc_report 07:17:14 INFO - PID 15807 | __startTimestamp1490278634290__endTimestamp 07:17:14 INFO - PID 15807 | 07:17:14 INFO - PID 15807 | ------- Summary: start ------- 07:17:14 INFO - PID 15807 | Number of tests: 6 07:17:14 INFO - PID 15807 | 07:17:14 INFO - PID 15807 | [#0] dojo.html Cycles:165 Average:5090.01 Median:5214.97 stddev:570.00 (10.9%) stddev-sans-first:539.64 07:17:14 INFO - PID 15807 | Values: 2685.6 2701.2 2711.6 2736.2 2743.7 5016.7 5175.3 5215.0 5235.6 5259.9 5143.9 5156.1 5191.7 5233.5 5273.0 4682.6 4706.5 4728.7 4736.7 4762.4 4730.6 4733.8 4775.2 4788.5 4812.3 4687.6 4689.8 4696.4 4725.3 4732.7 4699.1 4705.3 4710.2 4738.5 4752.5 4614.8 4663.8 4666.8 4675.3 4721.6 5006.9 5033.4 5114.8 5135.1 5204.1 5579.1 5597.6 5603.7 5624.4 5652.8 5607.0 5611.2 5614.9 5622.3 5623.9 5028.4 5060.8 5079.3 5199.8 5256.7 5520.5 5539.2 5586.1 5590.9 5593.4 5373.4 5397.3 5449.4 5459.3 5476.7 5512.6 5533.1 5539.6 5584.7 5586.6 5509.2 5511.6 5522.2 5535.0 5591.2 5293.9 5338.4 5493.2 5522.9 5549.4 4640.9 4645.7 4646.9 4665.6 4668.7 3966.4 3971.1 3993.5 4005.3 4031.9 4677.6 4740.6 4813.9 4845.9 4874.4 5582.7 5593.2 5600.2 5604.7 5645.5 4785.7 4824.3 4826.3 4826.6 4868.7 4830.3 4834.7 4883.6 4944.1 4944.8 5079.1 5125.7 5129.4 5131.6 5132.4 5484.6 5491.3 5493.0 5495.2 5495.9 5113.1 5117.3 5124.4 5128.2 5129.6 5432.1 5479.8 5487.1 5523.8 5537.6 5530.5 5587.3 5609.8 5615.5 5619.1 5426.6 5429.3 5437.9 5443.4 5497.4 5257.7 5271.9 5292.0 5312.0 5421.8 5207.1 5313.7 5314.0 5314.6 5321.2 5422.2 5443.7 5463.6 5473.7 5520.2 5167.8 5177.1 5224.8 5268.7 5268.8 07:17:14 INFO - PID 15807 | 07:17:14 INFO - PID 15807 | [#1] ext.html Cycles:180 Average:33782.34 Median:29151.91 stddev:53981.36 (185.2%) stddev-sans-first:54075.32 07:17:14 INFO - PID 15807 | Values: 607.2 659.3 684.0 1086.6 1098.1 29130.8 30050.7 30077.8 30119.7 30126.2 28837.3 29019.7 29173.0 29248.9 29282.0 7017.4 7146.8 7188.9 7232.2 7238.3 7205.9 7312.1 7315.7 7325.8 7332.7 7296.6 7311.1 7347.6 7356.7 7375.8 7303.9 7307.6 7329.9 7332.9 7371.7 7126.1 7177.6 7189.0 7194.1 7200.1 30964.5 31106.4 31269.7 31399.8 31430.2 2558.8 2596.0 2607.3 2629.5 2641.7 21903.8 21906.9 21987.7 22767.4 22787.3 2867.5 2938.9 2943.6 2960.6 2970.6 111567.0 114648.0 131931.0 133476.0 160354.0 37349.3 38006.8 38040.2 38197.4 38235.6 46088.8 46609.0 46638.8 46705.5 46707.8 13044.6 13171.7 13174.8 13195.9 13211.2 10656.6 10685.9 10711.7 10752.8 10812.7 13372.9 13373.3 13494.2 13511.7 13656.9 5717.2 5788.2 5806.9 5860.7 5915.0 849.7 865.3 887.2 893.2 908.6 21798.0 22266.8 23449.2 23456.0 23505.0 971.2 975.9 981.3 1000.6 1001.0 11329.2 11779.9 11784.8 11785.0 11795.9 226843.0 228302.0 228779.0 229492.0 229509.0 42949.4 43241.8 43282.0 43318.0 43336.8 1182.4 1215.4 1217.0 1225.2 1230.8 20332.0 20361.0 21563.0 21739.8 21769.0 31673.8 31922.7 31955.7 31961.5 31974.7 241059.0 241546.0 241577.0 242724.0 242851.0 28112.9 28119.0 28966.9 29024.0 29859.4 33012.3 33150.0 33319.5 33337.0 34010.1 25353.2 25857.0 26277.5 26321.5 27096.2 27922.2 27952.4 28140.4 28164.3 29204.1 30599.4 31630.5 31790.5 31831.2 31876.8 27636.1 27901.9 28067.9 28180.3 28366.1 20884.6 22224.8 22578.8 22586.7 22600.8 07:17:14 INFO - PID 15807 | 07:17:14 INFO - PID 15807 | [#2] jquery.html Cycles:180 Average:26993.57 Median:21615.74 stddev:73260.29 (338.9%) stddev-sans-first:73438.61 07:17:14 INFO - PID 15807 | Values: 406.4 410.7 419.8 423.7 439.8 11570.5 16040.8 16290.7 16874.2 16899.7 16014.3 16053.6 16299.7 17722.1 17929.6 5554.3 5565.9 5608.2 5751.3 5755.1 5562.1 5630.2 5653.1 5660.8 5666.0 5602.2 5607.7 5608.7 5654.3 5657.1 5445.0 5610.8 5613.8 5617.2 5622.9 4895.6 5006.5 5042.1 5085.2 5100.7 21334.4 21482.4 21534.2 21806.8 21828.5 1441.8 1478.9 1485.5 1488.7 1523.7 13986.6 14060.0 14105.2 14208.7 14694.4 1509.1 1576.6 1587.9 1596.1 1609.7 75421.0 75663.2 76380.0 77200.3 77495.6 10902.3 11021.8 11188.6 11275.2 11401.5 13039.4 15693.3 15702.5 15752.2 15760.7 6702.4 7078.6 7109.2 7364.6 7418.6 6740.6 6746.5 6947.7 6950.6 6956.5 6719.3 6811.2 6816.6 6949.5 7045.9 1967.4 2029.6 2033.8 2050.9 2060.3 836.3 860.7 861.2 867.7 880.9 16436.3 16646.1 17331.4 17480.5 17822.3 885.9 915.2 915.5 918.8 921.3 8710.0 9454.0 9516.0 9521.3 9556.8 433038.0 440078.0 440119.0 449267.0 452502.0 92174.0 92496.0 92520.0 94192.5 95044.5 1047.6 1063.3 1098.7 1105.5 1106.3 15861.7 17588.9 17819.0 17978.6 18018.6 41690.8 41877.4 42120.4 42807.8 43696.6 38262.1 44748.0 49822.0 53246.0 56640.0 7925.8 8201.5 8206.5 8378.7 8670.4 12958.7 12997.8 13010.9 13244.4 13291.4 11054.9 11204.8 11220.3 11271.5 11674.2 10270.3 10331.4 10450.8 10456.7 10548.5 11324.5 11491.6 11500.7 11746.5 11955.8 7846.3 7873.1 8066.8 8186.3 8195.3 9767.2 9835.5 10008.6 10203.1 10995.1 07:17:14 INFO - PID 15807 | 07:17:14 INFO - PID 15807 | [#3] mootools.html Cycles:180 Average:6166.27 Median:4082.90 stddev:3994.34 (97.8%) stddev-sans-first:3988.47 07:17:14 INFO - PID 15807 | Values: 1250.9 1306.9 1309.8 1321.9 1330.1 9318.6 9653.6 9671.6 9847.5 10164.1 9949.6 10083.7 10085.1 10119.5 10131.4 2193.0 2227.5 2228.9 2235.9 2237.2 2087.3 2153.5 2164.9 2196.5 2199.4 2126.6 2168.6 2185.3 2186.6 2193.5 2093.0 2104.6 2105.1 2106.1 2106.5 1791.0 1862.6 1991.4 2040.4 2041.8 9680.3 9908.4 9998.7 10003.4 10011.0 5190.4 5349.1 5381.7 5406.2 5409.5 3226.5 3233.4 3253.2 3312.1 3375.2 1021.0 1036.4 1064.7 1066.7 1085.3 14571.5 14615.6 14684.5 14688.9 14736.1 4459.8 4749.4 4815.3 4848.8 4898.1 10812.6 10818.3 10840.7 10841.6 10882.5 5239.4 5273.9 5282.9 5287.4 5293.4 4700.7 4856.2 4863.6 4922.0 4931.4 3532.4 3636.1 3645.4 3665.9 3680.2 1094.8 1110.5 1110.8 1134.9 1138.1 600.9 613.5 617.3 630.3 635.0 5052.3 5100.3 5104.9 5113.7 5303.6 538.5 540.4 551.9 552.7 553.8 3993.3 4036.7 4049.5 4068.3 4097.5 12541.7 12855.6 12879.3 12959.4 12964.7 12093.1 12785.3 12801.6 12811.7 12830.5 9058.5 9224.6 9290.3 9294.0 9294.8 5736.2 5872.7 5938.7 6014.9 6081.0 11669.7 11926.9 11998.2 12156.9 12190.3 11801.4 12209.7 12293.9 12365.9 12392.2 7688.5 7938.7 7956.5 7961.2 7961.7 9035.3 9065.1 9089.1 9118.6 9203.5 8138.0 8170.8 8248.8 8292.3 8439.5 7804.1 7881.3 7908.2 8039.7 8113.3 7008.4 7207.2 7215.7 7219.0 7229.0 4839.3 4985.5 5073.2 5080.2 5104.4 4786.6 4910.6 4936.2 4938.4 5004.9 07:17:14 INFO - PID 15807 | 07:17:14 INFO - PID 15807 | [#4] prototype.html Cycles:180 Average:4867.85 Median:5485.97 stddev:1401.51 (25.5%) stddev-sans-first:1364.30 07:17:14 INFO - PID 15807 | Values: 376.8 389.2 394.0 395.9 397.2 5383.0 5539.4 5628.5 5656.2 5679.5 5337.3 5462.0 5522.9 5531.3 5547.8 4394.2 4397.1 4404.0 4406.7 4409.3 4314.8 4321.4 4333.5 4404.6 4422.1 4327.4 4346.4 4347.4 4348.2 4365.4 4332.7 4369.4 4372.0 4375.0 4390.7 3837.3 3956.7 3969.6 3969.6 3974.2 5352.8 5364.7 5403.3 5404.6 5434.9 5077.9 5093.8 5096.4 5101.5 5119.6 5700.3 5814.5 5869.3 5877.0 5877.9 4328.0 4342.6 4347.9 4351.4 4355.8 5912.6 6011.2 6075.4 6145.4 6156.0 4431.0 4436.8 4437.6 4441.7 4445.5 4450.2 4483.5 4485.4 4487.7 4509.3 4563.2 4811.3 4828.6 5016.2 5057.5 5793.9 5815.4 5826.8 5833.0 5835.9 1440.9 1451.7 1460.1 1467.1 1471.5 970.5 978.2 982.3 984.6 995.5 5063.9 5100.5 5118.4 5126.1 5148.0 6031.8 6043.9 6058.7 6067.7 6089.7 4844.4 5054.4 5109.4 5109.5 5165.5 3186.9 3200.4 3204.9 3218.8 3219.0 5454.6 5612.2 5621.7 5623.9 5670.9 6150.7 6199.9 6224.9 6226.7 6253.2 5610.6 5615.3 5617.8 5622.0 5642.2 5635.6 6018.2 6039.5 6042.2 6051.0 5703.4 5988.3 6002.5 6022.4 6032.8 5472.8 5493.5 5598.6 5633.8 5634.5 4120.8 4136.8 4163.0 4163.2 4164.6 5993.2 6005.4 6028.2 6112.7 6132.4 5829.1 5860.8 5883.6 5891.7 5900.2 5842.8 5856.3 5858.5 5883.2 5897.7 5554.2 5744.3 5752.1 5776.4 5796.2 5874.5 5917.9 5919.3 5920.8 5946.8 5478.5 5714.9 5742.3 5756.6 5777.2 07:17:14 INFO - PID 15807 | 07:17:14 INFO - PID 15807 | [#5] yui.html Cycles:180 Average:13112.17 Median:45541.89 stddev:15336.82 (33.7%) stddev-sans-first:15351.07 07:17:14 INFO - PID 15807 | Values: 602.8 635.2 684.1 695.1 727.2 11319.1 11784.8 12398.4 12407.8 12452.0 11902.8 12297.4 12360.7 12421.0 12430.3 806.2 819.9 832.1 832.6 833.4 798.0 827.1 827.4 828.1 830.2 879.0 886.0 886.0 887.6 888.2 868.4 870.9 876.1 876.6 877.4 638.2 645.8 645.8 648.0 650.8 12862.4 12993.9 13225.5 13371.3 13381.3 12916.4 13033.7 13062.8 13303.8 13596.5 9126.2 9372.5 9440.4 9559.3 9568.7 2449.3 2472.1 2502.7 2508.0 2583.4 47985.0 48889.3 49667.5 50251.2 50991.0 9908.9 10054.6 10127.6 10198.8 10211.9 19154.2 19158.7 19381.8 19455.8 19679.8 6398.0 6546.3 6568.4 6573.7 6790.3 3346.6 3401.9 3419.6 3461.4 3533.9 3434.3 3458.2 3463.9 3470.2 3517.2 644.7 648.7 649.7 665.1 670.4 501.2 524.6 525.4 530.2 537.6 8144.6 8402.8 8498.0 8543.8 8734.6 491.7 495.1 496.6 503.9 505.9 3783.1 3840.3 3863.2 3921.9 4093.4 62745.0 63575.0 63625.4 64810.4 64984.0 42287.8 45447.8 45636.0 52779.0 54496.7 39532.6 40952.2 42445.6 42619.6 43228.0 9089.2 9621.3 9630.2 9677.2 9697.7 24621.9 25023.7 25172.9 25426.5 25949.4 31267.8 31281.8 31421.0 31756.5 31812.5 11853.1 11856.2 11921.3 11924.5 12001.0 11980.8 12252.8 12424.3 12512.4 13082.7 11098.9 11410.4 12052.3 12252.7 13098.2 11562.6 11824.2 11972.3 12115.7 12742.0 11184.0 11415.3 11443.4 11711.6 11718.9 8387.2 8436.7 8685.7 8723.6 8854.7 9440.6 9474.5 9541.8 9569.9 9623.6 07:17:14 INFO - PID 15807 | -------- Summary: end -------- 07:17:14 INFO - PID 15807 | 07:17:15 INFO - TEST-INFO | 15807: exit 0 07:17:15 INFO - TEST-OK | dromaeo_css | took 1121643ms 07:17:15 INFO - TEST-START | kraken 07:17:15 INFO - operating with platform_type : linux_ 07:17:15 INFO - Initialising browser for kraken test... 07:17:15 INFO - TEST-INFO | started process 16185 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiL2vnm/profile http://localhost:48266/getInfo.html) 07:17:20 INFO - PID 16185 | __metrics Screen width/height:1600/1200 07:17:20 INFO - PID 16185 | colorDepth:24 07:17:20 INFO - PID 16185 | Browser inner width/height: 1024/697 07:17:20 INFO - PID 16185 | __metrics 07:17:20 ERROR - PID 16185 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3388: TypeError: this.tabs is undefined 07:17:21 INFO - TEST-INFO | 16185: exit 0 07:17:21 INFO - Browser initialized. 07:17:21 INFO - Running cycle 1/1 for kraken test... 07:17:21 INFO - TEST-INFO | started process 16317 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiL2vnm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:17:34 INFO - PID 16317 | RSS: Main: 155529216 07:17:34 INFO - PID 16317 | 07:17:36 INFO - PID 16317 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48266/tests/kraken/driver.html?testName=audio-beat-detection) 07:17:37 INFO - PID 16317 | RSS: Main: 161812480 07:17:37 INFO - PID 16317 | 07:17:40 INFO - PID 16317 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48266/tests/kraken/driver.html?testName=audio-dft) 07:17:41 INFO - PID 16317 | RSS: Main: 160972800 07:17:41 INFO - PID 16317 | 07:17:44 INFO - PID 16317 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48266/tests/kraken/driver.html?testName=audio-fft) 07:17:44 INFO - PID 16317 | RSS: Main: 157954048 07:17:44 INFO - PID 16317 | 07:17:46 INFO - PID 16317 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48266/tests/kraken/driver.html?testName=audio-oscillator) 07:17:47 INFO - PID 16317 | RSS: Main: 158760960 07:17:47 INFO - PID 16317 | 07:17:49 INFO - PID 16317 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:17:50 INFO - PID 16317 | RSS: Main: 158932992 07:17:50 INFO - PID 16317 | 07:17:53 INFO - PID 16317 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48266/tests/kraken/driver.html?testName=imaging-darkroom) 07:17:54 INFO - PID 16317 | RSS: Main: 163553280 07:17:54 INFO - PID 16317 | 07:17:57 INFO - PID 16317 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48266/tests/kraken/driver.html?testName=imaging-desaturate) 07:17:58 INFO - PID 16317 | RSS: Main: 161501184 07:17:58 INFO - PID 16317 | 07:18:01 INFO - PID 16317 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48266/tests/kraken/driver.html?testName=json-parse-financial) 07:18:01 INFO - PID 16317 | RSS: Main: 162004992 07:18:01 INFO - PID 16317 | 07:18:03 INFO - PID 16317 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:18:04 INFO - PID 16317 | RSS: Main: 162930688 07:18:04 INFO - PID 16317 | 07:18:06 INFO - PID 16317 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48266/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:18:06 INFO - PID 16317 | RSS: Main: 162668544 07:18:06 INFO - PID 16317 | 07:18:08 INFO - PID 16317 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:18:09 INFO - PID 16317 | RSS: Main: 163323904 07:18:09 INFO - PID 16317 | 07:18:12 INFO - PID 16317 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:18:13 INFO - PID 16317 | RSS: Main: 163389440 07:18:13 INFO - PID 16317 | 07:18:16 INFO - PID 16317 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:18:17 INFO - PID 16317 | RSS: Main: 166748160 07:18:17 INFO - PID 16317 | 07:18:18 INFO - PID 16317 | Cycle 1(1): loaded http://localhost:48266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48266/tests/kraken/driver.html?testName=ai-astar) 07:18:19 INFO - PID 16317 | RSS: Main: 167796736 07:18:19 INFO - PID 16317 | 07:18:19 INFO - PID 16317 | __start_tp_report 07:18:19 INFO - PID 16317 | _x_x_mozilla_page_load 07:18:19 INFO - PID 16317 | _x_x_mozilla_page_load_details 07:18:19 INFO - PID 16317 | |i|pagename|runs| 07:18:19 INFO - PID 16317 | |0;ai-astar;105;112;112;113;113;112;112;114;113;113 07:18:19 INFO - PID 16317 | |1;audio-beat-detection;156;127;125;164;124;125;125;127;150;126 07:18:19 INFO - PID 16317 | |2;audio-dft;163;166;166;172;177;164;163;163;163;163 07:18:19 INFO - PID 16317 | |3;audio-fft;79;74;75;118;77;76;77;76;101;76 07:18:19 INFO - PID 16317 | |4;audio-oscillator;84;84;105;86;84;83;99;84;83;107 07:18:19 INFO - PID 16317 | |5;imaging-gaussian-blur;114;114;115;113;115;114;117;114;113;115 07:18:19 INFO - PID 16317 | |6;imaging-darkroom;150;150;151;151;150;150;151;151;152;151 07:18:19 INFO - PID 16317 | |7;imaging-desaturate;96;95;95;95;94;95;98;94;95;94 07:18:19 INFO - PID 16317 | |8;json-parse-financial;70;68;66;69;76;69;69;69;69;69 07:18:19 INFO - PID 16317 | |9;json-stringify-tinderbox;56;56;55;55;55;54;56;57;56;55 07:18:19 INFO - PID 16317 | |10;stanford-crypto-aes;84;93;95;92;86;84;85;85;84;84 07:18:19 INFO - PID 16317 | |11;stanford-crypto-ccm;139;136;140;133;134;138;134;140;185;150 07:18:19 INFO - PID 16317 | |12;stanford-crypto-pbkdf2;189;197;197;201;204;203;197;201;204;197 07:18:19 INFO - PID 16317 | |13;stanford-crypto-sha256-iterative;76;73;72;72;75;76;71;75;71;70 07:18:19 INFO - PID 16317 | __end_tp_report 07:18:19 INFO - PID 16317 | __start_cc_report 07:18:19 INFO - PID 16317 | _x_x_mozilla_cycle_collect,868 07:18:19 INFO - PID 16317 | __end_cc_report 07:18:19 INFO - PID 16317 | __startTimestamp1490278699169__endTimestamp 07:18:19 INFO - PID 16317 | 07:18:19 INFO - PID 16317 | ------- Summary: start ------- 07:18:19 INFO - PID 16317 | Number of tests: 14 07:18:19 INFO - PID 16317 | 07:18:19 INFO - PID 16317 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:2.51 (2.2%) stddev-sans-first:0.71 07:18:19 INFO - PID 16317 | Values: 105.0 112.0 112.0 113.0 113.0 112.0 112.0 114.0 113.0 113.0 07:18:19 INFO - PID 16317 | 07:18:19 INFO - PID 16317 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:127.00 stddev:15.41 (12.1%) stddev-sans-first:14.33 07:18:19 INFO - PID 16317 | Values: 156.0 127.0 125.0 164.0 124.0 125.0 125.0 127.0 150.0 126.0 07:18:19 INFO - PID 16317 | 07:18:19 INFO - PID 16317 | [#2] audio-dft Cycles:10 Average:166.00 Median:165.00 stddev:4.78 (2.9%) stddev-sans-first:4.95 07:18:19 INFO - PID 16317 | Values: 163.0 166.0 166.0 172.0 177.0 164.0 163.0 163.0 163.0 163.0 07:18:19 INFO - PID 16317 | 07:18:19 INFO - PID 16317 | [#3] audio-fft Cycles:10 Average:82.90 Median:76.00 stddev:14.64 (19.3%) stddev-sans-first:15.46 07:18:19 INFO - PID 16317 | Values: 79.0 74.0 75.0 118.0 77.0 76.0 77.0 76.0 101.0 76.0 07:18:19 INFO - PID 16317 | 07:18:19 INFO - PID 16317 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:84.00 stddev:9.73 (11.6%) stddev-sans-first:10.09 07:18:19 INFO - PID 16317 | Values: 84.0 84.0 105.0 86.0 84.0 83.0 99.0 84.0 83.0 107.0 07:18:19 INFO - PID 16317 | 07:18:19 INFO - PID 16317 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:1.17 (1.0%) stddev-sans-first:1.24 07:18:19 INFO - PID 16317 | Values: 114.0 114.0 115.0 113.0 115.0 114.0 117.0 114.0 113.0 115.0 07:18:19 INFO - PID 16317 | 07:18:19 INFO - PID 16317 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 07:18:19 INFO - PID 16317 | Values: 150.0 150.0 151.0 151.0 150.0 150.0 151.0 151.0 152.0 151.0 07:18:19 INFO - PID 16317 | 07:18:19 INFO - PID 16317 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:1.20 (1.3%) stddev-sans-first:1.22 07:18:19 INFO - PID 16317 | Values: 96.0 95.0 95.0 95.0 94.0 95.0 98.0 94.0 95.0 94.0 07:18:19 INFO - PID 16317 | 07:18:19 INFO - PID 16317 | [#8] json-parse-financial Cycles:10 Average:69.40 Median:69.00 stddev:2.55 (3.7%) stddev-sans-first:2.69 07:18:19 INFO - PID 16317 | Values: 70.0 68.0 66.0 69.0 76.0 69.0 69.0 69.0 69.0 69.0 07:18:19 INFO - PID 16317 | 07:18:19 INFO - PID 16317 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:56.00 stddev:0.85 (1.5%) stddev-sans-first:0.88 07:18:19 INFO - PID 16317 | Values: 56.0 56.0 55.0 55.0 55.0 54.0 56.0 57.0 56.0 55.0 07:18:19 INFO - PID 16317 | 07:18:19 INFO - PID 16317 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:85.50 stddev:4.34 (5.1%) stddev-sans-first:4.45 07:18:19 INFO - PID 16317 | Values: 84.0 93.0 95.0 92.0 86.0 84.0 85.0 85.0 84.0 84.0 07:18:19 INFO - PID 16317 | 07:18:19 INFO - PID 16317 | [#11] stanford-crypto-ccm Cycles:10 Average:142.90 Median:139.50 stddev:15.57 (11.2%) stddev-sans-first:16.45 07:18:19 INFO - PID 16317 | Values: 139.0 136.0 140.0 133.0 134.0 138.0 134.0 140.0 185.0 150.0 07:18:19 INFO - PID 16317 | 07:18:19 INFO - PID 16317 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.00 Median:201.00 stddev:4.59 (2.3%) stddev-sans-first:3.14 07:18:19 INFO - PID 16317 | Values: 189.0 197.0 197.0 201.0 204.0 203.0 197.0 201.0 204.0 197.0 07:18:19 INFO - PID 16317 | 07:18:19 INFO - PID 16317 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:74.00 stddev:2.23 (3.0%) stddev-sans-first:2.11 07:18:19 INFO - PID 16317 | Values: 76.0 73.0 72.0 72.0 75.0 76.0 71.0 75.0 71.0 70.0 07:18:19 INFO - PID 16317 | -------- Summary: end -------- 07:18:19 INFO - PID 16317 | 07:18:20 INFO - TEST-INFO | 16317: exit 0 07:18:20 INFO - TEST-OK | kraken | took 65173ms 07:18:20 INFO - SUITE-END | took 1186s 07:18:20 INFO - Completed test suite (00:19:47) 07:18:20 INFO - javascript benchmark 07:18:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6562.269355959642, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2685.624012638231, 2701.2166471723203, 2711.579705145702, 2736.247531928718, 2743.698193198748, 5016.698998060119, 5175.30133431987, 5214.967556308162, 5235.607329450297, 5259.947400525998, 5143.922841157376, 5156.097682905495, 5191.688498690081, 5233.450487698794, 5273.024490469256, 4682.648801339896, 4706.5293470653005, 4728.716277023373, 4736.692115012514, 4762.404699412574, 4730.574248317651, 4733.83431579893, 4775.164346239411, 4788.497207793183, 4812.278158276252, 4687.5781179693995, 4689.7655117244, 4696.365990591261, 4725.31482934976, 4732.739699316537, 4699.107169637758, 4705.270683044134, 4710.246360582325, 4738.47876733559, 4752.5247475252545, 4614.838480653161, 4663.790129444184, 4666.766661666903, 4675.298705194214, 4721.6458765592715, 5006.874828129289, 5033.395992480889, 5114.820981265675, 5135.075686376451, 5204.115300398941, 5579.107342825169, 5597.580181486364, 5603.719814009283, 5624.3531993820825, 5652.802151924663, 5607.046802043662, 5611.186377975211, 5614.9157762633595, 5622.297212848394, 5623.8594035149035, 5028.446870844277, 5060.822871199491, 5079.339685840817, 5199.766010529535, 5256.737163141827, 5520.53075488588, 5539.224508568723, 5586.050371436865, 5590.91613625796, 5593.412691667398, 5373.408925018245, 5397.325334333208, 5449.373322067933, 5459.344878614592, 5476.698781567052, 5512.641678290898, 5533.059379905426, 5539.639923404966, 5584.692841893735, 5586.581006424453, 5509.201165831012, 5511.58663100269, 5522.199281104297, 5535.0, 5591.245181900473, 5293.947060529423, 5338.412774594792, 5493.23094766733, 5522.861928451821, 5549.361823390281, 4640.930386044212, 4645.74448405341, 4646.907061858744, 4665.626749860071, 4668.719876807402, 3966.3852102924093, 3971.126352202569, 3993.4808474898077, 4005.339119045325, 4031.9193616127513, 4677.602403795716, 4740.6444516660695, 4813.855584332476, 4845.9030819383415, 4874.390701162355, 5582.665040097607, 5593.188987596775, 5600.243967064475, 5604.6917419542315, 5645.548356131581, 4785.665003449794, 4824.252240902666, 4826.348442960226, 4826.61387089032, 4868.683535570177, 4830.3479030331155, 4834.709917404896, 4883.584895283941, 4944.134776414113, 4944.826931057396, 5079.060373830853, 5125.743712814419, 5129.358830146231, 5131.640785145004, 5132.384113906355, 5484.61607687474, 5491.341039075177, 5493.038718224375, 5495.230667706604, 5495.862603434786, 5113.130767769414, 5117.309163262912, 5124.359455068116, 5128.230765385222, 5129.615278854176, 5432.076546986943, 5479.753411096431, 5487.122060470306, 5523.834284971457, 5537.640053396516, 5530.474604912527, 5587.329520457409, 5609.775608975759, 5615.494605485526, 5619.129034999582, 5426.593005524523, 5429.321334833146, 5437.945620543744, 5443.401225865073, 5497.3952865184, 5257.737113144404, 5271.8682032947945, 5292.0, 5311.973440132774, 5421.83734487966, 5207.140821764367, 5313.654612450178, 5314.043472175045, 5314.62797604164, 5321.228421878728, 5422.15956526739, 5443.673379597237, 5463.562914966873, 5473.726313684379, 5520.171974203901, 5167.844964651066, 5177.0940085485645, 5224.817131400383, 5268.736563171749, 5268.76290566933], "value": 5050.12339290885, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.1984979826627, 659.2715049869894, 684.0013580172947, 1086.608820824503, 1098.1105304703185, 29130.81518886084, 30050.699493005064, 30077.849610751917, 30119.698803011965, 30126.246843828914, 28837.279068023257, 29019.709802901965, 29173.0, 29248.853755731245, 29282.0, 7017.438604911607, 7146.821329466753, 7188.9281107189045, 7232.1683006454405, 7238.312360325761, 7205.927940720604, 7312.1225452945455, 7315.707371705125, 7325.816854578651, 7332.670029848643, 7296.562206267615, 7311.086114235721, 7347.559146451204, 7356.705731770723, 7375.778726638209, 7303.926960730404, 7307.561546307212, 7329.890051649176, 7332.8900066499045, 7371.705131794722, 7126.144862616467, 7177.641117944134, 7189.0, 7194.13670359555, 7200.135983681992, 30964.535531967038, 31106.377872442423, 31269.68730312713, 31399.84300078485, 31430.214244643837, 2558.808089393303, 2595.9870200649066, 2607.3090630982806, 2629.4609605030923, 2641.749033841782, 21903.780962190493, 21906.89046554773, 21987.670184947237, 22767.43081422961, 22787.31638050861, 2867.5411934090444, 2938.911832645024, 2943.6467623885055, 2960.6151200343816, 2970.6138202033812, 111567.0, 114648.0, 131931.0, 133476.0, 160354.0, 37349.253014939546, 38006.809965950546, 38040.23919521594, 38197.42703859444, 38235.61764382321, 46088.769556152, 46608.97041692279, 46638.76680616575, 46705.5329446708, 46707.766461168154, 13044.608661740163, 13171.67070823237, 13174.802377964339, 13195.934020330029, 13211.207327560378, 10656.62701805433, 10685.946570267099, 10711.73220669474, 10752.784944301071, 10812.67561973142, 13372.933135334455, 13373.331333433289, 13494.190348579117, 13511.729765404834, 13656.93171534136, 5717.22817419643, 5788.218590490314, 5806.912896306559, 5860.736266868002, 5914.970425147847, 849.7195925344621, 865.2558799432483, 887.1882227761525, 893.1782759860944, 908.6274627402734, 21798.0, 22266.75860563621, 23449.17927872516, 23456.0, 23505.0, 971.1502435369052, 975.9264808710503, 981.293468702533, 1000.6047611193537, 1000.9749756256152, 11329.206955513035, 11779.941100294443, 11784.823227651592, 11785.0, 11795.882041179479, 226843.0, 228302.0, 228779.0, 229492.0, 229509.0, 42949.35575966363, 43241.78379108147, 43282.0, 43317.99999999937, 43336.78331608385, 1182.4365626207295, 1215.398377802993, 1217.0385395537426, 1225.240350982379, 1230.7784598772307, 20332.0, 20361.0, 21563.0, 21739.782602174408, 21769.00665164082, 31673.8416307917, 31922.680773191973, 31955.68044319527, 31961.520577190895, 31974.68025319717, 241059.0, 241546.0, 241577.0, 242724.0, 242851.0, 28112.859435703507, 28119.0, 28966.85516572488, 29024.0, 29859.402811944074, 33012.339753205284, 33150.0, 33319.50020749739, 33337.0, 34010.14974625555, 25353.239402817944, 25857.0, 26277.4744505105, 26321.473570528866, 27096.1871143866, 27922.16233512998, 27952.44095118127, 28140.43719125647, 28164.295892602848, 29204.123876283746, 30599.388012240077, 31630.525542117346, 31790.52314215335, 31831.204219894687, 31876.840615796773, 27636.14720761813, 27901.860490697418, 28067.859660701564, 28180.295492612848, 28366.14901552957, 20884.582308353445, 22224.77763723011, 22578.774212257667, 22586.66120008234, 22600.773992260525], "value": 14772.421668959963, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.36201164172223, 410.68787721331796, 419.8320671731307, 423.6907057847771, 439.8064851465355, 11570.53717851287, 16040.83959160408, 16290.674186516277, 16874.240659170337, 16899.746503802453, 16014.279357428915, 16053.598660033476, 16299.674006519863, 17722.113894305297, 17929.64140717185, 5554.333479982408, 5565.9443405565835, 5608.214849921014, 5751.309842818868, 5755.107958266454, 5562.137868630349, 5630.211770352154, 5653.095504719246, 5660.830175094754, 5665.971670141644, 5602.187682785993, 5607.7476513556985, 5608.747606357723, 5654.321481422215, 5657.066584013633, 5444.96545656326, 5610.803621873235, 5613.775448982035, 5617.157426386034, 5622.887542249132, 4895.559399654048, 5006.499350065001, 5042.092423363793, 5085.211792172182, 5100.719460429675, 21334.359969200792, 21482.35552933399, 21534.246301379535, 21806.78193218079, 21828.45428864275, 1441.819772528434, 1478.8521147885233, 1485.5023567105034, 1488.672492051747, 1523.7104950059454, 13986.580402587939, 14060.0, 14105.2242126683, 14208.715825683532, 14694.412223511046, 1509.1397903195073, 1576.6294920693629, 1587.904725716449, 1596.106180538902, 1609.7343938250174, 75421.0, 75663.24336756617, 76379.99999999945, 77200.27997200347, 77495.61252193703, 10902.291351062155, 11021.779564408667, 11188.552457901755, 11275.154363422776, 11401.48693308803, 13039.413226404835, 15693.293801778947, 15702.528924132293, 15752.212389380486, 15760.68478630421, 6702.36327548882, 7078.590680808994, 7109.1824440189, 7364.594947277844, 7418.591977441185, 6740.561863478858, 6746.460283177334, 6947.7220911162985, 6950.6177160256675, 6956.5478243914995, 6719.260881303053, 6811.182658080963, 6816.556923799937, 6949.548279361826, 7045.92954070463, 1967.3802752133033, 2029.5839352932614, 2033.8474614403979, 2050.92821751238, 2060.2994981706292, 836.2891542189091, 860.6901515454431, 861.2033868671454, 867.7287773411982, 880.8942926848691, 16436.260368283456, 16646.08446535428, 17331.393401230896, 17480.47558573245, 17822.287108515775, 885.9059062058353, 915.2449229385784, 915.4690279637794, 918.8483900156399, 921.2675922641516, 8710.0, 9454.0, 9515.952420237854, 9521.28590355726, 9556.808863822685, 433038.0, 440078.0, 440119.0, 449267.0, 452502.0, 92174.0, 92496.0, 92520.0, 94192.52903735437, 95044.52477737567, 1047.6280920273346, 1063.3407287481812, 1098.6813823991113, 1105.4583254205543, 1106.2753896198003, 15861.682766344838, 17588.91205543964, 17819.0, 17978.5505362367, 18018.567493388226, 41690.79154604208, 41877.371839423045, 42120.3681944765, 42807.785961069996, 43696.56303436925, 38262.10219021542, 44748.0, 49822.0, 53246.0, 56640.0, 7925.841483170419, 8201.507909525448, 8206.507609543447, 8378.748637540884, 8670.393072484865, 12958.676033099247, 12997.805032924325, 13010.869891300967, 13244.404001820134, 13291.401886915306, 11054.889451105386, 11204.775904482029, 11220.270682405617, 11271.49278282463, 11674.241174323643, 10270.33242839213, 10331.431771252654, 10450.843237351597, 10456.68629941103, 10548.525316360628, 11324.490397931948, 11491.597794077166, 11500.712482188012, 11746.530138794353, 11955.820662689892, 7846.293833555007, 7873.133955264801, 8066.7579972600915, 8186.345092392713, 8195.344372450309, 9767.21862251004, 9835.459049752046, 10008.599656013677, 10203.081722644998, 10995.120390368911], "value": 8762.553210928074, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1250.9061820363472, 1306.9085164038522, 1309.7576948264573, 1321.881030707236, 1330.0689517337862, 9318.580663870125, 9653.613855445774, 9671.564779584918, 9847.507624618776, 10164.08523232909, 9949.602015919372, 10083.747906302346, 10085.142762865147, 10119.494025298742, 10131.392116472998, 2193.024104273603, 2227.532218234173, 2228.9331320060423, 2235.854669446489, 2237.2281562860785, 2087.342487116561, 2153.4616345913523, 2164.935051948436, 2196.53872686736, 2199.417154454071, 2126.5959467701086, 2168.5988092202915, 2185.311626837549, 2186.5736181444627, 2193.451637090727, 2092.98953505233, 2104.5790841831617, 2105.1158513424243, 2106.1259577275414, 2106.494441334084, 1790.973135402957, 1862.608852141052, 1991.3528103366464, 2040.438879308202, 2041.7549894012666, 9680.322377433582, 9908.405495670211, 9998.700038998843, 10003.399796012263, 10011.048950349705, 5190.429052804188, 5349.063913815066, 5381.730913454312, 5406.16204488301, 5409.513143817076, 3226.451503244454, 3233.4018206631613, 3253.2029652734996, 3312.0726196664973, 3375.206826395795, 1020.9591616335338, 1036.3574583758043, 1064.7072055184885, 1066.72798436399, 1085.3216739537788, 14571.489997850025, 14615.561533153916, 14684.48604298855, 14688.926555367154, 14736.115833049944, 4459.7547134907245, 4749.3588365570895, 4815.253635686474, 4848.781804818792, 4898.118338698997, 10812.567497300177, 10818.29681070728, 10840.72898177536, 10841.566337346576, 10882.455877206266, 5239.449857764956, 5273.945210957824, 5282.920756188661, 5287.41838397776, 5293.391260005072, 4700.694454860423, 4856.150173719656, 4863.562279394871, 4921.990991846663, 4931.408231012301, 3532.434810430319, 3636.072801435617, 3645.3802853514435, 3665.9185540265685, 3680.227152297994, 1094.7755710079414, 1110.5280255891214, 1110.7556337605713, 1134.8638163420442, 1138.0895283773114, 600.8703637162195, 613.4601550635501, 617.3363634093367, 630.331848240857, 635.0474288567149, 5052.267421223902, 5100.336956195671, 5104.923426148611, 5113.718745469035, 5303.602229832778, 538.4857461124695, 540.3947578711868, 551.9254900588369, 552.7070652554153, 553.8283132228942, 3993.341098718679, 4036.737612055207, 4049.4735684360844, 4068.3287257602756, 4097.467329247179, 12541.686457838627, 12855.614331569881, 12879.29163895976, 12959.416826242841, 12964.675883102998, 12093.093018023508, 12785.296808675426, 12801.551945682042, 12811.743765124646, 12830.486780528861, 9058.456492610465, 9224.631014759334, 9290.256779457763, 9293.953530232306, 9294.814103718023, 5736.196932429547, 5872.735726892385, 5938.7135107720605, 6014.939850601613, 6080.969595151996, 11669.708257293296, 11926.940365298118, 11998.220115692453, 12156.939215303866, 12190.329531875832, 11801.40992950332, 12209.69475763113, 12293.87706122963, 12365.876341236473, 12392.211752355648, 7688.538687678757, 7938.682452701827, 7956.482828616122, 7961.164077771982, 7961.72133975308, 9035.322350823582, 9065.093490650883, 9089.136532029446, 9118.589663465293, 9203.493807840632, 8138.0, 8170.795730106557, 8248.83502329962, 8292.33661307106, 8439.493630382196, 7804.141544429995, 7881.251281128284, 7908.248716371935, 8039.718609848627, 8113.269805717514, 7008.4042856355745, 7207.171175314906, 7215.67529461186, 7219.0, 7229.0, 4839.2983017462975, 4985.52637499437, 5073.188289873602, 5080.187170052774, 5104.387473503203, 4786.593139583035, 4910.631702622389, 4936.160852654985, 4938.38270216223, 5004.949950500594], "value": 4577.613241046413, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.8436099018907, 389.239037681333, 393.96848252139824, 395.86540576204084, 397.24523405529493, 5383.0, 5539.393575863005, 5628.493435590796, 5656.236408084912, 5679.488846003859, 5337.279467271917, 5462.0, 5522.889542209164, 5531.2532808071, 5547.833564993057, 4394.187075391047, 4397.141857792444, 4403.977980110095, 4406.700023493077, 4409.250427427345, 4314.762688052156, 4321.395004699345, 4333.458317710286, 4404.559544045585, 4422.137683151786, 4327.394164816928, 4346.391505189276, 4347.3696314034605, 4348.173846969065, 4365.36702178184, 4332.696711230215, 4369.43197384338, 4372.038151606642, 4375.0, 4390.714603550759, 3837.270918525499, 3956.7032472564383, 3969.563348031714, 3969.563348031714, 3974.205158968189, 5352.812651557177, 5364.704941228231, 5403.324584426947, 5404.6486978346675, 5434.91847622286, 5077.923831142536, 5093.821716239951, 5096.369161868203, 5101.489851014906, 5119.6160287978555, 5700.2589663343915, 5814.5057670098095, 5869.325027621835, 5877.000909845294, 5877.9412205877825, 4328.0, 4342.609165175149, 4347.891302717426, 4351.412559304516, 4355.760433176174, 5912.645241285493, 6011.188489553898, 6075.392460753934, 6145.354737752561, 6155.952803362319, 4430.955690443118, 4436.800343984529, 4437.622802061861, 4441.733495990251, 4445.488768791565, 4450.243458611979, 4483.461984561874, 4485.439320084989, 4487.685861989695, 4509.346144808985, 4563.201439748031, 4811.254255590389, 4828.637852161031, 5016.19740841471, 5057.544820966057, 5793.913091303634, 5815.389384114607, 5826.82519524415, 5833.0, 5835.883282334329, 1440.897713249365, 1451.7459444597152, 1460.0947412604253, 1467.097734893033, 1471.5144002479155, 970.5001924009141, 978.2418625565101, 982.2583949118513, 984.6307634637011, 995.5221493682928, 5063.873403164876, 5100.540951314325, 5118.38579370478, 5126.102931986888, 5148.047611191867, 6031.819045428644, 6043.909341359883, 6058.697065146725, 6067.666278354644, 6089.695515224221, 4844.394450693663, 5054.368203974504, 5109.3613298337705, 5109.489051094861, 5165.509276618715, 3186.9362612747614, 3200.447782825328, 3204.926349672839, 3218.7907785993834, 3218.9839050805062, 5454.636141453376, 5612.186232996274, 5621.747021384048, 5623.943760562423, 5670.943290567124, 6150.661713605705, 6199.938000620026, 6224.9377506224355, 6226.719797609118, 6253.155823963798, 5610.551155907518, 5615.298087739033, 5617.775288988395, 5622.004188513019, 5642.153676948491, 5635.577331700221, 6018.157457955802, 6039.48664363534, 6042.244719410074, 6051.031834906394, 5703.401142879938, 5988.311344195473, 6002.489788368038, 6022.36765139654, 6032.788852390146, 5472.781088756565, 5493.450654934474, 5598.552115830642, 5633.802816901389, 5634.492895639412, 4120.7733574653685, 4136.751794892196, 4163.0, 4163.188178305322, 4164.583541645932, 5993.220881285405, 6005.39946005396, 6028.156058151774, 6112.663803490673, 6132.448079672851, 5829.125631155361, 5860.765569377178, 5883.646981181143, 5891.734871930687, 5900.203472531153, 5842.795502157404, 5856.267966504187, 5858.47273745365, 5883.2057672215415, 5897.734601943009, 5554.194641776839, 5744.253247077853, 5752.13717942312, 5776.393478684678, 5796.246487956707, 5874.471297583067, 5917.881642367042, 5919.319278283053, 5920.79277225295, 5946.821595352147, 5478.479544443271, 5714.885702285847, 5742.3347229303035, 5756.597038207286, 5777.162311464898], "value": 4431.5451311359375, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.7769725201676, 635.177445208455, 684.0764967294153, 695.0755495191395, 727.15286691005, 11319.094472442206, 11784.7643047139, 12398.380080995938, 12407.751844963106, 12452.0, 11902.7619447611, 12297.446614902328, 12360.690982725437, 12421.0, 12430.316332601704, 806.2058872011064, 819.9098099209082, 832.1221111727156, 832.5753865528594, 833.4166083741375, 797.960101994898, 827.0819390476566, 827.3960009193293, 828.1180542722012, 830.219593582034, 878.9868151977726, 885.9822803543925, 886.007671408024, 887.5961437545933, 888.1828717579842, 868.431177578687, 870.851955167623, 876.0538618292229, 876.5792419638609, 877.4209022045419, 638.1735652330198, 645.8288553533317, 645.8385403649088, 648.0344287012317, 650.7559665125578, 12862.421191046426, 12993.935030324788, 13225.470981160743, 13371.26458044807, 13381.330933453386, 12916.41876115577, 13033.674158146123, 13062.804057939138, 13303.800442993363, 13596.456141754317, 9126.178643922012, 9372.484513351763, 9440.433573985583, 9559.283053770925, 9568.712938611852, 2449.2529778417575, 2472.1471092473066, 2502.7121880983555, 2507.962380564293, 2583.3929026678716, 47985.04029919417, 48889.26666100011, 49667.50332496665, 50251.24623130656, 50991.0, 9908.900910990942, 10054.64808731691, 10127.59489620407, 10198.847017294747, 10211.869459792515, 19154.233830646896, 19158.71261931072, 19381.806181938282, 19455.805441945682, 19679.803201967796, 6397.968010160012, 6546.345365463416, 6568.408843204134, 6573.737050517926, 6790.287019862942, 3346.6486018968144, 3401.9149521262166, 3419.6238413774463, 3461.3769521486374, 3533.8586456541966, 3434.3303055903857, 3458.239187378773, 3463.9307213856086, 3470.201853573692, 3517.1558825882116, 644.7421031587309, 648.740503798475, 649.7238673563717, 665.0987911380107, 670.4334837062675, 501.2456253338702, 524.6327570700448, 525.4062908912904, 530.1808705549935, 537.6397318732234, 8144.633491492897, 8402.789930251793, 8497.957510212533, 8543.829123417498, 8734.620227437177, 491.6582974832457, 495.09891996565904, 496.6275293529853, 503.8866255092575, 505.9215821547666, 3783.0920579060826, 3840.251151025579, 3863.2466668999277, 3921.862734804325, 4093.3655283431117, 62745.0, 63575.0, 63625.363746361945, 64810.35189648043, 64984.0, 42287.78856105761, 45447.77276113664, 45636.0, 52779.0, 54496.72751636296, 39532.604673953465, 40952.1809563813, 42445.57554424416, 42619.57380426156, 43228.0, 9089.227415669478, 9621.326507144433, 9630.229581633312, 9677.225821934087, 9697.709068727949, 24621.876890615433, 25023.749762502142, 25172.874135629936, 25426.491470170862, 25949.35126621774, 31267.84366078246, 31281.8435907819, 31421.0, 31756.523652145697, 31812.5228121583, 11853.111016673956, 11856.22934509254, 11921.34432606215, 11924.523019079139, 12001.0, 11980.820287695517, 12252.816207757069, 12424.34692215058, 12512.434950835239, 13082.672933176747, 11098.889011109786, 11410.372429516456, 12052.337121458404, 12252.693682658004, 13098.2141071536, 11562.595309164139, 11824.172307938361, 11972.32796922671, 12115.697107572381, 12742.0, 11184.0, 11415.258008229439, 11443.427828608703, 11711.590094346657, 11718.945294923156, 8387.203215694499, 8436.704715334934, 8685.696000639948, 8723.607437665194, 8854.690085846965, 9440.622375104918, 9474.478903660365, 9541.809163816546, 9569.904300956901, 9623.56693948788], "value": 6021.6127936720895, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1572.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 112.0, 113.0, 113.0, 112.0, 112.0, 114.0, 113.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 127.0, 125.0, 164.0, 124.0, 125.0, 125.0, 127.0, 150.0, 126.0], "value": 134.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 166.0, 172.0, 177.0, 164.0, 163.0, 163.0, 163.0, 163.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 74.0, 75.0, 118.0, 77.0, 76.0, 77.0, 76.0, 101.0, 76.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 105.0, 86.0, 84.0, 83.0, 99.0, 84.0, 83.0, 107.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 113.0, 115.0, 114.0, 117.0, 114.0, 113.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 151.0, 150.0, 150.0, 151.0, 151.0, 152.0, 151.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 98.0, 94.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 66.0, 69.0, 76.0, 69.0, 69.0, 69.0, 69.0, 69.0], "value": 69.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 55.0, 55.0, 54.0, 56.0, 57.0, 56.0, 55.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 93.0, 95.0, 92.0, 86.0, 84.0, 85.0, 85.0, 84.0, 84.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 136.0, 140.0, 133.0, 134.0, 138.0, 134.0, 140.0, 185.0, 150.0], "value": 142.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 197.0, 197.0, 201.0, 204.0, 203.0, 197.0, 201.0, 204.0, 197.0], "value": 199.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 72.0, 72.0, 75.0, 76.0, 71.0, 75.0, 71.0, 70.0], "value": 73.1, "unit": "score"}]}]} 07:18:20 INFO - Return code: 0 07:18:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:18:20 ERROR - # TBPL SUCCESS # 07:18:20 INFO - Running post-action listener: _resource_record_post_action 07:18:20 INFO - [mozharness: 2017-03-23 14:18:20.961274Z] Finished run-tests step (success) 07:18:20 INFO - Running post-run listener: _resource_record_post_run 07:18:21 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 361267200; Read time: 28; Write time: 324348 07:18:21 INFO - TinderboxPrint: CPU usage
13.3% 07:18:21 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 28 07:18:21 INFO - TinderboxPrint: I/O write bytes / time
361,267,200 / 324,348 07:18:21 INFO - TinderboxPrint: CPU idle
8,320.7 (86.7%) 07:18:21 INFO - TinderboxPrint: CPU user
1,219.6 (12.7%) 07:18:21 INFO - TinderboxPrint: Swap in / out
0 / 0 07:18:21 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105877504; Read time: 0; Write time: 121392 07:18:21 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 255066112; Read time: 28; Write time: 202928 07:18:21 INFO - Running post-run listener: _upload_blobber_files 07:18:21 INFO - Blob upload gear active. 07:18:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:18:21 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 07:18:21 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'] 07:18:21 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 07:18:22 INFO - (blobuploader) - INFO - Open directory for files ... 07:18:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:18:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:18:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:25 INFO - (blobuploader) - INFO - Done attempting. 07:18:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:18:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:18:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:26 INFO - (blobuploader) - INFO - Done attempting. 07:18:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:18:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:18:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:27 INFO - (blobuploader) - INFO - Done attempting. 07:18:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:18:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:18:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:27 INFO - (blobuploader) - INFO - Done attempting. 07:18:27 INFO - (blobuploader) - INFO - Iteration through files over. 07:18:28 INFO - Return code: 0 07:18:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:18:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:18:28 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/347b93b1f4f54a5de8e1697cf68fd4e7fb211ea546ea225aa16dc42f31a8e2754ca36ea717657f15b29e465db2b1b6173ae308c9faf9077da21f08db0b182580", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d58922492ab965454ebee3f06e73f3beaadc2f38f716431baa6298a1ed06b67bbe1b634aeb5a06cabc2b1a7d7fa29ee1520bf13796181d36743dff0debf4c2b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/516e3ebaa0bf34dac09fb98de2c00b8089cbd6f983345bcce48fc2816faf2af6f71e94c6d5368c1acec57580f0789c1b8ba5c9a926177986229c7710083eeb1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/651a48c39d251a9c7a53e557ef1688b44bf15c807c48211a3aaaf476c657448c42f464d75bd61c6f39e784ddb194cf4a8a19b4fe2779124a7c40ef3c1bafae63"} 07:18:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:18:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:18:28 INFO - Contents: 07:18:28 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/347b93b1f4f54a5de8e1697cf68fd4e7fb211ea546ea225aa16dc42f31a8e2754ca36ea717657f15b29e465db2b1b6173ae308c9faf9077da21f08db0b182580", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d58922492ab965454ebee3f06e73f3beaadc2f38f716431baa6298a1ed06b67bbe1b634aeb5a06cabc2b1a7d7fa29ee1520bf13796181d36743dff0debf4c2b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/516e3ebaa0bf34dac09fb98de2c00b8089cbd6f983345bcce48fc2816faf2af6f71e94c6d5368c1acec57580f0789c1b8ba5c9a926177986229c7710083eeb1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/651a48c39d251a9c7a53e557ef1688b44bf15c807c48211a3aaaf476c657448c42f464d75bd61c6f39e784ddb194cf4a8a19b4fe2779124a7c40ef3c1bafae63"} 07:18:28 INFO - Running post-run listener: copy_logs_to_upload_dir 07:18:28 INFO - Copying logs to upload dir... 07:18:28 INFO - mkdir: /builds/slave/test/build/upload/logs 07:18:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.937422 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-23 07:18:27.576648) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 07:18:27.580397) ========= 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=0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/347b93b1f4f54a5de8e1697cf68fd4e7fb211ea546ea225aa16dc42f31a8e2754ca36ea717657f15b29e465db2b1b6173ae308c9faf9077da21f08db0b182580", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d58922492ab965454ebee3f06e73f3beaadc2f38f716431baa6298a1ed06b67bbe1b634aeb5a06cabc2b1a7d7fa29ee1520bf13796181d36743dff0debf4c2b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/516e3ebaa0bf34dac09fb98de2c00b8089cbd6f983345bcce48fc2816faf2af6f71e94c6d5368c1acec57580f0789c1b8ba5c9a926177986229c7710083eeb1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/651a48c39d251a9c7a53e557ef1688b44bf15c807c48211a3aaaf476c657448c42f464d75bd61c6f39e784ddb194cf4a8a19b4fe2779124a7c40ef3c1bafae63"} build_url:https://queue.taskcluster.net/v1/task/AdQ6ImFxRnyZb_jkjM3hHQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011341 build_url: 'https://queue.taskcluster.net/v1/task/AdQ6ImFxRnyZb_jkjM3hHQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/347b93b1f4f54a5de8e1697cf68fd4e7fb211ea546ea225aa16dc42f31a8e2754ca36ea717657f15b29e465db2b1b6173ae308c9faf9077da21f08db0b182580", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d58922492ab965454ebee3f06e73f3beaadc2f38f716431baa6298a1ed06b67bbe1b634aeb5a06cabc2b1a7d7fa29ee1520bf13796181d36743dff0debf4c2b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/516e3ebaa0bf34dac09fb98de2c00b8089cbd6f983345bcce48fc2816faf2af6f71e94c6d5368c1acec57580f0789c1b8ba5c9a926177986229c7710083eeb1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/651a48c39d251a9c7a53e557ef1688b44bf15c807c48211a3aaaf476c657448c42f464d75bd61c6f39e784ddb194cf4a8a19b4fe2779124a7c40ef3c1bafae63"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 07:18:27.611837) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 07:18:27.612362) ========= 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=0a54c299e5ca1d63338479f2000001b5-1490275309.893567-1564407240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004401 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 07:18:27.696754) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 07:18:27.697055) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 07:18:27.697345) ========= ========= Total master_lag: 0.17 =========