builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-086 starttime: 1494419482.11 results: success (0) revision: f8d40e7fe132b7c73a8f610484b790e6063006e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 05:31:22.108240) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 05:31:22.108716) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 05:31:22.108998) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 05:31:22.133153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 05:31:22.133421) ========= 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=438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-10 05:31:22-- 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% 37.2M=0s 2017-05-10 05:31:23 (37.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131837 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 05:31:22.281891) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 05:31:22.282197) ========= 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=438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018369 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 05:31:22.331270) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 05:31:22.331611) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f8d40e7fe132b7c73a8f610484b790e6063006e3 --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 f8d40e7fe132b7c73a8f610484b790e6063006e3 --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=438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-10 05:31:23,185 truncating revision to first 12 chars 2017-05-10 05:31:23,186 Setting DEBUG logging. 2017-05-10 05:31:23,186 attempt 1/10 2017-05-10 05:31:23,186 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f8d40e7fe132?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-10 05:31:23,860 unpacking tar archive at: mozilla-central-f8d40e7fe132/testing/mozharness/ program finished with exit code 0 elapsedTime=0.978866 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 05:31:23.325995) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 05:31:23.326401) ========= script_repo_revision: f8d40e7fe132b7c73a8f610484b790e6063006e3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 05:31:23.327072) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 05:31:23.327426) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 05:31:23.337900) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-05-10 05:31:23.338182) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:31:24 INFO - MultiFileLogger online at 20170510 05:31:24 in /builds/slave/test 05:31:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 05:31:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:31:24 INFO - {'append_to_log': False, 05:31:24 INFO - 'base_work_dir': '/builds/slave/test', 05:31:24 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:31:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:31:24 INFO - 'branch': 'Firefox-Non-PGO', 05:31:24 INFO - 'buildbot_json_path': 'buildprops.json', 05:31:24 INFO - 'config_files': ('talos/linux_config.py',), 05:31:24 INFO - 'default_actions': ('clobber', 05:31:24 INFO - 'read-buildbot-config', 05:31:24 INFO - 'download-and-extract', 05:31:24 INFO - 'populate-webroot', 05:31:24 INFO - 'create-virtualenv', 05:31:24 INFO - 'install', 05:31:24 INFO - 'run-tests'), 05:31:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:31:24 INFO - 'download_minidump_stackwalk': True, 05:31:24 INFO - 'download_symbols': 'ondemand', 05:31:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:31:24 INFO - 'tooltool.py': '/tools/tooltool.py', 05:31:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:31:24 INFO - '/tools/misc-python/virtualenv.py')}, 05:31:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:31:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:31:24 INFO - 'gecko_profile': False, 05:31:24 INFO - 'gecko_profile_interval': 0, 05:31:24 INFO - 'installer_path': 'installer.exe', 05:31:24 INFO - 'log_level': 'info', 05:31:24 INFO - 'log_name': 'talos', 05:31:24 INFO - 'log_to_console': True, 05:31:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:31:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:31:24 INFO - 'opt_config_files': (), 05:31:24 INFO - 'pip_index': False, 05:31:24 INFO - 'suite': 'dromaeojs', 05:31:24 INFO - 'system_bits': '32', 05:31:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:31:24 INFO - 'title': 'talos-linux64-ix-086', 05:31:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:31:24 INFO - 'use_talos_json': True, 05:31:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:31:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:31:24 INFO - 'work_dir': 'build'} 05:31:24 INFO - [mozharness: 2017-05-10 12:31:24.293261Z] Running clobber step. 05:31:24 INFO - Running pre-action listener: _resource_record_pre_action 05:31:24 INFO - Running main action method: clobber 05:31:24 INFO - rmtree: /builds/slave/test/build 05:31:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:31:25 INFO - Running post-action listener: _resource_record_post_action 05:31:25 INFO - [mozharness: 2017-05-10 12:31:25.238507Z] Finished clobber step (success) 05:31:25 INFO - [mozharness: 2017-05-10 12:31:25.238607Z] Running read-buildbot-config step. 05:31:25 INFO - Running pre-action listener: _resource_record_pre_action 05:31:25 INFO - Running main action method: read_buildbot_config 05:31:25 INFO - Using buildbot properties: 05:31:25 INFO - { 05:31:25 INFO - "project": "", 05:31:25 INFO - "product": "firefox", 05:31:25 INFO - "who": "cbook@mozilla.com", 05:31:25 INFO - "installer_path": "public/build/target.tar.bz2", 05:31:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:31:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:31:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 05:31:25 INFO - "stage_platform": "linux64", 05:31:25 INFO - "basedir": "/builds/slave/test", 05:31:25 INFO - "buildnumber": 1141, 05:31:25 INFO - "platform": "ubuntu64_hw", 05:31:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:31:25 INFO - "slavebuilddir": "test", 05:31:25 INFO - "taskId": "Q_MBz3YSRz6flJXewJjLwg", 05:31:25 INFO - "branch": "mozilla-central", 05:31:25 INFO - "script_repo_revision": "production", 05:31:25 INFO - "revision": "f8d40e7fe132b7c73a8f610484b790e6063006e3", 05:31:25 INFO - "slavename": "talos-linux64-ix-086", 05:31:25 INFO - "repo_path": "mozilla-central" 05:31:25 INFO - } 05:31:25 INFO - Finding installer, test and symbols from parent task. 05:31:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q_MBz3YSRz6flJXewJjLwg'}, attempt #1 05:31:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q_MBz3YSRz6flJXewJjLwg'}, attempt #1 05:31:26 INFO - Task dependencies: QgSKW6CSQ3GvM-OoRtGyXw 05:31:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QgSKW6CSQ3GvM-OoRtGyXw'}, attempt #1 05:31:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QgSKW6CSQ3GvM-OoRtGyXw/artifacts/public/build/target.tar.bz2 05:31:26 INFO - Set test_url: https://queue.taskcluster.net/v1/task/QgSKW6CSQ3GvM-OoRtGyXw/artifacts/public/build/test_packages.json 05:31:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QgSKW6CSQ3GvM-OoRtGyXw/artifacts/public/build/target.crashreporter-symbols.zip 05:31:26 INFO - Running post-action listener: _resource_record_post_action 05:31:26 INFO - [mozharness: 2017-05-10 12:31:26.588902Z] Finished read-buildbot-config step (success) 05:31:26 INFO - [mozharness: 2017-05-10 12:31:26.589122Z] Running download-and-extract step. 05:31:26 INFO - Running pre-action listener: _resource_record_pre_action 05:31:26 INFO - Running main action method: download_and_extract 05:31:26 INFO - mkdir: /builds/slave/test/build/tests 05:31:26 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')]} 05:31:26 INFO - trying https://queue.taskcluster.net/v1/task/QgSKW6CSQ3GvM-OoRtGyXw/artifacts/public/build/target.test_packages.json 05:31:26 INFO - Downloading https://queue.taskcluster.net/v1/task/QgSKW6CSQ3GvM-OoRtGyXw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:31:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QgSKW6CSQ3GvM-OoRtGyXw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:31:27 INFO - Downloaded 986 bytes. 05:31:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:31:27 INFO - Using the following test package requirements: 05:31:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:31:27 INFO - u'common': [u'target.common.tests.zip'], 05:31:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:31:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:31:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:31:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:31:27 INFO - u'mozbase': [u'target.common.tests.zip'], 05:31:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:31:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:31:27 INFO - u'web-platform': [u'target.common.tests.zip', 05:31:27 INFO - u'target.web-platform.tests.zip'], 05:31:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:31:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:31:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QgSKW6CSQ3GvM-OoRtGyXw/artifacts/public/build/target.common.tests.zip 05:31:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QgSKW6CSQ3GvM-OoRtGyXw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:31:27 INFO - Fetch https://queue.taskcluster.net/v1/task/QgSKW6CSQ3GvM-OoRtGyXw/artifacts/public/build/target.common.tests.zip into memory 05:31:28 INFO - Content-Length response header: 58446244 05:31:28 INFO - Bytes received: 58446244 05:31:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:31:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QgSKW6CSQ3GvM-OoRtGyXw/artifacts/public/build/target.common.tests.zip 05:31:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QgSKW6CSQ3GvM-OoRtGyXw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:31:38 INFO - Fetch https://queue.taskcluster.net/v1/task/QgSKW6CSQ3GvM-OoRtGyXw/artifacts/public/build/target.common.tests.zip into memory 05:31:40 INFO - Content-Length response header: 58446244 05:31:40 INFO - Bytes received: 58446244 05:31:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QgSKW6CSQ3GvM-OoRtGyXw/artifacts/public/build/target.talos.tests.zip 05:31:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QgSKW6CSQ3GvM-OoRtGyXw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:31:50 INFO - Fetch https://queue.taskcluster.net/v1/task/QgSKW6CSQ3GvM-OoRtGyXw/artifacts/public/build/target.talos.tests.zip into memory 05:31:52 INFO - Content-Length response header: 14409362 05:31:52 INFO - Bytes received: 14409362 05:31: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')]} 05:31:52 INFO - trying https://queue.taskcluster.net/v1/task/QgSKW6CSQ3GvM-OoRtGyXw/artifacts/public/build/target.tar.bz2 05:31:52 INFO - Downloading https://queue.taskcluster.net/v1/task/QgSKW6CSQ3GvM-OoRtGyXw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:31:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QgSKW6CSQ3GvM-OoRtGyXw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:31:55 INFO - Downloaded 63002924 bytes. 05:31:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QgSKW6CSQ3GvM-OoRtGyXw/artifacts/public/build/target.tar.bz2 05:31:55 INFO - mkdir: /builds/slave/test/properties 05:31:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:31:55 INFO - Writing to file /builds/slave/test/properties/build_url 05:31:55 INFO - Contents: 05:31:55 INFO - build_url:https://queue.taskcluster.net/v1/task/QgSKW6CSQ3GvM-OoRtGyXw/artifacts/public/build/target.tar.bz2 05:31:55 INFO - Running post-action listener: _resource_record_post_action 05:31:55 INFO - Running post-action listener: set_extra_try_arguments 05:31:55 INFO - [mozharness: 2017-05-10 12:31:55.728017Z] Finished download-and-extract step (success) 05:31:55 INFO - [mozharness: 2017-05-10 12:31:55.728206Z] Running populate-webroot step. 05:31:55 INFO - Running pre-action listener: _resource_record_pre_action 05:31:55 INFO - Running main action method: populate_webroot 05:31:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:31:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:31:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:31:55 INFO - '--tppagecycles', 05:31:55 INFO - '7'], 05:31:55 INFO - 'tests': ['tsvgm']}}, 05:31:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:31:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:31:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:31:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:31:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:31:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:31:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:31:55 INFO - 'talos_options': ['--disable-e10s'], 05:31:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:31:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:31:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:31:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:31:55 INFO - 'talos_options': ['--disable-e10s'], 05:31:55 INFO - 'tests': ['damp', 'tps']}, 05:31:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:31:55 INFO - 'tests': ['damp', 'tps']}, 05:31:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:31:55 INFO - 'tests': ['dromaeo_dom']}, 05:31:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:31:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:31:55 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:31:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:31:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:31:55 INFO - 'tests': ['a11yr', 05:31:55 INFO - 'ts_paint', 05:31:55 INFO - 'tpaint', 05:31:55 INFO - 'sessionrestore', 05:31:55 INFO - 'sessionrestore_no_auto_restore', 05:31:55 INFO - 'tabpaint']}, 05:31:55 INFO - 'other-e10s': {'tests': ['a11yr', 05:31:55 INFO - 'ts_paint', 05:31:55 INFO - 'tpaint', 05:31:55 INFO - 'sessionrestore', 05:31:55 INFO - 'sessionrestore_no_auto_restore', 05:31:55 INFO - 'tabpaint']}, 05:31:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:31:55 INFO - 'ts_paint', 05:31:55 INFO - 'tpaint', 05:31:55 INFO - 'sessionrestore', 05:31:55 INFO - 'sessionrestore_no_auto_restore', 05:31:55 INFO - 'tabpaint']}, 05:31:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:31:55 INFO - 'ts_paint', 05:31:55 INFO - 'tpaint', 05:31:55 INFO - 'sessionrestore', 05:31:55 INFO - 'sessionrestore_no_auto_restore', 05:31:55 INFO - 'tabpaint']}, 05:31:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:31:55 INFO - 'tests': ['a11yr', 05:31:55 INFO - 'ts_paint', 05:31:55 INFO - 'tpaint', 05:31:55 INFO - 'sessionrestore', 05:31:55 INFO - 'sessionrestore_no_auto_restore', 05:31:55 INFO - 'tabpaint']}, 05:31:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:31:55 INFO - 'tests': ['a11yr', 05:31:55 INFO - 'ts_paint', 05:31:55 INFO - 'tpaint', 05:31:55 INFO - 'sessionrestore', 05:31:55 INFO - 'sessionrestore_no_auto_restore', 05:31:55 INFO - 'tabpaint']}, 05:31:55 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:31:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:31:55 INFO - 'bloom_basic_ref']}, 05:31:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:31:55 INFO - 'tests': ['tsvgx', 05:31:55 INFO - 'tsvgr_opacity', 05:31:55 INFO - 'tart', 05:31:55 INFO - 'tscrollx', 05:31:55 INFO - 'cart', 05:31:55 INFO - 'tsvg_static']}, 05:31:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:31:55 INFO - 'tsvgr_opacity', 05:31:55 INFO - 'tart', 05:31:55 INFO - 'tscrollx', 05:31:55 INFO - 'cart', 05:31:55 INFO - 'tsvg_static']}, 05:31:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:31:55 INFO - 'talos_options': ['--disable-e10s'], 05:31:55 INFO - 'tests': ['tp5o']}, 05:31:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:31:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:31:55 INFO - 'talos_options': ['--disable-e10s', 05:31:55 INFO - '--xperf_path', 05:31:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:31:55 INFO - 'tests': ['tp5n']}, 05:31:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:31:55 INFO - 'talos_options': ['--xperf_path', 05:31:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:31:55 INFO - 'tests': ['tp5n']}}, 05:31:55 INFO - 'talos.zip': {'path': '', 05:31:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:31:55 INFO - Running post-action listener: _resource_record_post_action 05:31:55 INFO - [mozharness: 2017-05-10 12:31:55.742781Z] Finished populate-webroot step (success) 05:31:55 INFO - [mozharness: 2017-05-10 12:31:55.742870Z] Running create-virtualenv step. 05:31:55 INFO - Running pre-action listener: _resource_record_pre_action 05:31:55 INFO - Running main action method: create_virtualenv 05:31:55 INFO - Creating virtualenv /builds/slave/test/build/venv 05:31:55 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:31:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:31:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:31:55 INFO - Using real prefix '/usr' 05:31:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:31:56 INFO - Installing distribute.............................................................................................................................................................................................done. 05:31:58 INFO - Installing pip.................done. 05:31:58 INFO - Return code: 0 05:31:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:31:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:31:58 INFO - Reading from file tmpfile_stdout 05:31:58 INFO - Output received: 05:31:58 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) 05:31:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2944770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2941a30>, '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 0x29427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2942ca0>, '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': '438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038', '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 05:31:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:31:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:31:58 INFO - Using env: {'DISPLAY': ':0', 05:31:58 INFO - 'HOME': '/home/cltbld', 05:31:58 INFO - 'LANG': 'en_US.UTF-8', 05:31:58 INFO - 'LANGUAGE': 'en_US:en', 05:31:58 INFO - 'LOGNAME': 'cltbld', 05:31:58 INFO - 'MAIL': '/var/mail/cltbld', 05:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:58 INFO - 'MOZ_NO_REMOTE': '1', 05:31:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:58 INFO - 'NO_EM_RESTART': '1', 05:31:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:58 INFO - 'PWD': '/builds/slave/test', 05:31:58 INFO - 'SHELL': '/bin/bash', 05:31:58 INFO - 'SHLVL': '1', 05:31:58 INFO - 'TERM': 'linux', 05:31:58 INFO - 'TMOUT': '86400', 05:31:58 INFO - 'USER': 'cltbld', 05:31:58 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038', 05:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:58 INFO - '_': '/tools/buildbot/bin/python'} 05:31:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:31:58 INFO - Cleaning up... 05:31:58 INFO - Return code: 0 05:31:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2944770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2941a30>, '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 0x29427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2942ca0>, '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': '438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038', '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 05:31:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:31:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:31:58 INFO - Using env: {'DISPLAY': ':0', 05:31:58 INFO - 'HOME': '/home/cltbld', 05:31:58 INFO - 'LANG': 'en_US.UTF-8', 05:31:58 INFO - 'LANGUAGE': 'en_US:en', 05:31:58 INFO - 'LOGNAME': 'cltbld', 05:31:58 INFO - 'MAIL': '/var/mail/cltbld', 05:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:58 INFO - 'MOZ_NO_REMOTE': '1', 05:31:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:58 INFO - 'NO_EM_RESTART': '1', 05:31:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:58 INFO - 'PWD': '/builds/slave/test', 05:31:58 INFO - 'SHELL': '/bin/bash', 05:31:58 INFO - 'SHLVL': '1', 05:31:58 INFO - 'TERM': 'linux', 05:31:58 INFO - 'TMOUT': '86400', 05:31:58 INFO - 'USER': 'cltbld', 05:31:58 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038', 05:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:58 INFO - '_': '/tools/buildbot/bin/python'} 05:31:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:58 INFO - Downloading/unpacking psutil>=3.1.1 05:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:32:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:00 INFO - Installing collected packages: psutil 05:32:00 INFO - Running setup.py install for psutil 05:32:00 INFO - building 'psutil._psutil_linux' extension 05:32:00 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 05:32:00 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 05:32:00 INFO - building 'psutil._psutil_posix' extension 05:32:00 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 05:32:00 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 05:32:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:00 INFO - Successfully installed psutil 05:32:00 INFO - Cleaning up... 05:32:00 INFO - Return code: 0 05:32:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2944770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2941a30>, '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 0x29427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2942ca0>, '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': '438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038', '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 05:32:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:32:00 INFO - Using env: {'DISPLAY': ':0', 05:32:00 INFO - 'HOME': '/home/cltbld', 05:32:00 INFO - 'LANG': 'en_US.UTF-8', 05:32:00 INFO - 'LANGUAGE': 'en_US:en', 05:32:00 INFO - 'LOGNAME': 'cltbld', 05:32:00 INFO - 'MAIL': '/var/mail/cltbld', 05:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:00 INFO - 'MOZ_NO_REMOTE': '1', 05:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:00 INFO - 'NO_EM_RESTART': '1', 05:32:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:00 INFO - 'PWD': '/builds/slave/test', 05:32:00 INFO - 'SHELL': '/bin/bash', 05:32:00 INFO - 'SHLVL': '1', 05:32:00 INFO - 'TERM': 'linux', 05:32:00 INFO - 'TMOUT': '86400', 05:32:00 INFO - 'USER': 'cltbld', 05:32:00 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038', 05:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:00 INFO - '_': '/tools/buildbot/bin/python'} 05:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:32:00 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 05:32:00 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 05:32:00 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 05:32:00 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 05:32:00 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 05:32:00 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 05:32:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:32:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:32:02 INFO - Installing collected packages: mozsystemmonitor 05:32:02 INFO - Running setup.py install for mozsystemmonitor 05:32:02 INFO - Successfully installed mozsystemmonitor 05:32:02 INFO - Cleaning up... 05:32:02 INFO - Return code: 0 05:32:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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 0x25d21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2944770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2941a30>, '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 0x29427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2942ca0>, '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': '438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038', '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 05:32: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 05:32: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 05:32:02 INFO - Using env: {'DISPLAY': ':0', 05:32:02 INFO - 'HOME': '/home/cltbld', 05:32:02 INFO - 'LANG': 'en_US.UTF-8', 05:32:02 INFO - 'LANGUAGE': 'en_US:en', 05:32:02 INFO - 'LOGNAME': 'cltbld', 05:32:02 INFO - 'MAIL': '/var/mail/cltbld', 05:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:02 INFO - 'MOZ_NO_REMOTE': '1', 05:32:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:02 INFO - 'NO_EM_RESTART': '1', 05:32:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:02 INFO - 'PWD': '/builds/slave/test', 05:32:02 INFO - 'SHELL': '/bin/bash', 05:32:02 INFO - 'SHLVL': '1', 05:32:02 INFO - 'TERM': 'linux', 05:32:02 INFO - 'TMOUT': '86400', 05:32:02 INFO - 'USER': 'cltbld', 05:32:02 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038', 05:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:02 INFO - '_': '/tools/buildbot/bin/python'} 05:32:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:02 INFO - Downloading/unpacking jsonschema==2.5.1 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:32:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:03 INFO - Downloading functools32-3.2.3-2.tar.gz 05:32:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:32:03 INFO - warning: no files found matching '*.txt' 05:32:03 INFO - no previously-included directories found matching 'build' 05:32:03 INFO - no previously-included directories found matching 'dist' 05:32:03 INFO - no previously-included directories found matching '.git*' 05:32:03 INFO - Installing collected packages: jsonschema, functools32 05:32:03 INFO - Running setup.py install for functools32 05:32:03 INFO - warning: no files found matching '*.txt' 05:32:03 INFO - no previously-included directories found matching 'build' 05:32:03 INFO - no previously-included directories found matching 'dist' 05:32:03 INFO - no previously-included directories found matching '.git*' 05:32:03 INFO - Successfully installed jsonschema functools32 05:32:03 INFO - Cleaning up... 05:32:03 INFO - Return code: 0 05:32:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2944770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2941a30>, '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 0x29427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2942ca0>, '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': '438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038', '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 05:32:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:32:03 INFO - Using env: {'DISPLAY': ':0', 05:32:03 INFO - 'HOME': '/home/cltbld', 05:32:03 INFO - 'LANG': 'en_US.UTF-8', 05:32:03 INFO - 'LANGUAGE': 'en_US:en', 05:32:03 INFO - 'LOGNAME': 'cltbld', 05:32:03 INFO - 'MAIL': '/var/mail/cltbld', 05:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:03 INFO - 'MOZ_NO_REMOTE': '1', 05:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:03 INFO - 'NO_EM_RESTART': '1', 05:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:03 INFO - 'PWD': '/builds/slave/test', 05:32:03 INFO - 'SHELL': '/bin/bash', 05:32:03 INFO - 'SHLVL': '1', 05:32:03 INFO - 'TERM': 'linux', 05:32:03 INFO - 'TMOUT': '86400', 05:32:03 INFO - 'USER': 'cltbld', 05:32:03 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038', 05:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:03 INFO - '_': '/tools/buildbot/bin/python'} 05:32:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:32:04 INFO - Cleaning up... 05:32:04 INFO - Return code: 0 05:32:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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', '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 0x25d21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2944770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2941a30>, '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 0x29427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2942ca0>, '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': '438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038', '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 05:32: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:32: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 blobuploader==1.2.4 05:32:04 INFO - Using env: {'DISPLAY': ':0', 05:32:04 INFO - 'HOME': '/home/cltbld', 05:32:04 INFO - 'LANG': 'en_US.UTF-8', 05:32:04 INFO - 'LANGUAGE': 'en_US:en', 05:32:04 INFO - 'LOGNAME': 'cltbld', 05:32:04 INFO - 'MAIL': '/var/mail/cltbld', 05:32:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:04 INFO - 'MOZ_NO_REMOTE': '1', 05:32:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:04 INFO - 'NO_EM_RESTART': '1', 05:32:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:04 INFO - 'PWD': '/builds/slave/test', 05:32:04 INFO - 'SHELL': '/bin/bash', 05:32:04 INFO - 'SHLVL': '1', 05:32:04 INFO - 'TERM': 'linux', 05:32:04 INFO - 'TMOUT': '86400', 05:32:04 INFO - 'USER': 'cltbld', 05:32:04 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038', 05:32:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:04 INFO - '_': '/tools/buildbot/bin/python'} 05:32:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:04 INFO - Downloading/unpacking blobuploader==1.2.4 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32:05 INFO - Downloading blobuploader-1.2.4.tar.gz 05:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:32:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:32:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32:06 INFO - Downloading docopt-0.6.1.tar.gz 05:32:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:32:06 INFO - Installing collected packages: blobuploader, requests, docopt 05:32:06 INFO - Running setup.py install for blobuploader 05:32:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:32:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:32:06 INFO - Running setup.py install for requests 05:32:06 INFO - Running setup.py install for docopt 05:32:06 INFO - Successfully installed blobuploader requests docopt 05:32:06 INFO - Cleaning up... 05:32:06 INFO - Return code: 0 05:32:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:06 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 0x25d21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2944770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2941a30>, '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 0x29427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2942ca0>, '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': '438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038', '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 05:32:06 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 05:32:06 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 05:32:06 INFO - Using env: {'DISPLAY': ':0', 05:32:06 INFO - 'HOME': '/home/cltbld', 05:32:06 INFO - 'LANG': 'en_US.UTF-8', 05:32:06 INFO - 'LANGUAGE': 'en_US:en', 05:32:06 INFO - 'LOGNAME': 'cltbld', 05:32:06 INFO - 'MAIL': '/var/mail/cltbld', 05:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:06 INFO - 'MOZ_NO_REMOTE': '1', 05:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:06 INFO - 'NO_EM_RESTART': '1', 05:32:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:06 INFO - 'PWD': '/builds/slave/test', 05:32:06 INFO - 'SHELL': '/bin/bash', 05:32:06 INFO - 'SHLVL': '1', 05:32:06 INFO - 'TERM': 'linux', 05:32:06 INFO - 'TMOUT': '86400', 05:32:06 INFO - 'USER': 'cltbld', 05:32:06 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038', 05:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:06 INFO - '_': '/tools/buildbot/bin/python'} 05:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:06 INFO - Running setup.py (path:/tmp/pip-7dF8lq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:07 INFO - Running setup.py (path:/tmp/pip-WXVgyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:07 INFO - Running setup.py (path:/tmp/pip-N40fLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:07 INFO - Running setup.py (path:/tmp/pip-YRS39N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:07 INFO - Running setup.py (path:/tmp/pip-rtQCo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:07 INFO - Running setup.py (path:/tmp/pip-KxJLsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:07 INFO - Running setup.py (path:/tmp/pip-Hk1iFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:07 INFO - Running setup.py (path:/tmp/pip-svhP0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:07 INFO - Running setup.py (path:/tmp/pip-kjnVia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:07 INFO - Running setup.py (path:/tmp/pip-HWJwiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:07 INFO - Running setup.py (path:/tmp/pip-OQJqZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:07 INFO - Running setup.py (path:/tmp/pip-oQ24lF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:07 INFO - Running setup.py (path:/tmp/pip-Jl5m8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:07 INFO - Running setup.py (path:/tmp/pip-MVTLjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:07 INFO - Running setup.py (path:/tmp/pip-Fv4CT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:08 INFO - Running setup.py (path:/tmp/pip-spucQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:08 INFO - Running setup.py (path:/tmp/pip-hCkBOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:32:08 INFO - Running setup.py install for manifestparser 05:32:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:32:08 INFO - Running setup.py install for mozcrash 05:32:08 INFO - Running setup.py install for mozdebug 05:32:08 INFO - Running setup.py install for mozdevice 05:32:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:32:08 INFO - Running setup.py install for mozfile 05:32:08 INFO - Running setup.py install for mozhttpd 05:32:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:32:08 INFO - Running setup.py install for mozinfo 05:32:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:32:08 INFO - Running setup.py install for mozInstall 05:32:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:32:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:32:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:32:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:32:09 INFO - Running setup.py install for mozleak 05:32:09 INFO - Running setup.py install for mozlog 05:32:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:32:09 INFO - Running setup.py install for moznetwork 05:32:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:32:09 INFO - Running setup.py install for mozprocess 05:32:09 INFO - Running setup.py install for mozprofile 05:32:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:32:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:32:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:32:09 INFO - Running setup.py install for mozrunner 05:32:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:32:09 INFO - Running setup.py install for mozscreenshot 05:32:09 INFO - Running setup.py install for moztest 05:32:09 INFO - Running setup.py install for mozversion 05:32:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:32:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:32:09 INFO - Cleaning up... 05:32:10 INFO - Return code: 0 05:32:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2944770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2941a30>, '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 0x29427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2942ca0>, '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': '438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038', '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 05:32:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:32:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:32:10 INFO - Using env: {'DISPLAY': ':0', 05:32:10 INFO - 'HOME': '/home/cltbld', 05:32:10 INFO - 'LANG': 'en_US.UTF-8', 05:32:10 INFO - 'LANGUAGE': 'en_US:en', 05:32:10 INFO - 'LOGNAME': 'cltbld', 05:32:10 INFO - 'MAIL': '/var/mail/cltbld', 05:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:10 INFO - 'MOZ_NO_REMOTE': '1', 05:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:10 INFO - 'NO_EM_RESTART': '1', 05:32:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:10 INFO - 'PWD': '/builds/slave/test', 05:32:10 INFO - 'SHELL': '/bin/bash', 05:32:10 INFO - 'SHLVL': '1', 05:32:10 INFO - 'TERM': 'linux', 05:32:10 INFO - 'TMOUT': '86400', 05:32:10 INFO - 'USER': 'cltbld', 05:32:10 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038', 05:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:10 INFO - '_': '/tools/buildbot/bin/python'} 05:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:10 INFO - Running setup.py (path:/tmp/pip-bW_c2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:10 INFO - Running setup.py (path:/tmp/pip-VdLj36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:10 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)) 05:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:10 INFO - Running setup.py (path:/tmp/pip-yUsaDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:10 INFO - Running setup.py (path:/tmp/pip-BHLglj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 05:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:10 INFO - Running setup.py (path:/tmp/pip-OG81Y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:10 INFO - Running setup.py (path:/tmp/pip-wComrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:10 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)) 05:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:10 INFO - Running setup.py (path:/tmp/pip-YFw66b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:10 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)) 05:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:10 INFO - Running setup.py (path:/tmp/pip-3vOJLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:10 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)) 05:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:10 INFO - Running setup.py (path:/tmp/pip-8n4rYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:10 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)) 05:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:10 INFO - Running setup.py (path:/tmp/pip-SCWLHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:10 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)) 05:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:10 INFO - Running setup.py (path:/tmp/pip-1cvwBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:11 INFO - Running setup.py (path:/tmp/pip-6xPEEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:11 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)) 05:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:11 INFO - Running setup.py (path:/tmp/pip-0tMNFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:11 INFO - Running setup.py (path:/tmp/pip-oMy8wM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:11 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)) 05:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:11 INFO - Running setup.py (path:/tmp/pip-8U7_IM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:11 INFO - Running setup.py (path:/tmp/pip-xTaMyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:11 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)) 05:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:11 INFO - Running setup.py (path:/tmp/pip-m229UV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:32:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:12 INFO - Downloading blessings-1.6.tar.gz 05:32:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:32:12 INFO - Installing collected packages: blessings 05:32:12 INFO - Running setup.py install for blessings 05:32:12 INFO - Successfully installed blessings 05:32:12 INFO - Cleaning up... 05:32:12 INFO - Return code: 0 05:32:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:32:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:13 INFO - Reading from file tmpfile_stdout 05:32:13 INFO - Current package versions: 05:32:13 INFO - argparse == 1.2.1 05:32:13 INFO - blessings == 1.6 05:32:13 INFO - blobuploader == 1.2.4 05:32:13 INFO - docopt == 0.6.1 05:32:13 INFO - functools32 == 3.2.3-2 05:32:13 INFO - jsonschema == 2.5.1 05:32:13 INFO - manifestparser == 1.1 05:32:13 INFO - mozInstall == 1.12 05:32:13 INFO - mozcrash == 1.0 05:32:13 INFO - mozdebug == 0.1 05:32:13 INFO - mozdevice == 0.50 05:32:13 INFO - mozfile == 1.2 05:32:13 INFO - mozhttpd == 0.7 05:32:13 INFO - mozinfo == 0.9 05:32:13 INFO - mozleak == 0.1 05:32:13 INFO - mozlog == 3.4 05:32:13 INFO - moznetwork == 0.27 05:32:13 INFO - mozprocess == 0.25 05:32:13 INFO - mozprofile == 0.28 05:32:13 INFO - mozrunner == 6.13 05:32:13 INFO - mozscreenshot == 0.1 05:32:13 INFO - mozsystemmonitor == 0.3 05:32:13 INFO - moztest == 0.8 05:32:13 INFO - mozversion == 1.4 05:32:13 INFO - psutil == 3.1.1 05:32:13 INFO - requests == 1.2.3 05:32:13 INFO - wsgiref == 0.1.2 05:32:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:13 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 0x25d21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2944770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2941a30>, '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 0x29427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2942ca0>, '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': '438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038', '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 05:32:13 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 05:32:13 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 05:32:13 INFO - Using env: {'DISPLAY': ':0', 05:32:13 INFO - 'HOME': '/home/cltbld', 05:32:13 INFO - 'LANG': 'en_US.UTF-8', 05:32:13 INFO - 'LANGUAGE': 'en_US:en', 05:32:13 INFO - 'LOGNAME': 'cltbld', 05:32:13 INFO - 'MAIL': '/var/mail/cltbld', 05:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:13 INFO - 'MOZ_NO_REMOTE': '1', 05:32:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:13 INFO - 'NO_EM_RESTART': '1', 05:32:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:13 INFO - 'PWD': '/builds/slave/test', 05:32:13 INFO - 'SHELL': '/bin/bash', 05:32:13 INFO - 'SHLVL': '1', 05:32:13 INFO - 'TERM': 'linux', 05:32:13 INFO - 'TMOUT': '86400', 05:32:13 INFO - 'USER': 'cltbld', 05:32:13 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038', 05:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:13 INFO - '_': '/tools/buildbot/bin/python'} 05:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:13 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)) 05:32:13 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)) 05:32:13 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)) 05:32:13 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)) 05:32:13 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)) 05:32:13 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)) 05:32:13 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)) 05:32:13 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)) 05:32:13 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)) 05:32:13 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)) 05:32:13 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)) 05:32:13 INFO - Cleaning up... 05:32:13 INFO - Return code: 0 05:32:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:13 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 0x25d21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2944770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2941a30>, '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 0x29427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2942ca0>, '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': '438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038', '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 05:32:13 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 05:32:13 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 05:32:13 INFO - Using env: {'DISPLAY': ':0', 05:32:13 INFO - 'HOME': '/home/cltbld', 05:32:13 INFO - 'LANG': 'en_US.UTF-8', 05:32:13 INFO - 'LANGUAGE': 'en_US:en', 05:32:13 INFO - 'LOGNAME': 'cltbld', 05:32:13 INFO - 'MAIL': '/var/mail/cltbld', 05:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:13 INFO - 'MOZ_NO_REMOTE': '1', 05:32:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:13 INFO - 'NO_EM_RESTART': '1', 05:32:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:13 INFO - 'PWD': '/builds/slave/test', 05:32:13 INFO - 'SHELL': '/bin/bash', 05:32:13 INFO - 'SHLVL': '1', 05:32:13 INFO - 'TERM': 'linux', 05:32:13 INFO - 'TMOUT': '86400', 05:32:13 INFO - 'USER': 'cltbld', 05:32:13 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038', 05:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:13 INFO - '_': '/tools/buildbot/bin/python'} 05:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:32:13 INFO - Cleaning up... 05:32:13 INFO - Return code: 0 05:32:13 INFO - Running post-action listener: _resource_record_post_action 05:32:13 INFO - Running post-action listener: _start_resource_monitoring 05:32:13 INFO - Starting resource monitoring. 05:32:13 INFO - [mozharness: 2017-05-10 12:32:13.540776Z] Finished create-virtualenv step (success) 05:32:13 INFO - [mozharness: 2017-05-10 12:32:13.541293Z] Running install step. 05:32:13 INFO - Running pre-action listener: _resource_record_pre_action 05:32:13 INFO - Running main action method: install 05:32:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:13 INFO - Reading from file tmpfile_stdout 05:32:13 INFO - Detecting whether we're running mozinstall >=1.0... 05:32:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:32:13 INFO - Reading from file tmpfile_stdout 05:32:13 INFO - Output received: 05:32:13 INFO - Usage: mozinstall [options] installer 05:32:13 INFO - Options: 05:32:13 INFO - -h, --help show this help message and exit 05:32:13 INFO - -d DEST, --destination=DEST 05:32:13 INFO - Directory to install application into. [default: 05:32:13 INFO - "/builds/slave/test"] 05:32:13 INFO - --app=APP Application being installed. [default: firefox] 05:32:13 INFO - mkdir: /builds/slave/test/build/application 05:32:13 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'] 05:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:32:29 INFO - Reading from file tmpfile_stdout 05:32:29 INFO - Output received: 05:32:29 INFO - /builds/slave/test/build/application/firefox/firefox 05:32:29 INFO - Running post-action listener: _resource_record_post_action 05:32:29 INFO - [mozharness: 2017-05-10 12:32:29.621643Z] Finished install step (success) 05:32:29 INFO - [mozharness: 2017-05-10 12:32:29.621924Z] Running run-tests step. 05:32:29 INFO - Running pre-action listener: _resource_record_pre_action 05:32:29 INFO - Running main action method: run_tests 05:32:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:32:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:32:29 INFO - Python 2.7.3 05:32:29 INFO - Return code: 0 05:32:29 INFO - grabbing minidump binary from tooltool 05:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:29 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 0x2941a30>, '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 0x29427f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2942ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:32:29 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 05:32:29 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 05:32:29 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 05:32:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:32:29 INFO - Return code: 0 05:32:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:32:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:32:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:32:29 INFO - ENV: RUST_BACKTRACE is now 1 05:32:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:32:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:32:29 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QgSKW6CSQ3GvM-OoRtGyXw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-086', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:32:29 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QgSKW6CSQ3GvM-OoRtGyXw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-086 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:32:29 INFO - Using env: {'DISPLAY': ':0', 05:32:29 INFO - 'HOME': '/home/cltbld', 05:32:29 INFO - 'LANG': 'en_US.UTF-8', 05:32:29 INFO - 'LANGUAGE': 'en_US:en', 05:32:29 INFO - 'LOGNAME': 'cltbld', 05:32:29 INFO - 'MAIL': '/var/mail/cltbld', 05:32:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:32:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:32:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:29 INFO - 'MOZ_NO_REMOTE': '1', 05:32:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:32:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:29 INFO - 'NO_EM_RESTART': '1', 05:32:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:29 INFO - 'PWD': '/builds/slave/test', 05:32:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:32:29 INFO - 'RUST_BACKTRACE': '1', 05:32:29 INFO - 'SHELL': '/bin/bash', 05:32:29 INFO - 'SHLVL': '1', 05:32:29 INFO - 'TERM': 'linux', 05:32:29 INFO - 'TMOUT': '86400', 05:32:29 INFO - 'USER': 'cltbld', 05:32:29 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038', 05:32:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:29 INFO - '_': '/tools/buildbot/bin/python'} 05:32:29 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QgSKW6CSQ3GvM-OoRtGyXw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-086', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:32:29 INFO - mozversion application_buildid: 20170510120601 05:32:29 INFO - mozversion application_changeset: f8d40e7fe132b7c73a8f610484b790e6063006e3 05:32:29 INFO - mozversion application_display_name: Nightly 05:32:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:32:29 INFO - mozversion application_name: Firefox 05:32:29 INFO - mozversion application_remotingname: firefox 05:32:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:32:29 INFO - mozversion application_vendor: Mozilla 05:32:29 INFO - mozversion application_version: 55.0a1 05:32:29 INFO - mozversion platform_buildid: 20170510120601 05:32:29 INFO - mozversion platform_changeset: f8d40e7fe132b7c73a8f610484b790e6063006e3 05:32:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:32:29 INFO - mozversion platform_version: 55.0a1 05:32:29 INFO - using testdate: 1494419549 05:32:29 INFO - actual date: 1494419549 05:32:29 INFO - starting webserver on 'localhost:40910' 05:32:29 INFO - SUITE-START | Running 2 tests 05:32:29 INFO - TEST-START | dromaeo_css 05:32:29 INFO - operating with platform_type : linux_ 05:32:29 INFO - Initialising browser for dromaeo_css test... 05:32:29 INFO - TEST-INFO | started process 26772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTjgA5N/profile http://localhost:40910/getInfo.html) 05:32:33 INFO - PID 26772 | __metrics Screen width/height:1600/1200 05:32:33 INFO - PID 26772 | colorDepth:24 05:32:33 INFO - PID 26772 | Browser inner width/height: 1024/695 05:32:33 INFO - PID 26772 | __metrics 05:32:34 INFO - PID 26772 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:32:34 INFO - PID 26772 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:32:35 INFO - TEST-INFO | 26772: exit 0 05:32:35 INFO - Browser initialized. 05:32:35 INFO - Running cycle 1/1 for dromaeo_css test... 05:32:35 INFO - TEST-INFO | started process 26869 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTjgA5N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:32:47 INFO - PID 26869 | RSS: Main: 148656128 05:32:47 INFO - PID 26869 | 05:35:53 INFO - PID 26869 | Cycle 1(1): loaded http://localhost:40910/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40910/tests/dromaeo/cssquery-ext.html) 05:35:54 INFO - PID 26869 | RSS: Main: 240590848 05:35:54 INFO - PID 26869 | 05:38:56 INFO - PID 26869 | Cycle 1(1): loaded http://localhost:40910/tests/dromaeo/cssquery-ext.html (next: http://localhost:40910/tests/dromaeo/cssquery-jquery.html) 05:38:57 INFO - PID 26869 | RSS: Main: 225599488 05:38:57 INFO - PID 26869 | 05:41:59 INFO - PID 26869 | Cycle 1(1): loaded http://localhost:40910/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40910/tests/dromaeo/cssquery-mootools.html) 05:42:00 INFO - PID 26869 | RSS: Main: 176676864 05:42:00 INFO - PID 26869 | 05:45:02 INFO - PID 26869 | Cycle 1(1): loaded http://localhost:40910/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40910/tests/dromaeo/cssquery-prototype.html) 05:45:02 INFO - PID 26869 | RSS: Main: 177455104 05:45:02 INFO - PID 26869 | 05:48:06 INFO - PID 26869 | Cycle 1(1): loaded http://localhost:40910/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40910/tests/dromaeo/cssquery-yui.html) 05:48:06 INFO - PID 26869 | RSS: Main: 179380224 05:48:06 INFO - PID 26869 | 05:51:08 INFO - PID 26869 | Cycle 1(1): loaded http://localhost:40910/tests/dromaeo/cssquery-yui.html (next: http://localhost:40910/tests/dromaeo/cssquery-dojo.html) 05:51:09 INFO - PID 26869 | RSS: Main: 234643456 05:51:09 INFO - PID 26869 | 05:51:09 INFO - PID 26869 | __start_tp_report 05:51:09 INFO - PID 26869 | _x_x_mozilla_page_load 05:51:09 INFO - PID 26869 | _x_x_mozilla_page_load_details 05:51:09 INFO - PID 26869 | |i|pagename|runs| 05:51:09 INFO - PID 26869 | |0;dojo.html;2689.287338855203;2702.4054707964265;2734.0977477432443;2739.041335532565;2739.3973325868315;5137.743112844352;5254.133068043778;5270.07773639613;5283.049051170788;5315.654482458643;5193.870153246161;5196;5218.817341393043;5221.921671174926;5225.425203227642;4648.674592778515;4665.720056796603;4718.174319494092;4731.78706958186;4749.881252968669;4681.414823147106;4694.483606803266;4729.408823897013;4730.574248317651;4777.90444191116;169.12384373416265;4623.699459535153;4624.306354046887;4628.907421851578;4680.859574212779;4657.836975705868;4658.836940707093;4661.906761864778;4690.4605970313505;4707.058588282357;4622.8150873965005;4623.375844261015;4633.907321853578;4635.351050852883;4682.040181762764;5121.590272778169;5164.147915593922;5172.301739265189;5191.766370513336;5210.583153347723;5700.657960522382;5701.429857014306;5707.315122185323;5735.569832262597;5761.711914404263;5726.68503232322;5729.226554415142;5737.942620573825;5741.626794258402;5742.994975879246;5146.125158723026;5217.869553261123;5304.893902121936;5317.361916570037;5327.854511280093;5618.775248990077;5805.970970145122;5881.823545293648;5888;5893.174955506232;5398.352197736218;5579.302587176603;5586.497215250566;5589.74846131925;5596.776128954796;5575.498205161555;5608.298962629671;5619.325680918316;5620.747066382022;5634.690092044895;5516.724163791875;5565.833025009256;5570.832875013756;5572.832815015556;5577.358603760538;5557.249771280825;5558.333000040021;5559.527440167551;5586.050371436865;5674.460926212003;4753.33453316536;4779.115863565182;4780.211265141213;4790.257510085872;4793.161196790547;3992.121733218687;4043.939340909889;4098.036961314089;4123.3196522574035;4140.23405669952;4737.265723812815;4808.08646357198;4829.517048295143;4834.927476087862;4848.636352273594;5621.4378562144275;5627.465390787868;5627.465390787868;5627.662340259598;5629.099344104923;4736.64475164364;4740.217864052462;4781.713097214179;4785.066911952136;4835.564799168092;4988.800447982113;5037.949620503821;5096.23556466533;5097.566706829961;5106.004329155853;5301.3373328333955;5309.389420216725;5316.043112239834;5318.920216196838;5320.414754376938;5668.404817494269;5670.432956704297;5678.602497825113;5717.714114294352;5720.313562372542;5129.948700512947;5206.5314121729225;5222.268882356397;5346.705931173823;5362.51737343641;5624.268845050117;5625;5630.60585758993;5630.7466164023535;5673.8297851064535;5589.77640894376;5687.829365119053;5692;5694.288213973254;5695.917775622618;5328.49379308965;5386.676799392049;5429.592780541554;5432.076546986943;5523.337199536081;5400.162974738922;5464.071107911744;5487.588430867621;5487.5884308677805;5514.80698175562;5271.525562699376;5374.4088150304215;5479.369872464717;5481.424450432647;5511.724413779375;5303.178007408857;5378.542823860016;5407.161889907071;5418.349798024262;5508.724563771875;5340.412554618911;5404.891902162013;5406.216098665593;5408.648437851527;5409.83770486886 05:51:09 INFO - PID 26869 | |1;ext.html;684.5584597934333;713.7537549545407;732.6702983657352;1047.6333283350828;1070.3631339353083;26109.347266318353;32370.676293237062;33568.66431335686;33572.66427335726;33638.66361336389;35971.92084237477;36336.63663363366;36352;36370;36424.81787591065;5250.553702935255;6920.204176519715;7079.752208672698;7087.3267039631155;7088.3620474157315;5230.476952304777;5299.231611416361;5303.840884773444;6290.622562646233;7035.085438892962;7070.15158181019;7122.323379278961;7123.964380178118;7159.069320988264;7163.14042314923;7065.364117229448;7121.857562848766;7130;7130.893036604455;7132.108486439195;5199.53204211619;5340.732963351817;6765.797026089176;6899.931000689979;6961.572877560088;31857.52213716796;32274.838625806955;32328.030159095266;32343.191420214447;32405.351892962008;2937.221636266391;2982;2983.19453747487;2983.4928062229474;2984.4031193761334;24597.38506537333;24611;24668.629970550457;24674.629880551805;24692.25923222288;2805.1864959161817;2807.73326533981;2815.408764159529;2819.7885158613185;2830.221689035511;144208;144268;144985.275073625;145025.274873626;145406.27296863555;41374.172516550105;41666.58333416688;41722.58277417187;41733.37399939003;41776.58223417727;43271.35092973608;43338.34992475116;43375.34936975948;43391.96256262031;43392.132157356675;12386.132970691964;12612;12621.747565048647;12630.242185468902;12653.430595623218;10092.646757363456;10116.140128089048;10120.139788118093;10124.240681948882;10128.797424051478;10423;10726.785464290671;11900.940495297467;12401.193922395016;12445.62663120108;4987.326710894055;5047.873803154877;5066.746662666852;5153.716545589954;5166.948330516722;857.648364170687;886.3352485635774;904.1329654264056;918.389271134688;924.2190349154953;21046.47383815417;21713;21839.235626752987;21887.781122188575;22256.109755609596;975.5951280218771;976.7802244494932;986.6729249159869;1002.14817405205;1002.2032484174953;10854.620088296871;11282.210245282915;11539.249948753304;11586.71033224176;11654.417279136009;157577;158692;158897;159136.20431897766;159236;40618.79690601587;40629;40711.38932916008;40723;40766.79616601898;1193.7194759231575;1232.5008371609513;1256.0705078242217;1263.753568054239;1267.4423253768311;20158.193672252946;20206;21131;21356.35263183993;21518.569628607653;30228;30349.241268968453;30365;30376;30380.24049398783;149901;149958;150067;150272;150672;29774.404511909208;29896.25259368533;29939.850300748356;30022.69977300199;30134.246643834078;35847.82076089603;37828.24343513169;37862.810685946395;38021;38068.23863522659;27042.32394190161;28652.42695146127;28961.855190723913;29015.419691606472;29025;27786.583201251593;27978;28359.836618154615;28956.27609309784;29031.56452653254;31135.221619459695;31419.68580314259;31487.84256078705;31493.68506314999;31501.527477087402;26051.348716282246;26873.193804185907;27568;28037;28352.854173328673;21699.674504882125;22465.5506889858;22544.77455225427;22554.661680074485;22570.097196111972 05:51:09 INFO - PID 26869 | |2;jquery.html;380.0745185473371;427.2949633105377;427.5339590320167;438.3796927347803;438.44536661123664;13381.53164639238;17731.55671108223;17801.46595602134;17867.106644667765;17904.731429028576;17794.733079003825;18021.639567208647;18214.180361883715;18463.2614695412;18608.906955465205;5435.130379139338;5580.079286917654;5608.355039170487;5608.663480191181;5612.176042786111;2761.64098667173;2868.7561557267554;5265.7893684252585;5477.890442191154;5496.0107180707455;5493.313335833021;5496.5053145216925;5498.752556134984;5499.587530935176;5502.119660854264;5340.145576707708;5470.671759694431;5494.532964698005;5495.230667706524;5508.669479831183;5013.323201367805;5014.774335154891;5015.445211984296;5018.623603229772;5019.52314530119;21167.259145929973;21862.672059919114;21984.560308793894;21990.450238744;22185.889070554706;1451.7096580683906;1470.3971371737537;1470.9190994495298;1610.557096798378;1637.606974326165;13866.65333366674;14277.928610356985;14855.514448555166;15077.924610376987;15196.088234705952;1999.8500112491477;2050.282401159597;2054.116729806183;2060.6084843879617;2068.927587534429;77263.22736772617;77487;77965.22034779636;78943.21056789474;79256.60371698163;10160;10948.835767463494;10962.123030157569;10993.835092473619;11023.83464248037;14299.847108553044;14756.335964881606;14759.926200369144;14764.40942362315;15470.922645386927;7442.553446793209;7502.924970750222;7636.732714354971;7654.96172519145;7680.078390593053;6703.128593282842;6823.283555226729;6972.825679358057;6978.930210697929;6997.370236678723;6817.613835157755;6980.825479363057;7045.89431158533;7064.50548461613;7115.786526404217;2064.256867527689;2069.5860827834495;2098.7691353951054;2104.2004038465284;2106.2101711858054;808.7654580171802;881.9250363719156;882.748416701237;886.7073865624328;887.4808237181193;17584.82415175832;17701.734473982902;17741.645167096587;17923;18044.819551804314;880.3925291548811;887.662688178488;893.2764460786783;897.3628723606182;912.4935660708238;9367;9520.761980950394;9776.804463910681;9902.455364954852;10053.346532475365;344469;346477;347360;352124;353798;74066;74452.62773686097;76547;77267.61366193245;80359.59820200861;1043;1065.4353192807823;1066.0991462214417;1069.1820757120963;1081.118888106191;14990;15079.698406031599;15106.54680359591;15426.614334641723;15574.299156537756;37576.43635345527;37844.62155378521;38435.6156438432;39664;39725;46813.76593117013;47030.294545582525;47468.287975679705;47552;50135;8262.669493220204;8287.212714792086;8333.208345207195;8364.163583641588;8746.300295976434;13243.072984890965;13744.450221991008;13752;13798.103123296954;13991.790123148365;11319.151063670093;11339.376334301693;11596.826047609124;11695.590654327058;11798.233114847508;10666.146708263164;10948.890511094787;10997.010269075821;11090.057345125755;11326.603568875049;11203;11205.719857003314;11318.094552435621;11461.828072578752;11852.762944740884;8340.207680270365;8469.814226008488;8499.150084991452;8511.446755960842;8574.142585741376;10986.615468458565;11239.943800280946;12031.338276394883;12057.758844823229;12313.753724925273 05:51:09 INFO - PID 26869 | |3;mootools.html;1232.8274041634172;1289.8774616411442;1296.9092163548548;1300.2913412190355;1309.934503274836;9785.510724463775;10239.948800256007;10241.948790256058;10254.487275636226;10263.794724105514;10067.798644027114;10343.224258180648;10350.58597656093;10350.948245258764;10354;2200.5378870437225;2235.4634887627017;2240.5070884405404;2242.6299660555987;2242.8542144760618;1881.444973732752;1952.306931039482;2137.1665050630268;2177.401214665964;2187.3656639574506;2151.4728891421546;2228.92198773043;2231.15216217837;2234.55308938213;2236.1502629000956;2157.8489505734606;2202.7797220277926;2209.834262430324;2209.9558008839895;2218.223621732397;2193.6270833958106;2194.462356722613;2194.9561008779897;2197.439652888519;2198.692183094368;10086.445245511493;10316.226283028727;10319.277650564463;10320.380777153396;10335.121514671262;5518.613697041209;5719.19931209631;5720.684242624178;5726.141078838166;5730.570207234474;3342.3148254607745;3471.375152472554;3618.4391419330045;3619.692326152254;3628.6915612172997;1082.9133669306436;1103.862017247844;1107.983380249297;1201.531402752927;1209.558511143435;14988.925055374762;15142.16718080505;15152.242387880562;15169.317380717785;15169.924150379287;4589.655775816827;4610.815567377267;4908.067467181296;5005.224190250517;5023.522765337287;10848.18638602108;10862.72843178911;10866.076383507332;10867.239293249397;10872.67381978542;5415.864603384868;5419.132938729785;5426.484483974016;5431.945680543223;5433.402325744165;4883.291922671193;4889.559939605452;4933.975330123327;5056.519630635084;5203.245529398216;3838.1939792643857;3945.368741001426;3945.585713500099;3990.86031988879;4013.3779264214095;1025.3079171559316;1124.9381284029294;1142.3374442823142;1151.0446329546455;1164.6447833410891;610.3225419784036;661.8312330355825;690.2028157478121;691.3155975584135;695.391532409142;5670.347909990404;5724.313082430135;5769.221155144001;5872.17789509469;5881.235439392852;805.1988271669609;816.1348970091603;820.5681086504088;834.641104325146;841.8274253778084;3996.5204175499125;4208.326667733148;4228.429162063082;4246.554111818276;4293.635041021548;13121.409536570878;13319.467221311039;13335.933320333335;13339.399727012307;13413.463461461432;12587.811182832265;13173.60479185626;13175.407106680032;13196.14225075367;13203.933980330037;7632.732854350071;7816.6091695415;7817.335526480199;7847.803804904809;7855.253750893656;5853.239078919713;6154;6201.2868520118955;6254.343293954252;6413.743450261937;11489.827652585385;11975.76048479043;11983.880161198276;12023.21849079842;12159.392030398269;11431.942840285745;11694.941525292319;11801.29192248468;11863.169578129447;11883.405829708652;9469.621215151592;9518.095780900803;9667.129958303787;9673.467959262309;9675.177609903238;9044.773880653036;9210.125038121369;9286.30352723535;9290.396124251902;9290.72127836166;7779.338756205786;7818.17909119557;7931.801704957422;7983.481073730189;8119.918800811916;7279.344858962719;7566.546007239584;7723.884141737991;7734.961325193338;7940.841183176189;6982.825429364307;7015.438764898898;7023.859522809617;7039.908814133817;7177.677004534704;5049.873753156054;5082.542571168613;5121.052605268037;5123.077845987758;5177.611679124006;4965.379327584052;5137.743112844418;5209.661372010807;5220.504052115043;5233.241180028951 05:51:09 INFO - PID 26869 | |4;prototype.html;385.6798856948731;391.97060220483473;396.07318873835203;396.07318873835226;398.40637450199205;5310.76101575429;5341.599380046502;5354.170103633938;5360.061989151893;5378.0857254266775;5079.79680812767;5191.896162076756;5212.192110222912;5242.3184985951775;5248.291480650111;4128.91742165158;4156.833726650931;4159.334506478956;4160.479940007499;4165.854779641381;4159.856039589107;4167.4790651168605;4168.99832120874;4177.101923086536;4179.937300940488;4024.8188831502507;4143.109231515224;4146.274401979642;4146.274401979656;4162.334026555752;4106.77412742299;4121.80467664377;4123.835046598132;4132.834686612532;4142.64787493065;3711.2020915503026;3737.4206997915367;3740.214554943465;3746.250749850041;3748.8687895923786;5103.387593488768;5149.665271757323;5156.664816786897;5158.3552055993005;5159.638825282232;4833.178359678863;4862.465128835825;4881.487443818419;4887.36464259644;4896.632752543574;5578.442155784389;5578.553715702734;5579.525740312079;5595.4124816894455;5600.215969764236;4083.958590559418;4164.083901541656;4207.410962465257;4208.537060923296;4209.158168366308;5646.774129034834;5807.564432667525;5808.912866307009;5809.128630705428;5823.233963867129;4362.956370436255;4452.220861349251;4455.799489023002;4459.9777001115435;4494.70784399013;4520.88697782558;4551.886202844956;4562.88592785183;4563.840265590755;4568.771561421982;4720.527947205252;4782.665213435026;4812.181929072066;4972.0801651694555;5012.273220383024;5626.1842032905;5639.548836093103;5642;5646.971765141148;5652.773889044474;1563.1637074165267;1579.9526014219362;1580.9209539522979;1582.0586750883206;1585.587747185717;1104.6575561575937;1150.9597164099216;1152.9769404611861;1153.5039932828963;1160.5241850841114;4863.1732605457155;4891.26631005352;4898.24077268024;4903.583195428358;4931.438419461983;5768.451997060272;5778.94221057784;5780;5791.652500849962;5798.188253644493;4732.266498692708;4883.560479556857;4902.705837649681;4944.950550494449;4989.600831933437;3059.8623061962267;3069.739072178845;3075.6616772155044;3080.4609193391066;3089.165925200183;5337.306150200527;5394.676319420847;5398.433164517748;5414.620976531605;5425.321834770653;5961.7615295387695;5973.671448070398;5981.730822113015;5982.4017598239825;5989.371116032841;5399.973000134974;5409.323834520685;5415.593830462731;5418.376886658006;5430.5927055471;5721;5784.855378615568;5797.739101740347;5849.566856120277;5858.297004359504;5694.409043885105;5713.800016999385;5744.770209191585;5745.511631511368;5748.885022299447;5161.793528258828;5179.326687530597;5179.430262671028;5234.555062819703;5412;3988.1624858779983;3993.900152496211;4000.3999400089056;4004.8598299059395;4015.1768887378603;5771.884562308646;5796.59423840344;5797.8550536236935;5803.100519419497;5816.156657284755;5398.217258497417;5587.469190426903;5644.774209031757;5648.519875810603;5650;5618.185363122406;5637.267155269788;5637.408072152365;5643.7742490299925;5649.94902752509;5443.183522471661;5503.807366742145;5522.30971128609;5540.889182216252;5547.11246200606;5681.573881958787;5685.317761868602;5688.345840228261;5706.400827913009;5731.8567035824435;5473.4400695801505;5517.475839795213;5522.9447705524035;5523.613347065667;5529.834104976857 05:51:09 INFO - PID 26869 | |5;yui.html;744.9143348514916;751.7744676597022;756.0889128600038;768.247117824532;778.9883151752723;11739.589114380999;11791.231315302708;11845.881541184586;11855.347955862424;11865.466054027567;13754.17474951501;13763.31183440829;14108.647283817909;14542.563723088299;14559.636009099779;876.0976194519639;896.6592694775976;898.8516894712365;899.0829354058856;900.0504467786483;860.0453496618749;886.6542048601051;888.0719647967857;888.524639317965;889.0353965946955;947.2516711797672;955.2024059909949;955.8948515663271;956.1012648110753;956.9569369378395;948.9999999999966;949.6343907595557;949.8717673114111;949.9050094990515;954.4941181173954;700.8668353012911;701.6912558474306;701.9403350715145;702.6521871673555;703.8275622472476;13706;13854.099483533539;14018.228997405138;14038.157710537298;14075.788863167061;15710.135942523157;15761.29074191664;15995.680086398323;16141.91929040359;16159.91920040404;12610.936945315307;12718.618441446772;12749.553765618159;12750.80873786894;13916.373763180682;4709.529047095298;4738.715677059387;4744.83393081244;4765.142274390609;4766.046790641885;62823.6858815703;63467;64968.675156624384;65603.67198164026;68883;12611.558595449298;12862.935685321514;12952.287624180572;12958.740825183444;12980.935095324463;21964.341069767932;22058.669119963215;22360.664590031163;22515.64906105606;22581.887090564443;5965.940340596625;5987.64074155552;5988.730507127189;5997.0404735242155;6000.459958603747;2986.4027194561177;3031.227037105524;3072.9078127656207;3094.257378229254;3103.34829685764;3487.4594437861665;3567.500549923013;3571.571411430593;3574.57105147384;3576.302620988934;771.5640663025373;796.8685166947389;805.1787177079464;807.9959600201961;809.8987626546682;559.3343920734313;578.7762164742345;583.8414179290021;586.0388962102156;587.4976894754923;10210.387376757419;10734.463276836126;10781.02970732638;11081.168912331608;11101.1674124441;587.33630996974;589.7405141737707;598.3806760003463;602.7076867719153;610.984725381869;4250;4384.495782984997;4402.7358358498595;4424.159409712209;4426.778661066934;61594.69202653958;61922;62409;65824.67087664531;66088.6695566519;54704.72647636816;55855;55997.72001139968;56878.71560642253;58068.70965645145;36331.273374532364;46347.768261158475;47719.28421073686;47972.04055918932;48496.5150348492;10077.19382449417;10973.890261097606;11321.660350189508;11380.089592832388;11540.480678369326;24483.265502034967;24897.751022489545;25029.249122526355;25929;26005.739942600332;41179.58820411757;42620.57379426166;43854;44671.55328446674;45297.77351113223;13647.385867635781;13711.520096796565;13804.447822087406;13856.237906915216;14013.229272390117;15043.247837608295;15136.697266054396;15231.771523426936;15515;16207;13023.674408139872;13058.281794501014;13430.462781488632;13468.393922273717;13495.59513214605;13982.091164074303;14183;14360;14424.134551926918;14669.413223470941;12755.170913890568;13255.270960097287;13316.733665326832;13432.865671343552;13460.326983650582;9421.905780942378;10359.533820977924;10888.61889833852;11057.723556911142;11687;11897.940510297392;13052.673683157996;13130.606081817561;13196.736065278832;13203.033491493336 05:51:09 INFO - PID 26869 | __end_tp_report 05:51:09 INFO - PID 26869 | __start_cc_report 05:51:09 INFO - PID 26869 | _x_x_mozilla_cycle_collect,1164 05:51:09 INFO - PID 26869 | __end_cc_report 05:51:09 INFO - PID 26869 | __startTimestamp1494420669108__endTimestamp 05:51:09 INFO - PID 26869 | 05:51:09 INFO - PID 26869 | ------- Summary: start ------- 05:51:09 INFO - PID 26869 | Number of tests: 6 05:51:09 INFO - PID 26869 | 05:51:09 INFO - PID 26869 | [#0] dojo.html Cycles:165 Average:5136.54 Median:5318.92 stddev:717.10 (13.5%) stddev-sans-first:693.13 05:51:09 INFO - PID 26869 | Values: 2689.3 2702.4 2734.1 2739.0 2739.4 5137.7 5254.1 5270.1 5283.0 5315.7 5193.9 5196.0 5218.8 5221.9 5225.4 4648.7 4665.7 4718.2 4731.8 4749.9 4681.4 4694.5 4729.4 4730.6 4777.9 169.1 4623.7 4624.3 4628.9 4680.9 4657.8 4658.8 4661.9 4690.5 4707.1 4622.8 4623.4 4633.9 4635.4 4682.0 5121.6 5164.1 5172.3 5191.8 5210.6 5700.7 5701.4 5707.3 5735.6 5761.7 5726.7 5729.2 5737.9 5741.6 5743.0 5146.1 5217.9 5304.9 5317.4 5327.9 5618.8 5806.0 5881.8 5888.0 5893.2 5398.4 5579.3 5586.5 5589.7 5596.8 5575.5 5608.3 5619.3 5620.7 5634.7 5516.7 5565.8 5570.8 5572.8 5577.4 5557.2 5558.3 5559.5 5586.1 5674.5 4753.3 4779.1 4780.2 4790.3 4793.2 3992.1 4043.9 4098.0 4123.3 4140.2 4737.3 4808.1 4829.5 4834.9 4848.6 5621.4 5627.5 5627.5 5627.7 5629.1 4736.6 4740.2 4781.7 4785.1 4835.6 4988.8 5037.9 5096.2 5097.6 5106.0 5301.3 5309.4 5316.0 5318.9 5320.4 5668.4 5670.4 5678.6 5717.7 5720.3 5129.9 5206.5 5222.3 5346.7 5362.5 5624.3 5625.0 5630.6 5630.7 5673.8 5589.8 5687.8 5692.0 5694.3 5695.9 5328.5 5386.7 5429.6 5432.1 5523.3 5400.2 5464.1 5487.6 5487.6 5514.8 5271.5 5374.4 5479.4 5481.4 5511.7 5303.2 5378.5 5407.2 5418.3 5508.7 5340.4 5404.9 5406.2 5408.6 5409.8 05:51:09 INFO - PID 26869 | 05:51:09 INFO - PID 26869 | [#1] ext.html Cycles:180 Average:29901.51 Median:16440.33 stddev:39038.82 (237.5%) stddev-sans-first:39086.69 05:51:09 INFO - PID 26869 | Values: 684.6 713.8 732.7 1047.6 1070.4 26109.3 32370.7 33568.7 33572.7 33638.7 35971.9 36336.6 36352.0 36370.0 36424.8 5250.6 6920.2 7079.8 7087.3 7088.4 5230.5 5299.2 5303.8 6290.6 7035.1 7070.2 7122.3 7124.0 7159.1 7163.1 7065.4 7121.9 7130.0 7130.9 7132.1 5199.5 5340.7 6765.8 6899.9 6961.6 31857.5 32274.8 32328.0 32343.2 32405.4 2937.2 2982.0 2983.2 2983.5 2984.4 24597.4 24611.0 24668.6 24674.6 24692.3 2805.2 2807.7 2815.4 2819.8 2830.2 144208.0 144268.0 144985.3 145025.3 145406.3 41374.2 41666.6 41722.6 41733.4 41776.6 43271.4 43338.3 43375.3 43392.0 43392.1 12386.1 12612.0 12621.7 12630.2 12653.4 10092.6 10116.1 10120.1 10124.2 10128.8 10423.0 10726.8 11900.9 12401.2 12445.6 4987.3 5047.9 5066.7 5153.7 5166.9 857.6 886.3 904.1 918.4 924.2 21046.5 21713.0 21839.2 21887.8 22256.1 975.6 976.8 986.7 1002.1 1002.2 10854.6 11282.2 11539.2 11586.7 11654.4 157577.0 158692.0 158897.0 159136.2 159236.0 40618.8 40629.0 40711.4 40723.0 40766.8 1193.7 1232.5 1256.1 1263.8 1267.4 20158.2 20206.0 21131.0 21356.4 21518.6 30228.0 30349.2 30365.0 30376.0 30380.2 149901.0 149958.0 150067.0 150272.0 150672.0 29774.4 29896.3 29939.9 30022.7 30134.2 35847.8 37828.2 37862.8 38021.0 38068.2 27042.3 28652.4 28961.9 29015.4 29025.0 27786.6 27978.0 28359.8 28956.3 29031.6 31135.2 31419.7 31487.8 31493.7 31501.5 26051.3 26873.2 27568.0 28037.0 28352.9 21699.7 22465.6 22544.8 22554.7 22570.1 05:51:09 INFO - PID 26869 | 05:51:09 INFO - PID 26869 | [#2] jquery.html Cycles:180 Average:23962.34 Median:349742.00 stddev:57954.98 (16.6%) stddev-sans-first:58090.51 05:51:09 INFO - PID 26869 | Values: 380.1 427.3 427.5 438.4 438.4 13381.5 17731.6 17801.5 17867.1 17904.7 17794.7 18021.6 18214.2 18463.3 18608.9 5435.1 5580.1 5608.4 5608.7 5612.2 2761.6 2868.8 5265.8 5477.9 5496.0 5493.3 5496.5 5498.8 5499.6 5502.1 5340.1 5470.7 5494.5 5495.2 5508.7 5013.3 5014.8 5015.4 5018.6 5019.5 21167.3 21862.7 21984.6 21990.5 22185.9 1451.7 1470.4 1470.9 1610.6 1637.6 13866.7 14277.9 14855.5 15077.9 15196.1 1999.9 2050.3 2054.1 2060.6 2068.9 77263.2 77487.0 77965.2 78943.2 79256.6 10160.0 10948.8 10962.1 10993.8 11023.8 14299.8 14756.3 14759.9 14764.4 15470.9 7442.6 7502.9 7636.7 7655.0 7680.1 6703.1 6823.3 6972.8 6978.9 6997.4 6817.6 6980.8 7045.9 7064.5 7115.8 2064.3 2069.6 2098.8 2104.2 2106.2 808.8 881.9 882.7 886.7 887.5 17584.8 17701.7 17741.6 17923.0 18044.8 880.4 887.7 893.3 897.4 912.5 9367.0 9520.8 9776.8 9902.5 10053.3 344469.0 346477.0 347360.0 352124.0 353798.0 74066.0 74452.6 76547.0 77267.6 80359.6 1043.0 1065.4 1066.1 1069.2 1081.1 14990.0 15079.7 15106.5 15426.6 15574.3 37576.4 37844.6 38435.6 39664.0 39725.0 46813.8 47030.3 47468.3 47552.0 50135.0 8262.7 8287.2 8333.2 8364.2 8746.3 13243.1 13744.5 13752.0 13798.1 13991.8 11319.2 11339.4 11596.8 11695.6 11798.2 10666.1 10948.9 10997.0 11090.1 11326.6 11203.0 11205.7 11318.1 11461.8 11852.8 8340.2 8469.8 8499.2 8511.4 8574.1 10986.6 11239.9 12031.3 12057.8 12313.8 05:51:09 INFO - PID 26869 | 05:51:09 INFO - PID 26869 | [#3] mootools.html Cycles:180 Average:6299.30 Median:3945.48 stddev:4022.50 (102.0%) stddev-sans-first:4015.76 05:51:09 INFO - PID 26869 | Values: 1232.8 1289.9 1296.9 1300.3 1309.9 9785.5 10239.9 10241.9 10254.5 10263.8 10067.8 10343.2 10350.6 10350.9 10354.0 2200.5 2235.5 2240.5 2242.6 2242.9 1881.4 1952.3 2137.2 2177.4 2187.4 2151.5 2228.9 2231.2 2234.6 2236.2 2157.8 2202.8 2209.8 2210.0 2218.2 2193.6 2194.5 2195.0 2197.4 2198.7 10086.4 10316.2 10319.3 10320.4 10335.1 5518.6 5719.2 5720.7 5726.1 5730.6 3342.3 3471.4 3618.4 3619.7 3628.7 1082.9 1103.9 1108.0 1201.5 1209.6 14988.9 15142.2 15152.2 15169.3 15169.9 4589.7 4610.8 4908.1 5005.2 5023.5 10848.2 10862.7 10866.1 10867.2 10872.7 5415.9 5419.1 5426.5 5431.9 5433.4 4883.3 4889.6 4934.0 5056.5 5203.2 3838.2 3945.4 3945.6 3990.9 4013.4 1025.3 1124.9 1142.3 1151.0 1164.6 610.3 661.8 690.2 691.3 695.4 5670.3 5724.3 5769.2 5872.2 5881.2 805.2 816.1 820.6 834.6 841.8 3996.5 4208.3 4228.4 4246.6 4293.6 13121.4 13319.5 13335.9 13339.4 13413.5 12587.8 13173.6 13175.4 13196.1 13203.9 7632.7 7816.6 7817.3 7847.8 7855.3 5853.2 6154.0 6201.3 6254.3 6413.7 11489.8 11975.8 11983.9 12023.2 12159.4 11431.9 11694.9 11801.3 11863.2 11883.4 9469.6 9518.1 9667.1 9673.5 9675.2 9044.8 9210.1 9286.3 9290.4 9290.7 7779.3 7818.2 7931.8 7983.5 8119.9 7279.3 7566.5 7723.9 7735.0 7940.8 6982.8 7015.4 7023.9 7039.9 7177.7 5049.9 5082.5 5121.1 5123.1 5177.6 4965.4 5137.7 5209.7 5220.5 5233.2 05:51:09 INFO - PID 26869 | 05:51:09 INFO - PID 26869 | [#4] prototype.html Cycles:180 Average:4693.70 Median:5160.72 stddev:1316.28 (25.5%) stddev-sans-first:1279.64 05:51:09 INFO - PID 26869 | Values: 385.7 392.0 396.1 396.1 398.4 5310.8 5341.6 5354.2 5360.1 5378.1 5079.8 5191.9 5212.2 5242.3 5248.3 4128.9 4156.8 4159.3 4160.5 4165.9 4159.9 4167.5 4169.0 4177.1 4179.9 4024.8 4143.1 4146.3 4146.3 4162.3 4106.8 4121.8 4123.8 4132.8 4142.6 3711.2 3737.4 3740.2 3746.3 3748.9 5103.4 5149.7 5156.7 5158.4 5159.6 4833.2 4862.5 4881.5 4887.4 4896.6 5578.4 5578.6 5579.5 5595.4 5600.2 4084.0 4164.1 4207.4 4208.5 4209.2 5646.8 5807.6 5808.9 5809.1 5823.2 4363.0 4452.2 4455.8 4460.0 4494.7 4520.9 4551.9 4562.9 4563.8 4568.8 4720.5 4782.7 4812.2 4972.1 5012.3 5626.2 5639.5 5642.0 5647.0 5652.8 1563.2 1580.0 1580.9 1582.1 1585.6 1104.7 1151.0 1153.0 1153.5 1160.5 4863.2 4891.3 4898.2 4903.6 4931.4 5768.5 5778.9 5780.0 5791.7 5798.2 4732.3 4883.6 4902.7 4945.0 4989.6 3059.9 3069.7 3075.7 3080.5 3089.2 5337.3 5394.7 5398.4 5414.6 5425.3 5961.8 5973.7 5981.7 5982.4 5989.4 5400.0 5409.3 5415.6 5418.4 5430.6 5721.0 5784.9 5797.7 5849.6 5858.3 5694.4 5713.8 5744.8 5745.5 5748.9 5161.8 5179.3 5179.4 5234.6 5412.0 3988.2 3993.9 4000.4 4004.9 4015.2 5771.9 5796.6 5797.9 5803.1 5816.2 5398.2 5587.5 5644.8 5648.5 5650.0 5618.2 5637.3 5637.4 5643.8 5649.9 5443.2 5503.8 5522.3 5540.9 5547.1 5681.6 5685.3 5688.3 5706.4 5731.9 5473.4 5517.5 5522.9 5523.6 5529.8 05:51:09 INFO - PID 26869 | 05:51:09 INFO - PID 26869 | [#5] yui.html Cycles:180 Average:15208.88 Median:3569.54 stddev:17516.26 (490.7%) stddev-sans-first:17531.72 05:51:09 INFO - PID 26869 | Values: 744.9 751.8 756.1 768.2 779.0 11739.6 11791.2 11845.9 11855.3 11865.5 13754.2 13763.3 14108.6 14542.6 14559.6 876.1 896.7 898.9 899.1 900.1 860.0 886.7 888.1 888.5 889.0 947.3 955.2 955.9 956.1 957.0 949.0 949.6 949.9 949.9 954.5 700.9 701.7 701.9 702.7 703.8 13706.0 13854.1 14018.2 14038.2 14075.8 15710.1 15761.3 15995.7 16141.9 16159.9 12610.9 12718.6 12749.6 12750.8 13916.4 4709.5 4738.7 4744.8 4765.1 4766.0 62823.7 63467.0 64968.7 65603.7 68883.0 12611.6 12862.9 12952.3 12958.7 12980.9 21964.3 22058.7 22360.7 22515.6 22581.9 5965.9 5987.6 5988.7 5997.0 6000.5 2986.4 3031.2 3072.9 3094.3 3103.3 3487.5 3567.5 3571.6 3574.6 3576.3 771.6 796.9 805.2 808.0 809.9 559.3 578.8 583.8 586.0 587.5 10210.4 10734.5 10781.0 11081.2 11101.2 587.3 589.7 598.4 602.7 611.0 4250.0 4384.5 4402.7 4424.2 4426.8 61594.7 61922.0 62409.0 65824.7 66088.7 54704.7 55855.0 55997.7 56878.7 58068.7 36331.3 46347.8 47719.3 47972.0 48496.5 10077.2 10973.9 11321.7 11380.1 11540.5 24483.3 24897.8 25029.2 25929.0 26005.7 41179.6 42620.6 43854.0 44671.6 45297.8 13647.4 13711.5 13804.4 13856.2 14013.2 15043.2 15136.7 15231.8 15515.0 16207.0 13023.7 13058.3 13430.5 13468.4 13495.6 13982.1 14183.0 14360.0 14424.1 14669.4 12755.2 13255.3 13316.7 13432.9 13460.3 9421.9 10359.5 10888.6 11057.7 11687.0 11897.9 13052.7 13130.6 13196.7 13203.0 05:51:09 INFO - PID 26869 | -------- Summary: end -------- 05:51:09 INFO - PID 26869 | 05:51:09 INFO - TEST-INFO | 26869: exit 0 05:51:09 INFO - TEST-OK | dromaeo_css | took 1120031ms 05:51:09 INFO - TEST-START | kraken 05:51:09 INFO - operating with platform_type : linux_ 05:51:09 INFO - Initialising browser for kraken test... 05:51:09 INFO - TEST-INFO | started process 27193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphUGo1d/profile http://localhost:40910/getInfo.html) 05:51:13 INFO - PID 27193 | __metrics Screen width/height:1600/1200 05:51:13 INFO - PID 27193 | colorDepth:24 05:51:13 INFO - PID 27193 | Browser inner width/height: 1024/695 05:51:13 INFO - PID 27193 | __metrics 05:51:14 INFO - PID 27193 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:51:14 INFO - PID 27193 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:51:15 INFO - TEST-INFO | 27193: exit 0 05:51:15 INFO - Browser initialized. 05:51:15 INFO - Running cycle 1/1 for kraken test... 05:51:15 INFO - TEST-INFO | started process 27291 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphUGo1d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:51:27 INFO - PID 27291 | RSS: Main: 148766720 05:51:27 INFO - PID 27291 | 05:51:29 INFO - PID 27291 | Cycle 1(1): loaded http://localhost:40910/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40910/tests/kraken/driver.html?testName=audio-beat-detection) 05:51:30 INFO - PID 27291 | RSS: Main: 221147136 05:51:30 INFO - PID 27291 | 05:51:33 INFO - PID 27291 | Cycle 1(1): loaded http://localhost:40910/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40910/tests/kraken/driver.html?testName=audio-dft) 05:51:34 INFO - PID 27291 | RSS: Main: 181366784 05:51:34 INFO - PID 27291 | 05:51:37 INFO - PID 27291 | Cycle 1(1): loaded http://localhost:40910/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40910/tests/kraken/driver.html?testName=audio-fft) 05:51:37 INFO - PID 27291 | RSS: Main: 264032256 05:51:37 INFO - PID 27291 | 05:51:40 INFO - PID 27291 | Cycle 1(1): loaded http://localhost:40910/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40910/tests/kraken/driver.html?testName=audio-oscillator) 05:51:40 INFO - PID 27291 | RSS: Main: 175202304 05:51:40 INFO - PID 27291 | 05:51:42 INFO - PID 27291 | Cycle 1(1): loaded http://localhost:40910/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40910/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:51:43 INFO - PID 27291 | RSS: Main: 177078272 05:51:43 INFO - PID 27291 | 05:51:46 INFO - PID 27291 | Cycle 1(1): loaded http://localhost:40910/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40910/tests/kraken/driver.html?testName=imaging-darkroom) 05:51:47 INFO - PID 27291 | RSS: Main: 237563904 05:51:47 INFO - PID 27291 | 05:51:50 INFO - PID 27291 | Cycle 1(1): loaded http://localhost:40910/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40910/tests/kraken/driver.html?testName=imaging-desaturate) 05:51:51 INFO - PID 27291 | RSS: Main: 237125632 05:51:51 INFO - PID 27291 | 05:51:54 INFO - PID 27291 | Cycle 1(1): loaded http://localhost:40910/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40910/tests/kraken/driver.html?testName=json-parse-financial) 05:51:54 INFO - PID 27291 | RSS: Main: 235171840 05:51:54 INFO - PID 27291 | 05:51:56 INFO - PID 27291 | Cycle 1(1): loaded http://localhost:40910/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40910/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:51:57 INFO - PID 27291 | RSS: Main: 199659520 05:51:57 INFO - PID 27291 | 05:51:58 INFO - PID 27291 | Cycle 1(1): loaded http://localhost:40910/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40910/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:51:59 INFO - PID 27291 | RSS: Main: 187273216 05:51:59 INFO - PID 27291 | 05:52:01 INFO - PID 27291 | Cycle 1(1): loaded http://localhost:40910/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40910/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:52:02 INFO - PID 27291 | RSS: Main: 214822912 05:52:02 INFO - PID 27291 | 05:52:04 INFO - PID 27291 | Cycle 1(1): loaded http://localhost:40910/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40910/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:52:05 INFO - PID 27291 | RSS: Main: 223657984 05:52:05 INFO - PID 27291 | 05:52:08 INFO - PID 27291 | Cycle 1(1): loaded http://localhost:40910/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40910/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:52:09 INFO - PID 27291 | RSS: Main: 219668480 05:52:09 INFO - PID 27291 | 05:52:11 INFO - PID 27291 | Cycle 1(1): loaded http://localhost:40910/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40910/tests/kraken/driver.html?testName=ai-astar) 05:52:11 INFO - PID 27291 | RSS: Main: 268398592 05:52:11 INFO - PID 27291 | 05:52:11 INFO - PID 27291 | __start_tp_report 05:52:11 INFO - PID 27291 | _x_x_mozilla_page_load 05:52:11 INFO - PID 27291 | _x_x_mozilla_page_load_details 05:52:11 INFO - PID 27291 | |i|pagename|runs| 05:52:11 INFO - PID 27291 | |0;ai-astar;107;111;112;111;109;110;110;111;109;112 05:52:11 INFO - PID 27291 | |1;audio-beat-detection;154;129;124;168;124;125;124;129;149;124 05:52:11 INFO - PID 27291 | |2;audio-dft;162;161;162;163;162;162;160;161;163;163 05:52:11 INFO - PID 27291 | |3;audio-fft;77;78;74;106;74;76;75;75;94;75 05:52:11 INFO - PID 27291 | |4;audio-oscillator;84;83;116;84;83;83;100;84;83;105 05:52:11 INFO - PID 27291 | |5;imaging-gaussian-blur;114;113;114;113;114;113;113;113;115;113 05:52:11 INFO - PID 27291 | |6;imaging-darkroom;150;148;149;149;148;149;148;148;149;149 05:52:11 INFO - PID 27291 | |7;imaging-desaturate;93;93;94;94;94;94;94;93;94;94 05:52:11 INFO - PID 27291 | |8;json-parse-financial;53;51;52;51;53;53;54;53;54;54 05:52:11 INFO - PID 27291 | |9;json-stringify-tinderbox;56;56;57;56;56;56;57;58;57;56 05:52:11 INFO - PID 27291 | |10;stanford-crypto-aes;81;85;81;82;82;81;82;82;80;80 05:52:11 INFO - PID 27291 | |11;stanford-crypto-ccm;134;133;129;136;129;137;129;138;180;142 05:52:11 INFO - PID 27291 | |12;stanford-crypto-pbkdf2;189;190;192;182;193;192;191;202;196;191 05:52:11 INFO - PID 27291 | |13;stanford-crypto-sha256-iterative;73;73;72;72;72;73;71;71;71;71 05:52:11 INFO - PID 27291 | __end_tp_report 05:52:11 INFO - PID 27291 | __start_cc_report 05:52:11 INFO - PID 27291 | _x_x_mozilla_cycle_collect,2000 05:52:11 INFO - PID 27291 | __end_cc_report 05:52:11 INFO - PID 27291 | __startTimestamp1494420731518__endTimestamp 05:52:11 INFO - PID 27291 | 05:52:11 INFO - PID 27291 | ------- Summary: start ------- 05:52:11 INFO - PID 27291 | Number of tests: 14 05:52:11 INFO - PID 27291 | 05:52:11 INFO - PID 27291 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:1.55 (1.4%) stddev-sans-first:1.13 05:52:11 INFO - PID 27291 | Values: 107.0 111.0 112.0 111.0 109.0 110.0 110.0 111.0 109.0 112.0 05:52:11 INFO - PID 27291 | 05:52:11 INFO - PID 27291 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:129.00 stddev:15.99 (12.4%) stddev-sans-first:15.41 05:52:11 INFO - PID 27291 | Values: 154.0 129.0 124.0 168.0 124.0 125.0 124.0 129.0 149.0 124.0 05:52:11 INFO - PID 27291 | 05:52:11 INFO - PID 27291 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 05:52:11 INFO - PID 27291 | Values: 162.0 161.0 162.0 163.0 162.0 162.0 160.0 161.0 163.0 163.0 05:52:11 INFO - PID 27291 | 05:52:11 INFO - PID 27291 | [#3] audio-fft Cycles:10 Average:80.40 Median:75.50 stddev:10.78 (14.3%) stddev-sans-first:11.37 05:52:11 INFO - PID 27291 | Values: 77.0 78.0 74.0 106.0 74.0 76.0 75.0 75.0 94.0 75.0 05:52:11 INFO - PID 27291 | 05:52:11 INFO - PID 27291 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:83.00 stddev:12.03 (14.5%) stddev-sans-first:12.53 05:52:11 INFO - PID 27291 | Values: 84.0 83.0 116.0 84.0 83.0 83.0 100.0 84.0 83.0 105.0 05:52:11 INFO - PID 27291 | 05:52:11 INFO - PID 27291 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:113.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 05:52:11 INFO - PID 27291 | Values: 114.0 113.0 114.0 113.0 114.0 113.0 113.0 113.0 115.0 113.0 05:52:11 INFO - PID 27291 | 05:52:11 INFO - PID 27291 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:0.67 (0.5%) stddev-sans-first:0.53 05:52:11 INFO - PID 27291 | Values: 150.0 148.0 149.0 149.0 148.0 149.0 148.0 148.0 149.0 149.0 05:52:11 INFO - PID 27291 | 05:52:11 INFO - PID 27291 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 05:52:11 INFO - PID 27291 | Values: 93.0 93.0 94.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 05:52:11 INFO - PID 27291 | 05:52:11 INFO - PID 27291 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:1.14 (2.1%) stddev-sans-first:1.20 05:52:11 INFO - PID 27291 | Values: 53.0 51.0 52.0 51.0 53.0 53.0 54.0 53.0 54.0 54.0 05:52:11 INFO - PID 27291 | 05:52:11 INFO - PID 27291 | [#9] json-stringify-tinderbox Cycles:10 Average:56.50 Median:56.50 stddev:0.71 (1.3%) stddev-sans-first:0.73 05:52:11 INFO - PID 27291 | Values: 56.0 56.0 57.0 56.0 56.0 56.0 57.0 58.0 57.0 56.0 05:52:11 INFO - PID 27291 | 05:52:11 INFO - PID 27291 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:82.00 stddev:1.43 (1.7%) stddev-sans-first:1.50 05:52:11 INFO - PID 27291 | Values: 81.0 85.0 81.0 82.0 82.0 81.0 82.0 82.0 80.0 80.0 05:52:11 INFO - PID 27291 | 05:52:11 INFO - PID 27291 | [#11] stanford-crypto-ccm Cycles:10 Average:138.70 Median:136.50 stddev:15.14 (11.1%) stddev-sans-first:15.97 05:52:11 INFO - PID 27291 | Values: 134.0 133.0 129.0 136.0 129.0 137.0 129.0 138.0 180.0 142.0 05:52:11 INFO - PID 27291 | 05:52:11 INFO - PID 27291 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.80 Median:192.00 stddev:5.07 (2.6%) stddev-sans-first:5.28 05:52:11 INFO - PID 27291 | Values: 189.0 190.0 192.0 182.0 193.0 192.0 191.0 202.0 196.0 191.0 05:52:11 INFO - PID 27291 | 05:52:11 INFO - PID 27291 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:72.00 stddev:0.88 (1.2%) stddev-sans-first:0.83 05:52:11 INFO - PID 27291 | Values: 73.0 73.0 72.0 72.0 72.0 73.0 71.0 71.0 71.0 71.0 05:52:11 INFO - PID 27291 | -------- Summary: end -------- 05:52:11 INFO - PID 27291 | 05:52:12 INFO - TEST-INFO | 27291: exit 0 05:52:12 INFO - TEST-OK | kraken | took 62841ms 05:52:12 INFO - SUITE-END | took 1182s 05:52:13 INFO - Completed test suite (00:19:43) 05:52:13 INFO - javascript benchmark 05:52:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6706.478471326553, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2689.287338855203, 2702.4054707964265, 2734.0977477432443, 2739.041335532565, 2739.3973325868315, 5137.743112844352, 5254.133068043778, 5270.07773639613, 5283.049051170788, 5315.654482458643, 5193.870153246161, 5196.0, 5218.817341393043, 5221.921671174926, 5225.425203227642, 4648.674592778515, 4665.720056796603, 4718.174319494092, 4731.78706958186, 4749.881252968669, 4681.414823147106, 4694.483606803266, 4729.408823897013, 4730.574248317651, 4777.90444191116, 169.12384373416265, 4623.699459535153, 4624.306354046887, 4628.907421851578, 4680.859574212779, 4657.836975705868, 4658.836940707093, 4661.906761864778, 4690.4605970313505, 4707.058588282357, 4622.8150873965005, 4623.375844261015, 4633.907321853578, 4635.351050852883, 4682.040181762764, 5121.590272778169, 5164.147915593922, 5172.301739265189, 5191.766370513336, 5210.583153347723, 5700.657960522382, 5701.429857014306, 5707.315122185323, 5735.569832262597, 5761.711914404263, 5726.68503232322, 5729.226554415142, 5737.942620573825, 5741.626794258402, 5742.994975879246, 5146.125158723026, 5217.869553261123, 5304.893902121936, 5317.361916570037, 5327.854511280093, 5618.775248990077, 5805.970970145122, 5881.823545293648, 5888.0, 5893.174955506232, 5398.352197736218, 5579.302587176603, 5586.497215250566, 5589.74846131925, 5596.776128954796, 5575.498205161555, 5608.298962629671, 5619.325680918316, 5620.747066382022, 5634.690092044895, 5516.724163791875, 5565.833025009256, 5570.832875013756, 5572.832815015556, 5577.358603760538, 5557.249771280825, 5558.333000040021, 5559.527440167551, 5586.050371436865, 5674.460926212003, 4753.33453316536, 4779.115863565182, 4780.211265141213, 4790.257510085872, 4793.161196790547, 3992.121733218687, 4043.939340909889, 4098.036961314089, 4123.3196522574035, 4140.23405669952, 4737.265723812815, 4808.08646357198, 4829.517048295143, 4834.927476087862, 4848.636352273594, 5621.4378562144275, 5627.465390787868, 5627.465390787868, 5627.662340259598, 5629.099344104923, 4736.64475164364, 4740.217864052462, 4781.713097214179, 4785.066911952136, 4835.564799168092, 4988.800447982113, 5037.949620503821, 5096.23556466533, 5097.566706829961, 5106.004329155853, 5301.3373328333955, 5309.389420216725, 5316.043112239834, 5318.920216196838, 5320.414754376938, 5668.404817494269, 5670.432956704297, 5678.602497825113, 5717.714114294352, 5720.313562372542, 5129.948700512947, 5206.5314121729225, 5222.268882356397, 5346.705931173823, 5362.51737343641, 5624.268845050117, 5625.0, 5630.60585758993, 5630.7466164023535, 5673.8297851064535, 5589.77640894376, 5687.829365119053, 5692.0, 5694.288213973254, 5695.917775622618, 5328.49379308965, 5386.676799392049, 5429.592780541554, 5432.076546986943, 5523.337199536081, 5400.162974738922, 5464.071107911744, 5487.588430867621, 5487.5884308677805, 5514.80698175562, 5271.525562699376, 5374.4088150304215, 5479.369872464717, 5481.424450432647, 5511.724413779375, 5303.178007408857, 5378.542823860016, 5407.161889907071, 5418.349798024262, 5508.724563771875, 5340.412554618911, 5404.891902162013, 5406.216098665593, 5408.648437851527, 5409.83770486886], "value": 5086.783725500144, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.5584597934333, 713.7537549545407, 732.6702983657352, 1047.6333283350828, 1070.3631339353083, 26109.347266318353, 32370.676293237062, 33568.66431335686, 33572.66427335726, 33638.66361336389, 35971.92084237477, 36336.63663363366, 36352.0, 36370.0, 36424.81787591065, 5250.553702935255, 6920.204176519715, 7079.752208672698, 7087.3267039631155, 7088.3620474157315, 5230.476952304777, 5299.231611416361, 5303.840884773444, 6290.622562646233, 7035.085438892962, 7070.15158181019, 7122.323379278961, 7123.964380178118, 7159.069320988264, 7163.14042314923, 7065.364117229448, 7121.857562848766, 7130.0, 7130.893036604455, 7132.108486439195, 5199.53204211619, 5340.732963351817, 6765.797026089176, 6899.931000689979, 6961.572877560088, 31857.52213716796, 32274.838625806955, 32328.030159095266, 32343.191420214447, 32405.351892962008, 2937.221636266391, 2982.0, 2983.19453747487, 2983.4928062229474, 2984.4031193761334, 24597.38506537333, 24611.0, 24668.629970550457, 24674.629880551805, 24692.25923222288, 2805.1864959161817, 2807.73326533981, 2815.408764159529, 2819.7885158613185, 2830.221689035511, 144208.0, 144268.0, 144985.275073625, 145025.274873626, 145406.27296863555, 41374.172516550105, 41666.58333416688, 41722.58277417187, 41733.37399939003, 41776.58223417727, 43271.35092973608, 43338.34992475116, 43375.34936975948, 43391.96256262031, 43392.132157356675, 12386.132970691964, 12612.0, 12621.747565048647, 12630.242185468902, 12653.430595623218, 10092.646757363456, 10116.140128089048, 10120.139788118093, 10124.240681948882, 10128.797424051478, 10423.0, 10726.785464290671, 11900.940495297467, 12401.193922395016, 12445.62663120108, 4987.326710894055, 5047.873803154877, 5066.746662666852, 5153.716545589954, 5166.948330516722, 857.648364170687, 886.3352485635774, 904.1329654264056, 918.389271134688, 924.2190349154953, 21046.47383815417, 21713.0, 21839.235626752987, 21887.781122188575, 22256.109755609596, 975.5951280218771, 976.7802244494932, 986.6729249159869, 1002.14817405205, 1002.2032484174953, 10854.620088296871, 11282.210245282915, 11539.249948753304, 11586.71033224176, 11654.417279136009, 157577.0, 158692.0, 158897.0, 159136.20431897766, 159236.0, 40618.79690601587, 40629.0, 40711.38932916008, 40723.0, 40766.79616601898, 1193.7194759231575, 1232.5008371609513, 1256.0705078242217, 1263.753568054239, 1267.4423253768311, 20158.193672252946, 20206.0, 21131.0, 21356.35263183993, 21518.569628607653, 30228.0, 30349.241268968453, 30365.0, 30376.0, 30380.24049398783, 149901.0, 149958.0, 150067.0, 150272.0, 150672.0, 29774.404511909208, 29896.25259368533, 29939.850300748356, 30022.69977300199, 30134.246643834078, 35847.82076089603, 37828.24343513169, 37862.810685946395, 38021.0, 38068.23863522659, 27042.32394190161, 28652.42695146127, 28961.855190723913, 29015.419691606472, 29025.0, 27786.583201251593, 27978.0, 28359.836618154615, 28956.27609309784, 29031.56452653254, 31135.221619459695, 31419.68580314259, 31487.84256078705, 31493.68506314999, 31501.527477087402, 26051.348716282246, 26873.193804185907, 27568.0, 28037.0, 28352.854173328673, 21699.674504882125, 22465.5506889858, 22544.77455225427, 22554.661680074485, 22570.097196111972], "value": 14370.326170647608, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.0745185473371, 427.2949633105377, 427.5339590320167, 438.3796927347803, 438.44536661123664, 13381.53164639238, 17731.55671108223, 17801.46595602134, 17867.106644667765, 17904.731429028576, 17794.733079003825, 18021.639567208647, 18214.180361883715, 18463.2614695412, 18608.906955465205, 5435.130379139338, 5580.079286917654, 5608.355039170487, 5608.663480191181, 5612.176042786111, 2761.64098667173, 2868.7561557267554, 5265.7893684252585, 5477.890442191154, 5496.0107180707455, 5493.313335833021, 5496.5053145216925, 5498.752556134984, 5499.587530935176, 5502.119660854264, 5340.145576707708, 5470.671759694431, 5494.532964698005, 5495.230667706524, 5508.669479831183, 5013.323201367805, 5014.774335154891, 5015.445211984296, 5018.623603229772, 5019.52314530119, 21167.259145929973, 21862.672059919114, 21984.560308793894, 21990.450238744, 22185.889070554706, 1451.7096580683906, 1470.3971371737537, 1470.9190994495298, 1610.557096798378, 1637.606974326165, 13866.65333366674, 14277.928610356985, 14855.514448555166, 15077.924610376987, 15196.088234705952, 1999.8500112491477, 2050.282401159597, 2054.116729806183, 2060.6084843879617, 2068.927587534429, 77263.22736772617, 77487.0, 77965.22034779636, 78943.21056789474, 79256.60371698163, 10160.0, 10948.835767463494, 10962.123030157569, 10993.835092473619, 11023.83464248037, 14299.847108553044, 14756.335964881606, 14759.926200369144, 14764.40942362315, 15470.922645386927, 7442.553446793209, 7502.924970750222, 7636.732714354971, 7654.96172519145, 7680.078390593053, 6703.128593282842, 6823.283555226729, 6972.825679358057, 6978.930210697929, 6997.370236678723, 6817.613835157755, 6980.825479363057, 7045.89431158533, 7064.50548461613, 7115.786526404217, 2064.256867527689, 2069.5860827834495, 2098.7691353951054, 2104.2004038465284, 2106.2101711858054, 808.7654580171802, 881.9250363719156, 882.748416701237, 886.7073865624328, 887.4808237181193, 17584.82415175832, 17701.734473982902, 17741.645167096587, 17923.0, 18044.819551804314, 880.3925291548811, 887.662688178488, 893.2764460786783, 897.3628723606182, 912.4935660708238, 9367.0, 9520.761980950394, 9776.804463910681, 9902.455364954852, 10053.346532475365, 344469.0, 346477.0, 347360.0, 352124.0, 353798.0, 74066.0, 74452.62773686097, 76547.0, 77267.61366193245, 80359.59820200861, 1043.0, 1065.4353192807823, 1066.0991462214417, 1069.1820757120963, 1081.118888106191, 14990.0, 15079.698406031599, 15106.54680359591, 15426.614334641723, 15574.299156537756, 37576.43635345527, 37844.62155378521, 38435.6156438432, 39664.0, 39725.0, 46813.76593117013, 47030.294545582525, 47468.287975679705, 47552.0, 50135.0, 8262.669493220204, 8287.212714792086, 8333.208345207195, 8364.163583641588, 8746.300295976434, 13243.072984890965, 13744.450221991008, 13752.0, 13798.103123296954, 13991.790123148365, 11319.151063670093, 11339.376334301693, 11596.826047609124, 11695.590654327058, 11798.233114847508, 10666.146708263164, 10948.890511094787, 10997.010269075821, 11090.057345125755, 11326.603568875049, 11203.0, 11205.719857003314, 11318.094552435621, 11461.828072578752, 11852.762944740884, 8340.207680270365, 8469.814226008488, 8499.150084991452, 8511.446755960842, 8574.142585741376, 10986.615468458565, 11239.943800280946, 12031.338276394883, 12057.758844823229, 12313.753724925273], "value": 8752.298261346843, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1232.8274041634172, 1289.8774616411442, 1296.9092163548548, 1300.2913412190355, 1309.934503274836, 9785.510724463775, 10239.948800256007, 10241.948790256058, 10254.487275636226, 10263.794724105514, 10067.798644027114, 10343.224258180648, 10350.58597656093, 10350.948245258764, 10354.0, 2200.5378870437225, 2235.4634887627017, 2240.5070884405404, 2242.6299660555987, 2242.8542144760618, 1881.444973732752, 1952.306931039482, 2137.1665050630268, 2177.401214665964, 2187.3656639574506, 2151.4728891421546, 2228.92198773043, 2231.15216217837, 2234.55308938213, 2236.1502629000956, 2157.8489505734606, 2202.7797220277926, 2209.834262430324, 2209.9558008839895, 2218.223621732397, 2193.6270833958106, 2194.462356722613, 2194.9561008779897, 2197.439652888519, 2198.692183094368, 10086.445245511493, 10316.226283028727, 10319.277650564463, 10320.380777153396, 10335.121514671262, 5518.613697041209, 5719.19931209631, 5720.684242624178, 5726.141078838166, 5730.570207234474, 3342.3148254607745, 3471.375152472554, 3618.4391419330045, 3619.692326152254, 3628.6915612172997, 1082.9133669306436, 1103.862017247844, 1107.983380249297, 1201.531402752927, 1209.558511143435, 14988.925055374762, 15142.16718080505, 15152.242387880562, 15169.317380717785, 15169.924150379287, 4589.655775816827, 4610.815567377267, 4908.067467181296, 5005.224190250517, 5023.522765337287, 10848.18638602108, 10862.72843178911, 10866.076383507332, 10867.239293249397, 10872.67381978542, 5415.864603384868, 5419.132938729785, 5426.484483974016, 5431.945680543223, 5433.402325744165, 4883.291922671193, 4889.559939605452, 4933.975330123327, 5056.519630635084, 5203.245529398216, 3838.1939792643857, 3945.368741001426, 3945.585713500099, 3990.86031988879, 4013.3779264214095, 1025.3079171559316, 1124.9381284029294, 1142.3374442823142, 1151.0446329546455, 1164.6447833410891, 610.3225419784036, 661.8312330355825, 690.2028157478121, 691.3155975584135, 695.391532409142, 5670.347909990404, 5724.313082430135, 5769.221155144001, 5872.17789509469, 5881.235439392852, 805.1988271669609, 816.1348970091603, 820.5681086504088, 834.641104325146, 841.8274253778084, 3996.5204175499125, 4208.326667733148, 4228.429162063082, 4246.554111818276, 4293.635041021548, 13121.409536570878, 13319.467221311039, 13335.933320333335, 13339.399727012307, 13413.463461461432, 12587.811182832265, 13173.60479185626, 13175.407106680032, 13196.14225075367, 13203.933980330037, 7632.732854350071, 7816.6091695415, 7817.335526480199, 7847.803804904809, 7855.253750893656, 5853.239078919713, 6154.0, 6201.2868520118955, 6254.343293954252, 6413.743450261937, 11489.827652585385, 11975.76048479043, 11983.880161198276, 12023.21849079842, 12159.392030398269, 11431.942840285745, 11694.941525292319, 11801.29192248468, 11863.169578129447, 11883.405829708652, 9469.621215151592, 9518.095780900803, 9667.129958303787, 9673.467959262309, 9675.177609903238, 9044.773880653036, 9210.125038121369, 9286.30352723535, 9290.396124251902, 9290.72127836166, 7779.338756205786, 7818.17909119557, 7931.801704957422, 7983.481073730189, 8119.918800811916, 7279.344858962719, 7566.546007239584, 7723.884141737991, 7734.961325193338, 7940.841183176189, 6982.825429364307, 7015.438764898898, 7023.859522809617, 7039.908814133817, 7177.677004534704, 5049.873753156054, 5082.542571168613, 5121.052605268037, 5123.077845987758, 5177.611679124006, 4965.379327584052, 5137.743112844418, 5209.661372010807, 5220.504052115043, 5233.241180028951], "value": 4752.227856768268, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.6798856948731, 391.97060220483473, 396.07318873835203, 396.07318873835226, 398.40637450199205, 5310.76101575429, 5341.599380046502, 5354.170103633938, 5360.061989151893, 5378.0857254266775, 5079.79680812767, 5191.896162076756, 5212.192110222912, 5242.3184985951775, 5248.291480650111, 4128.91742165158, 4156.833726650931, 4159.334506478956, 4160.479940007499, 4165.854779641381, 4159.856039589107, 4167.4790651168605, 4168.99832120874, 4177.101923086536, 4179.937300940488, 4024.8188831502507, 4143.109231515224, 4146.274401979642, 4146.274401979656, 4162.334026555752, 4106.77412742299, 4121.80467664377, 4123.835046598132, 4132.834686612532, 4142.64787493065, 3711.2020915503026, 3737.4206997915367, 3740.214554943465, 3746.250749850041, 3748.8687895923786, 5103.387593488768, 5149.665271757323, 5156.664816786897, 5158.3552055993005, 5159.638825282232, 4833.178359678863, 4862.465128835825, 4881.487443818419, 4887.36464259644, 4896.632752543574, 5578.442155784389, 5578.553715702734, 5579.525740312079, 5595.4124816894455, 5600.215969764236, 4083.958590559418, 4164.083901541656, 4207.410962465257, 4208.537060923296, 4209.158168366308, 5646.774129034834, 5807.564432667525, 5808.912866307009, 5809.128630705428, 5823.233963867129, 4362.956370436255, 4452.220861349251, 4455.799489023002, 4459.9777001115435, 4494.70784399013, 4520.88697782558, 4551.886202844956, 4562.88592785183, 4563.840265590755, 4568.771561421982, 4720.527947205252, 4782.665213435026, 4812.181929072066, 4972.0801651694555, 5012.273220383024, 5626.1842032905, 5639.548836093103, 5642.0, 5646.971765141148, 5652.773889044474, 1563.1637074165267, 1579.9526014219362, 1580.9209539522979, 1582.0586750883206, 1585.587747185717, 1104.6575561575937, 1150.9597164099216, 1152.9769404611861, 1153.5039932828963, 1160.5241850841114, 4863.1732605457155, 4891.26631005352, 4898.24077268024, 4903.583195428358, 4931.438419461983, 5768.451997060272, 5778.94221057784, 5780.0, 5791.652500849962, 5798.188253644493, 4732.266498692708, 4883.560479556857, 4902.705837649681, 4944.950550494449, 4989.600831933437, 3059.8623061962267, 3069.739072178845, 3075.6616772155044, 3080.4609193391066, 3089.165925200183, 5337.306150200527, 5394.676319420847, 5398.433164517748, 5414.620976531605, 5425.321834770653, 5961.7615295387695, 5973.671448070398, 5981.730822113015, 5982.4017598239825, 5989.371116032841, 5399.973000134974, 5409.323834520685, 5415.593830462731, 5418.376886658006, 5430.5927055471, 5721.0, 5784.855378615568, 5797.739101740347, 5849.566856120277, 5858.297004359504, 5694.409043885105, 5713.800016999385, 5744.770209191585, 5745.511631511368, 5748.885022299447, 5161.793528258828, 5179.326687530597, 5179.430262671028, 5234.555062819703, 5412.0, 3988.1624858779983, 3993.900152496211, 4000.3999400089056, 4004.8598299059395, 4015.1768887378603, 5771.884562308646, 5796.59423840344, 5797.8550536236935, 5803.100519419497, 5816.156657284755, 5398.217258497417, 5587.469190426903, 5644.774209031757, 5648.519875810603, 5650.0, 5618.185363122406, 5637.267155269788, 5637.408072152365, 5643.7742490299925, 5649.94902752509, 5443.183522471661, 5503.807366742145, 5522.30971128609, 5540.889182216252, 5547.11246200606, 5681.573881958787, 5685.317761868602, 5688.345840228261, 5706.400827913009, 5731.8567035824435, 5473.4400695801505, 5517.475839795213, 5522.9447705524035, 5523.613347065667, 5529.834104976857], "value": 4305.757211018513, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.9143348514916, 751.7744676597022, 756.0889128600038, 768.247117824532, 778.9883151752723, 11739.589114380999, 11791.231315302708, 11845.881541184586, 11855.347955862424, 11865.466054027567, 13754.17474951501, 13763.31183440829, 14108.647283817909, 14542.563723088299, 14559.636009099779, 876.0976194519639, 896.6592694775976, 898.8516894712365, 899.0829354058856, 900.0504467786483, 860.0453496618749, 886.6542048601051, 888.0719647967857, 888.524639317965, 889.0353965946955, 947.2516711797672, 955.2024059909949, 955.8948515663271, 956.1012648110753, 956.9569369378395, 948.9999999999966, 949.6343907595557, 949.8717673114111, 949.9050094990515, 954.4941181173954, 700.8668353012911, 701.6912558474306, 701.9403350715145, 702.6521871673555, 703.8275622472476, 13706.0, 13854.099483533539, 14018.228997405138, 14038.157710537298, 14075.788863167061, 15710.135942523157, 15761.29074191664, 15995.680086398323, 16141.91929040359, 16159.91920040404, 12610.936945315307, 12718.618441446772, 12749.553765618159, 12750.80873786894, 13916.373763180682, 4709.529047095298, 4738.715677059387, 4744.83393081244, 4765.142274390609, 4766.046790641885, 62823.6858815703, 63467.0, 64968.675156624384, 65603.67198164026, 68883.0, 12611.558595449298, 12862.935685321514, 12952.287624180572, 12958.740825183444, 12980.935095324463, 21964.341069767932, 22058.669119963215, 22360.664590031163, 22515.64906105606, 22581.887090564443, 5965.940340596625, 5987.64074155552, 5988.730507127189, 5997.0404735242155, 6000.459958603747, 2986.4027194561177, 3031.227037105524, 3072.9078127656207, 3094.257378229254, 3103.34829685764, 3487.4594437861665, 3567.500549923013, 3571.571411430593, 3574.57105147384, 3576.302620988934, 771.5640663025373, 796.8685166947389, 805.1787177079464, 807.9959600201961, 809.8987626546682, 559.3343920734313, 578.7762164742345, 583.8414179290021, 586.0388962102156, 587.4976894754923, 10210.387376757419, 10734.463276836126, 10781.02970732638, 11081.168912331608, 11101.1674124441, 587.33630996974, 589.7405141737707, 598.3806760003463, 602.7076867719153, 610.984725381869, 4250.0, 4384.495782984997, 4402.7358358498595, 4424.159409712209, 4426.778661066934, 61594.69202653958, 61922.0, 62409.0, 65824.67087664531, 66088.6695566519, 54704.72647636816, 55855.0, 55997.72001139968, 56878.71560642253, 58068.70965645145, 36331.273374532364, 46347.768261158475, 47719.28421073686, 47972.04055918932, 48496.5150348492, 10077.19382449417, 10973.890261097606, 11321.660350189508, 11380.089592832388, 11540.480678369326, 24483.265502034967, 24897.751022489545, 25029.249122526355, 25929.0, 26005.739942600332, 41179.58820411757, 42620.57379426166, 43854.0, 44671.55328446674, 45297.77351113223, 13647.385867635781, 13711.520096796565, 13804.447822087406, 13856.237906915216, 14013.229272390117, 15043.247837608295, 15136.697266054396, 15231.771523426936, 15515.0, 16207.0, 13023.674408139872, 13058.281794501014, 13430.462781488632, 13468.393922273717, 13495.59513214605, 13982.091164074303, 14183.0, 14360.0, 14424.134551926918, 14669.413223470941, 12755.170913890568, 13255.270960097287, 13316.733665326832, 13432.865671343552, 13460.326983650582, 9421.905780942378, 10359.533820977924, 10888.61889833852, 11057.723556911142, 11687.0, 11897.940510297392, 13052.673683157996, 13130.606081817561, 13196.736065278832, 13203.033491493336], "value": 6949.555032245266, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1527.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 112.0, 111.0, 109.0, 110.0, 110.0, 111.0, 109.0, 112.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 129.0, 124.0, 168.0, 124.0, 125.0, 124.0, 129.0, 149.0, 124.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 163.0, 162.0, 162.0, 160.0, 161.0, 163.0, 163.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 74.0, 106.0, 74.0, 76.0, 75.0, 75.0, 94.0, 75.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 116.0, 84.0, 83.0, 83.0, 100.0, 84.0, 83.0, 105.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 113.0, 114.0, 113.0, 113.0, 113.0, 115.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 149.0, 149.0, 148.0, 149.0, 148.0, 148.0, 149.0, 149.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 52.0, 51.0, 53.0, 53.0, 54.0, 53.0, 54.0, 54.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 56.0, 56.0, 56.0, 57.0, 58.0, 57.0, 56.0], "value": 56.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 85.0, 81.0, 82.0, 82.0, 81.0, 82.0, 82.0, 80.0, 80.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 133.0, 129.0, 136.0, 129.0, 137.0, 129.0, 138.0, 180.0, 142.0], "value": 138.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 190.0, 192.0, 182.0, 193.0, 192.0, 191.0, 202.0, 196.0, 191.0], "value": 191.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 72.0, 72.0, 73.0, 71.0, 71.0, 71.0, 71.0], "value": 71.9, "unit": "score"}]}]} 05:52:13 INFO - Return code: 0 05:52:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:52:13 INFO - # TBPL SUCCESS # 05:52:13 INFO - Running post-action listener: _resource_record_post_action 05:52:13 INFO - [mozharness: 2017-05-10 12:52:13.317432Z] Finished run-tests step (success) 05:52:13 INFO - Running post-run listener: _resource_record_post_run 05:52:13 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 359714816; Read time: 0; Write time: 187368 05:52:13 INFO - TinderboxPrint: CPU usage
12.9% 05:52:13 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:52:13 INFO - TinderboxPrint: I/O write bytes / time
359,714,816 / 187,368 05:52:13 INFO - TinderboxPrint: CPU idle
8,331.9 (87.1%) 05:52:13 INFO - TinderboxPrint: CPU user
1,195.9 (12.5%) 05:52:13 INFO - TinderboxPrint: Swap in / out
0 / 0 05:52:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106287104; Read time: 0; Write time: 67332 05:52:13 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 252817408; Read time: 0; Write time: 119996 05:52:13 INFO - Running post-run listener: _upload_blobber_files 05:52:13 INFO - Blob upload gear active. 05:52:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:52:13 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 05:52:13 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'] 05:52:13 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 05:52:14 INFO - (blobuploader) - INFO - Open directory for files ... 05:52:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:52:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:52:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:17 INFO - (blobuploader) - INFO - Done attempting. 05:52:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:52:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:52:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:19 INFO - (blobuploader) - INFO - Done attempting. 05:52:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:52:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:52:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:20 INFO - (blobuploader) - INFO - Done attempting. 05:52:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:52:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:52:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:21 INFO - (blobuploader) - INFO - Done attempting. 05:52:21 INFO - (blobuploader) - INFO - Iteration through files over. 05:52:21 INFO - Return code: 0 05:52:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:52:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:52:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23b76bcb69f4065c7ddf05783d6ea89a0a6ee8379e13baa9604bb66423ac6be3e23b2bf53f0af929f26c48c52238f8c04c41a9e1e4de92e30d67a0497400c3b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7f7aec842075a150b46bb89358848d5989a98ad8e6efe7ab3e88a1024000ed1261484e548ca74f257c043f266d8419ac6f73debf1e91367534ab8bc2937be51", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/810049d779c6c1db573c9b32fdb8c50b876f74acb74304731cdebad2f589dd14a26925d8aa1f5c4f3132d16b9911384ae05217619b8a62fa02ef7fd88e548cf2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b57bee62aa49ff297986094068f93f77277b9476df02948d3bc58c152a2bfa9d2f6f1901199396afd2485deba3634d3cacde998168b6ceaea322c311b13e6061"} 05:52:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:52:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:52:21 INFO - Contents: 05:52:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23b76bcb69f4065c7ddf05783d6ea89a0a6ee8379e13baa9604bb66423ac6be3e23b2bf53f0af929f26c48c52238f8c04c41a9e1e4de92e30d67a0497400c3b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7f7aec842075a150b46bb89358848d5989a98ad8e6efe7ab3e88a1024000ed1261484e548ca74f257c043f266d8419ac6f73debf1e91367534ab8bc2937be51", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/810049d779c6c1db573c9b32fdb8c50b876f74acb74304731cdebad2f589dd14a26925d8aa1f5c4f3132d16b9911384ae05217619b8a62fa02ef7fd88e548cf2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b57bee62aa49ff297986094068f93f77277b9476df02948d3bc58c152a2bfa9d2f6f1901199396afd2485deba3634d3cacde998168b6ceaea322c311b13e6061"} 05:52:21 INFO - Running post-run listener: copy_logs_to_upload_dir 05:52:21 INFO - Copying logs to upload dir... 05:52:21 INFO - mkdir: /builds/slave/test/build/upload/logs 05:52:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.642910 ========= master_lag: 0.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-05-10 05:52:21.137854) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 05:52:21.145954) ========= 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=438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23b76bcb69f4065c7ddf05783d6ea89a0a6ee8379e13baa9604bb66423ac6be3e23b2bf53f0af929f26c48c52238f8c04c41a9e1e4de92e30d67a0497400c3b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7f7aec842075a150b46bb89358848d5989a98ad8e6efe7ab3e88a1024000ed1261484e548ca74f257c043f266d8419ac6f73debf1e91367534ab8bc2937be51", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/810049d779c6c1db573c9b32fdb8c50b876f74acb74304731cdebad2f589dd14a26925d8aa1f5c4f3132d16b9911384ae05217619b8a62fa02ef7fd88e548cf2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b57bee62aa49ff297986094068f93f77277b9476df02948d3bc58c152a2bfa9d2f6f1901199396afd2485deba3634d3cacde998168b6ceaea322c311b13e6061"} build_url:https://queue.taskcluster.net/v1/task/QgSKW6CSQ3GvM-OoRtGyXw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/QgSKW6CSQ3GvM-OoRtGyXw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23b76bcb69f4065c7ddf05783d6ea89a0a6ee8379e13baa9604bb66423ac6be3e23b2bf53f0af929f26c48c52238f8c04c41a9e1e4de92e30d67a0497400c3b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7f7aec842075a150b46bb89358848d5989a98ad8e6efe7ab3e88a1024000ed1261484e548ca74f257c043f266d8419ac6f73debf1e91367534ab8bc2937be51", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/810049d779c6c1db573c9b32fdb8c50b876f74acb74304731cdebad2f589dd14a26925d8aa1f5c4f3132d16b9911384ae05217619b8a62fa02ef7fd88e548cf2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b57bee62aa49ff297986094068f93f77277b9476df02948d3bc58c152a2bfa9d2f6f1901199396afd2485deba3634d3cacde998168b6ceaea322c311b13e6061"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 05:52:21.176898) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 05:52:21.177337) ========= 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=438111f3d31ce799eff2119d000001bc-1494418754.964422-360621038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 05:52:21.227341) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 05:52:21.230814) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 05:52:21.231213) ========= ========= Total master_lag: 0.28 =========