builder: pine_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-009 starttime: 1490321062.59 results: success (0) revision: ca70726efd142fc7b8d7658b528b3d8da0310f0e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 19:04:22.590176) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 19:04:22.590643) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 19:04:22.590917) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 19:04:22.605873) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 19:04:22.606254) ========= 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=17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-23 19:04: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2017-03-23 19:04:23 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126928 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 19:04:22.747038) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 19:04:22.750435) ========= 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=17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019336 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 19:04:22.800199) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 19:04:22.800564) ========= bash -c 'python archiver_client.py mozharness --repo projects/pine --rev ca70726efd142fc7b8d7658b528b3d8da0310f0e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/pine --rev ca70726efd142fc7b8d7658b528b3d8da0310f0e --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=17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-23 19:04:23,139 truncating revision to first 12 chars 2017-03-23 19:04:23,139 Setting DEBUG logging. 2017-03-23 19:04:23,139 attempt 1/10 2017-03-23 19:04:23,139 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/pine/ca70726efd14?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-23 19:04:24,496 unpacking tar archive at: pine-ca70726efd14/testing/mozharness/ program finished with exit code 0 elapsedTime=1.710653 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 19:04:24.529799) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 19:04:24.530136) ========= script_repo_revision: ca70726efd142fc7b8d7658b528b3d8da0310f0e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 19:04:24.531016) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 19:04:24.531662) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 19:04:24.544811) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-03-23 19:04:24.545488) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Pine --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 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', 'Pine', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Pine'] 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=17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:04:24 INFO - MultiFileLogger online at 20170323 19:04:24 in /builds/slave/test 19:04:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Pine --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 19:04:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:04:24 INFO - {'append_to_log': False, 19:04:24 INFO - 'base_work_dir': '/builds/slave/test', 19:04:24 INFO - 'blob_upload_branch': 'Pine', 19:04:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:04:24 INFO - 'branch': 'Pine', 19:04:24 INFO - 'buildbot_json_path': 'buildprops.json', 19:04:24 INFO - 'config_files': ('talos/linux_config.py',), 19:04:24 INFO - 'default_actions': ('clobber', 19:04:24 INFO - 'read-buildbot-config', 19:04:24 INFO - 'download-and-extract', 19:04:24 INFO - 'populate-webroot', 19:04:24 INFO - 'create-virtualenv', 19:04:24 INFO - 'install', 19:04:24 INFO - 'run-tests'), 19:04:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:04:24 INFO - 'download_minidump_stackwalk': True, 19:04:24 INFO - 'download_symbols': 'ondemand', 19:04:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:04:24 INFO - 'tooltool.py': '/tools/tooltool.py', 19:04:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:04:24 INFO - '/tools/misc-python/virtualenv.py')}, 19:04:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:04:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:04:24 INFO - 'gecko_profile': False, 19:04:24 INFO - 'gecko_profile_interval': 0, 19:04:24 INFO - 'installer_path': 'installer.exe', 19:04:24 INFO - 'log_level': 'info', 19:04:24 INFO - 'log_name': 'talos', 19:04:24 INFO - 'log_to_console': True, 19:04:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:04:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:04:24 INFO - 'opt_config_files': (), 19:04:24 INFO - 'pip_index': False, 19:04:24 INFO - 'suite': 'dromaeojs', 19:04:24 INFO - 'system_bits': '32', 19:04:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:04:24 INFO - 'title': 'talos-linux64-ix-009', 19:04:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:04:24 INFO - 'use_talos_json': True, 19:04:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:04:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:04:24 INFO - 'work_dir': 'build'} 19:04:24 INFO - [mozharness: 2017-03-24 02:04:24.985517Z] Running clobber step. 19:04:24 INFO - Running pre-action listener: _resource_record_pre_action 19:04:24 INFO - Running main action method: clobber 19:04:24 INFO - rmtree: /builds/slave/test/build 19:04:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:04:25 INFO - Running post-action listener: _resource_record_post_action 19:04:25 INFO - [mozharness: 2017-03-24 02:04:25.938105Z] Finished clobber step (success) 19:04:25 INFO - [mozharness: 2017-03-24 02:04:25.938207Z] Running read-buildbot-config step. 19:04:25 INFO - Running pre-action listener: _resource_record_pre_action 19:04:25 INFO - Running main action method: read_buildbot_config 19:04:25 INFO - Using buildbot properties: 19:04:25 INFO - { 19:04:25 INFO - "project": "", 19:04:25 INFO - "product": "firefox", 19:04:25 INFO - "who": "dmosedale@mozilla.com", 19:04:25 INFO - "installer_path": "public/build/target.tar.bz2", 19:04:25 INFO - "builddir": "pine_ubuntu64_hw_test-dromaeojs", 19:04:25 INFO - "repository": "https://hg.mozilla.org/projects/pine/", 19:04:25 INFO - "buildername": "Ubuntu HW 12.04 x64 pine talos dromaeojs", 19:04:25 INFO - "stage_platform": "linux64", 19:04:25 INFO - "basedir": "/builds/slave/test", 19:04:25 INFO - "buildnumber": 1, 19:04:25 INFO - "platform": "ubuntu64_hw", 19:04:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:04:25 INFO - "slavebuilddir": "test", 19:04:25 INFO - "taskId": "PFuNeAT_TJ6rsTYKVhucZw", 19:04:25 INFO - "branch": "pine", 19:04:25 INFO - "script_repo_revision": "default", 19:04:25 INFO - "revision": "ca70726efd142fc7b8d7658b528b3d8da0310f0e", 19:04:25 INFO - "slavename": "talos-linux64-ix-009", 19:04:25 INFO - "repo_path": "projects/pine" 19:04:25 INFO - } 19:04:25 INFO - Finding installer, test and symbols from parent task. 19:04:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PFuNeAT_TJ6rsTYKVhucZw'}, attempt #1 19:04:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PFuNeAT_TJ6rsTYKVhucZw'}, attempt #1 19:04:26 INFO - Task dependencies: L2z-0K3WS3Wl8DUv-yQl8w 19:04:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L2z-0K3WS3Wl8DUv-yQl8w'}, attempt #1 19:04:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/L2z-0K3WS3Wl8DUv-yQl8w/artifacts/public/build/target.tar.bz2 19:04:27 INFO - Set test_url: https://queue.taskcluster.net/v1/task/L2z-0K3WS3Wl8DUv-yQl8w/artifacts/public/build/test_packages.json 19:04:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/L2z-0K3WS3Wl8DUv-yQl8w/artifacts/public/build/target.crashreporter-symbols.zip 19:04:27 INFO - Running post-action listener: _resource_record_post_action 19:04:27 INFO - [mozharness: 2017-03-24 02:04:27.345179Z] Finished read-buildbot-config step (success) 19:04:27 INFO - [mozharness: 2017-03-24 02:04:27.345396Z] Running download-and-extract step. 19:04:27 INFO - Running pre-action listener: _resource_record_pre_action 19:04:27 INFO - Running main action method: download_and_extract 19:04:27 INFO - mkdir: /builds/slave/test/build/tests 19:04:27 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')]} 19:04:27 INFO - trying https://queue.taskcluster.net/v1/task/L2z-0K3WS3Wl8DUv-yQl8w/artifacts/public/build/target.test_packages.json 19:04:27 INFO - Downloading https://queue.taskcluster.net/v1/task/L2z-0K3WS3Wl8DUv-yQl8w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:04:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L2z-0K3WS3Wl8DUv-yQl8w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:04:27 INFO - Downloaded 986 bytes. 19:04:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:04:27 INFO - Using the following test package requirements: 19:04:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:04:27 INFO - u'common': [u'target.common.tests.zip'], 19:04:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:04:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:04:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:04:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:04:27 INFO - u'mozbase': [u'target.common.tests.zip'], 19:04:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:04:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:04:27 INFO - u'web-platform': [u'target.common.tests.zip', 19:04:27 INFO - u'target.web-platform.tests.zip'], 19:04:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:04:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:04:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L2z-0K3WS3Wl8DUv-yQl8w/artifacts/public/build/target.common.tests.zip 19:04:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L2z-0K3WS3Wl8DUv-yQl8w/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:04:27 INFO - Fetch https://queue.taskcluster.net/v1/task/L2z-0K3WS3Wl8DUv-yQl8w/artifacts/public/build/target.common.tests.zip into memory 19:04:29 INFO - Expected file size: 58125546 19:04:29 INFO - Obtained file size: 58125546 19:04:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:04:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L2z-0K3WS3Wl8DUv-yQl8w/artifacts/public/build/target.common.tests.zip 19:04:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L2z-0K3WS3Wl8DUv-yQl8w/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:04:39 INFO - Fetch https://queue.taskcluster.net/v1/task/L2z-0K3WS3Wl8DUv-yQl8w/artifacts/public/build/target.common.tests.zip into memory 19:04:40 INFO - Expected file size: 58125546 19:04:40 INFO - Obtained file size: 58125546 19:04:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L2z-0K3WS3Wl8DUv-yQl8w/artifacts/public/build/target.talos.tests.zip 19:04:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L2z-0K3WS3Wl8DUv-yQl8w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:04:51 INFO - Fetch https://queue.taskcluster.net/v1/task/L2z-0K3WS3Wl8DUv-yQl8w/artifacts/public/build/target.talos.tests.zip into memory 19:04:52 INFO - Expected file size: 14404171 19:04:52 INFO - Obtained file size: 14404171 19:04: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')]} 19:04:52 INFO - trying https://queue.taskcluster.net/v1/task/L2z-0K3WS3Wl8DUv-yQl8w/artifacts/public/build/target.tar.bz2 19:04:52 INFO - Downloading https://queue.taskcluster.net/v1/task/L2z-0K3WS3Wl8DUv-yQl8w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:04:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L2z-0K3WS3Wl8DUv-yQl8w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:04:53 INFO - Downloaded 62612941 bytes. 19:04:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L2z-0K3WS3Wl8DUv-yQl8w/artifacts/public/build/target.tar.bz2 19:04:53 INFO - mkdir: /builds/slave/test/properties 19:04:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:04:53 INFO - Writing to file /builds/slave/test/properties/build_url 19:04:53 INFO - Contents: 19:04:53 INFO - build_url:https://queue.taskcluster.net/v1/task/L2z-0K3WS3Wl8DUv-yQl8w/artifacts/public/build/target.tar.bz2 19:04:53 INFO - Running post-action listener: _resource_record_post_action 19:04:53 INFO - Running post-action listener: set_extra_try_arguments 19:04:53 INFO - [mozharness: 2017-03-24 02:04:53.790858Z] Finished download-and-extract step (success) 19:04:53 INFO - [mozharness: 2017-03-24 02:04:53.790955Z] Running populate-webroot step. 19:04:53 INFO - Running pre-action listener: _resource_record_pre_action 19:04:53 INFO - Running main action method: populate_webroot 19:04:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:04:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:04:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:04:53 INFO - '--tppagecycles', 19:04:53 INFO - '7'], 19:04:53 INFO - 'tests': ['tsvgm']}}, 19:04:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:04:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:04:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:04:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:04:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:04:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:04:53 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:04:53 INFO - 'talos_options': ['--disable-e10s'], 19:04:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:04:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:04:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:04:53 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:04:53 INFO - 'talos_options': ['--disable-e10s'], 19:04:53 INFO - 'tests': ['damp', 'tps']}, 19:04:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:04:53 INFO - 'tests': ['damp', 'tps']}, 19:04:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:04:53 INFO - 'tests': ['dromaeo_dom']}, 19:04:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:04:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:04:53 INFO - 'tests': ['basic_compositor_video']}, 19:04:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:04:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:04:53 INFO - 'tests': ['a11yr', 19:04:53 INFO - 'ts_paint', 19:04:53 INFO - 'tpaint', 19:04:53 INFO - 'sessionrestore', 19:04:53 INFO - 'sessionrestore_no_auto_restore', 19:04:53 INFO - 'tabpaint']}, 19:04:53 INFO - 'other-e10s': {'tests': ['a11yr', 19:04:53 INFO - 'ts_paint', 19:04:53 INFO - 'tpaint', 19:04:53 INFO - 'sessionrestore', 19:04:53 INFO - 'sessionrestore_no_auto_restore', 19:04:53 INFO - 'tabpaint']}, 19:04:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:04:53 INFO - 'ts_paint', 19:04:53 INFO - 'tpaint', 19:04:53 INFO - 'sessionrestore', 19:04:53 INFO - 'sessionrestore_no_auto_restore', 19:04:53 INFO - 'tabpaint']}, 19:04:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:04:53 INFO - 'ts_paint', 19:04:53 INFO - 'tpaint', 19:04:53 INFO - 'sessionrestore', 19:04:53 INFO - 'sessionrestore_no_auto_restore', 19:04:53 INFO - 'tabpaint']}, 19:04:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:04:53 INFO - 'tests': ['a11yr', 19:04:53 INFO - 'ts_paint', 19:04:53 INFO - 'tpaint', 19:04:53 INFO - 'sessionrestore', 19:04:53 INFO - 'sessionrestore_no_auto_restore', 19:04:53 INFO - 'tabpaint']}, 19:04:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:04:53 INFO - 'tests': ['a11yr', 19:04:53 INFO - 'ts_paint', 19:04:53 INFO - 'tpaint', 19:04:53 INFO - 'sessionrestore', 19:04:53 INFO - 'sessionrestore_no_auto_restore', 19:04:53 INFO - 'tabpaint']}, 19:04:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:04:53 INFO - 'tests': ['tsvgx', 19:04:53 INFO - 'tsvgr_opacity', 19:04:53 INFO - 'tart', 19:04:53 INFO - 'tscrollx', 19:04:53 INFO - 'cart', 19:04:53 INFO - 'tsvg_static']}, 19:04:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:04:53 INFO - 'tsvgr_opacity', 19:04:53 INFO - 'tart', 19:04:53 INFO - 'tscrollx', 19:04:53 INFO - 'cart', 19:04:53 INFO - 'tsvg_static']}, 19:04:53 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:04:53 INFO - 'talos_options': ['--disable-e10s'], 19:04:53 INFO - 'tests': ['tp5o']}, 19:04:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:04:53 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:04:53 INFO - 'talos_options': ['--disable-e10s', 19:04:53 INFO - '--xperf_path', 19:04:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:04:53 INFO - 'tests': ['tp5n']}, 19:04:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:04:53 INFO - 'talos_options': ['--xperf_path', 19:04:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:04:53 INFO - 'tests': ['tp5n']}}, 19:04:53 INFO - 'talos.zip': {'path': '', 19:04:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:04:53 INFO - Running post-action listener: _resource_record_post_action 19:04:53 INFO - [mozharness: 2017-03-24 02:04:53.804213Z] Finished populate-webroot step (success) 19:04:53 INFO - [mozharness: 2017-03-24 02:04:53.804304Z] Running create-virtualenv step. 19:04:53 INFO - Running pre-action listener: _resource_record_pre_action 19:04:53 INFO - Running main action method: create_virtualenv 19:04:53 INFO - Creating virtualenv /builds/slave/test/build/venv 19:04:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:04:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:04:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:04:53 INFO - Using real prefix '/usr' 19:04:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:04:54 INFO - Installing distribute.............................................................................................................................................................................................done. 19:04:56 INFO - Installing pip.................done. 19:04:56 INFO - Return code: 0 19:04:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:04:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:04:56 INFO - Reading from file tmpfile_stdout 19:04:56 INFO - Output received: 19:04:56 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 19:04:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6400>, '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 0x15d73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d7840>, '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': '17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077', '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 19:04:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:04:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:04:56 INFO - Using env: {'DISPLAY': ':0', 19:04:56 INFO - 'HOME': '/home/cltbld', 19:04:56 INFO - 'LANG': 'en_US.UTF-8', 19:04:56 INFO - 'LANGUAGE': 'en_US:en', 19:04:56 INFO - 'LOGNAME': 'cltbld', 19:04:56 INFO - 'MAIL': '/var/mail/cltbld', 19:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:56 INFO - 'MOZ_NO_REMOTE': '1', 19:04:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:56 INFO - 'NO_EM_RESTART': '1', 19:04:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:56 INFO - 'PWD': '/builds/slave/test', 19:04:56 INFO - 'SHELL': '/bin/bash', 19:04:56 INFO - 'SHLVL': '1', 19:04:56 INFO - 'TERM': 'linux', 19:04:56 INFO - 'TMOUT': '86400', 19:04:56 INFO - 'USER': 'cltbld', 19:04:56 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077', 19:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:56 INFO - '_': '/tools/buildbot/bin/python'} 19:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:04:56 INFO - Cleaning up... 19:04:56 INFO - Return code: 0 19:04:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6400>, '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 0x15d73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d7840>, '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': '17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077', '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 19:04:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:04:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:04:56 INFO - Using env: {'DISPLAY': ':0', 19:04:56 INFO - 'HOME': '/home/cltbld', 19:04:56 INFO - 'LANG': 'en_US.UTF-8', 19:04:56 INFO - 'LANGUAGE': 'en_US:en', 19:04:56 INFO - 'LOGNAME': 'cltbld', 19:04:56 INFO - 'MAIL': '/var/mail/cltbld', 19:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:56 INFO - 'MOZ_NO_REMOTE': '1', 19:04:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:56 INFO - 'NO_EM_RESTART': '1', 19:04:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:56 INFO - 'PWD': '/builds/slave/test', 19:04:56 INFO - 'SHELL': '/bin/bash', 19:04:56 INFO - 'SHLVL': '1', 19:04:56 INFO - 'TERM': 'linux', 19:04:56 INFO - 'TMOUT': '86400', 19:04:56 INFO - 'USER': 'cltbld', 19:04:56 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077', 19:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:56 INFO - '_': '/tools/buildbot/bin/python'} 19:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:57 INFO - Downloading/unpacking psutil>=3.1.1 19:04:57 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 19:04:57 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 19:04:57 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 19:04:57 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 19:04:57 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 19:04:57 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 19:04:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:04:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:04:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:04:59 INFO - Installing collected packages: psutil 19:04:59 INFO - Running setup.py install for psutil 19:04:59 INFO - building 'psutil._psutil_linux' extension 19:04:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:04:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:04:59 INFO - building 'psutil._psutil_posix' extension 19:04:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:04:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:04:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:04:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:04:59 INFO - Successfully installed psutil 19:04:59 INFO - Cleaning up... 19:04:59 INFO - Return code: 0 19:04:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6400>, '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 0x15d73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d7840>, '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': '17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077', '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 19:04:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:04:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:04:59 INFO - Using env: {'DISPLAY': ':0', 19:04:59 INFO - 'HOME': '/home/cltbld', 19:04:59 INFO - 'LANG': 'en_US.UTF-8', 19:04:59 INFO - 'LANGUAGE': 'en_US:en', 19:04:59 INFO - 'LOGNAME': 'cltbld', 19:04:59 INFO - 'MAIL': '/var/mail/cltbld', 19:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:59 INFO - 'MOZ_NO_REMOTE': '1', 19:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:59 INFO - 'NO_EM_RESTART': '1', 19:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:59 INFO - 'PWD': '/builds/slave/test', 19:04:59 INFO - 'SHELL': '/bin/bash', 19:04:59 INFO - 'SHLVL': '1', 19:04:59 INFO - 'TERM': 'linux', 19:04:59 INFO - 'TMOUT': '86400', 19:04:59 INFO - 'USER': 'cltbld', 19:04:59 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077', 19:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:59 INFO - '_': '/tools/buildbot/bin/python'} 19:05:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:05:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:05:02 INFO - Installing collected packages: mozsystemmonitor 19:05:02 INFO - Running setup.py install for mozsystemmonitor 19:05:02 INFO - Successfully installed mozsystemmonitor 19:05:02 INFO - Cleaning up... 19:05:02 INFO - Return code: 0 19:05:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:05: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')]} 19:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05: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')]} 19:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05: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 0x133b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6400>, '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 0x15d73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d7840>, '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': '17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077', '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 19:05: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 19:05: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 19:05:02 INFO - Using env: {'DISPLAY': ':0', 19:05:02 INFO - 'HOME': '/home/cltbld', 19:05:02 INFO - 'LANG': 'en_US.UTF-8', 19:05:02 INFO - 'LANGUAGE': 'en_US:en', 19:05:02 INFO - 'LOGNAME': 'cltbld', 19:05:02 INFO - 'MAIL': '/var/mail/cltbld', 19:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:02 INFO - 'MOZ_NO_REMOTE': '1', 19:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:02 INFO - 'NO_EM_RESTART': '1', 19:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:02 INFO - 'PWD': '/builds/slave/test', 19:05:02 INFO - 'SHELL': '/bin/bash', 19:05:02 INFO - 'SHLVL': '1', 19:05:02 INFO - 'TERM': 'linux', 19:05:02 INFO - 'TMOUT': '86400', 19:05:02 INFO - 'USER': 'cltbld', 19:05:02 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077', 19:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:02 INFO - '_': '/tools/buildbot/bin/python'} 19:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:02 INFO - Downloading/unpacking jsonschema==2.5.1 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:05:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05:04 INFO - Downloading functools32-3.2.3-2.tar.gz 19:05:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:05:04 INFO - warning: no files found matching '*.txt' 19:05:04 INFO - no previously-included directories found matching 'build' 19:05:04 INFO - no previously-included directories found matching 'dist' 19:05:04 INFO - no previously-included directories found matching '.git*' 19:05:04 INFO - Installing collected packages: jsonschema, functools32 19:05:04 INFO - Running setup.py install for functools32 19:05:04 INFO - warning: no files found matching '*.txt' 19:05:04 INFO - no previously-included directories found matching 'build' 19:05:04 INFO - no previously-included directories found matching 'dist' 19:05:04 INFO - no previously-included directories found matching '.git*' 19:05:05 INFO - Successfully installed jsonschema functools32 19:05:05 INFO - Cleaning up... 19:05:05 INFO - Return code: 0 19:05:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x133b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6400>, '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 0x15d73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d7840>, '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': '17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077', '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 19:05:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:05:05 INFO - Using env: {'DISPLAY': ':0', 19:05:05 INFO - 'HOME': '/home/cltbld', 19:05:05 INFO - 'LANG': 'en_US.UTF-8', 19:05:05 INFO - 'LANGUAGE': 'en_US:en', 19:05:05 INFO - 'LOGNAME': 'cltbld', 19:05:05 INFO - 'MAIL': '/var/mail/cltbld', 19:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:05 INFO - 'MOZ_NO_REMOTE': '1', 19:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:05 INFO - 'NO_EM_RESTART': '1', 19:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:05 INFO - 'PWD': '/builds/slave/test', 19:05:05 INFO - 'SHELL': '/bin/bash', 19:05:05 INFO - 'SHLVL': '1', 19:05:05 INFO - 'TERM': 'linux', 19:05:05 INFO - 'TMOUT': '86400', 19:05:05 INFO - 'USER': 'cltbld', 19:05:05 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077', 19:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:05 INFO - '_': '/tools/buildbot/bin/python'} 19:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:05:05 INFO - Cleaning up... 19:05:05 INFO - Return code: 0 19:05:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6400>, '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 0x15d73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d7840>, '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': '17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077', '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 19:05:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:05:05 INFO - Using env: {'DISPLAY': ':0', 19:05:05 INFO - 'HOME': '/home/cltbld', 19:05:05 INFO - 'LANG': 'en_US.UTF-8', 19:05:05 INFO - 'LANGUAGE': 'en_US:en', 19:05:05 INFO - 'LOGNAME': 'cltbld', 19:05:05 INFO - 'MAIL': '/var/mail/cltbld', 19:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:05 INFO - 'MOZ_NO_REMOTE': '1', 19:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:05 INFO - 'NO_EM_RESTART': '1', 19:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:05 INFO - 'PWD': '/builds/slave/test', 19:05:05 INFO - 'SHELL': '/bin/bash', 19:05:05 INFO - 'SHLVL': '1', 19:05:05 INFO - 'TERM': 'linux', 19:05:05 INFO - 'TMOUT': '86400', 19:05:05 INFO - 'USER': 'cltbld', 19:05:05 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077', 19:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:05 INFO - '_': '/tools/buildbot/bin/python'} 19:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:05 INFO - Downloading/unpacking blobuploader==1.2.4 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05:07 INFO - Downloading blobuploader-1.2.4.tar.gz 19:05:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:05:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:05:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:08 INFO - Downloading docopt-0.6.1.tar.gz 19:05:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:05:08 INFO - Installing collected packages: blobuploader, requests, docopt 19:05:08 INFO - Running setup.py install for blobuploader 19:05:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:05:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:05:08 INFO - Running setup.py install for requests 19:05:09 INFO - Running setup.py install for docopt 19:05:09 INFO - Successfully installed blobuploader requests docopt 19:05:09 INFO - Cleaning up... 19:05:09 INFO - Return code: 0 19:05:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6400>, '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 0x15d73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d7840>, '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': '17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077', '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 19:05:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:05:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:05:09 INFO - Using env: {'DISPLAY': ':0', 19:05:09 INFO - 'HOME': '/home/cltbld', 19:05:09 INFO - 'LANG': 'en_US.UTF-8', 19:05:09 INFO - 'LANGUAGE': 'en_US:en', 19:05:09 INFO - 'LOGNAME': 'cltbld', 19:05:09 INFO - 'MAIL': '/var/mail/cltbld', 19:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:09 INFO - 'MOZ_NO_REMOTE': '1', 19:05:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:09 INFO - 'NO_EM_RESTART': '1', 19:05:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:09 INFO - 'PWD': '/builds/slave/test', 19:05:09 INFO - 'SHELL': '/bin/bash', 19:05:09 INFO - 'SHLVL': '1', 19:05:09 INFO - 'TERM': 'linux', 19:05:09 INFO - 'TMOUT': '86400', 19:05:09 INFO - 'USER': 'cltbld', 19:05:09 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077', 19:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:09 INFO - '_': '/tools/buildbot/bin/python'} 19:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:05:09 INFO - Running setup.py (path:/tmp/pip-5kB1Xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:05:09 INFO - Running setup.py (path:/tmp/pip-NKss0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:05:09 INFO - Running setup.py (path:/tmp/pip-3kIc6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:05:09 INFO - Running setup.py (path:/tmp/pip-fArP0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:05:10 INFO - Running setup.py (path:/tmp/pip-oO6rs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:05:10 INFO - Running setup.py (path:/tmp/pip-YIMwmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:05:10 INFO - Running setup.py (path:/tmp/pip-LgtGMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:05:10 INFO - Running setup.py (path:/tmp/pip-PelP1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:05:10 INFO - Running setup.py (path:/tmp/pip-VMDB2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:05:10 INFO - Running setup.py (path:/tmp/pip-vunR7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:05:10 INFO - Running setup.py (path:/tmp/pip-_3TaJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:05:10 INFO - Running setup.py (path:/tmp/pip-dYbvlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:05:10 INFO - Running setup.py (path:/tmp/pip-6pIBsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:05:10 INFO - Running setup.py (path:/tmp/pip-ulxCl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:10 INFO - Running setup.py (path:/tmp/pip-v8CEgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:05:10 INFO - Running setup.py (path:/tmp/pip-j4qtpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:05:10 INFO - Running setup.py (path:/tmp/pip-QCCCf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:05:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:05:10 INFO - Running setup.py install for manifestparser 19:05:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:05:11 INFO - Running setup.py install for mozcrash 19:05:11 INFO - Running setup.py install for mozdebug 19:05:11 INFO - Running setup.py install for mozdevice 19:05:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:05:11 INFO - Running setup.py install for mozfile 19:05:11 INFO - Running setup.py install for mozhttpd 19:05:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:05:11 INFO - Running setup.py install for mozinfo 19:05:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:05:11 INFO - Running setup.py install for mozInstall 19:05:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:05:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:05:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:05:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:05:11 INFO - Running setup.py install for mozleak 19:05:11 INFO - Running setup.py install for mozlog 19:05:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:05:12 INFO - Running setup.py install for moznetwork 19:05:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:05:12 INFO - Running setup.py install for mozprocess 19:05:12 INFO - Running setup.py install for mozprofile 19:05:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:05:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:05:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:05:12 INFO - Running setup.py install for mozrunner 19:05:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:05:12 INFO - Running setup.py install for mozscreenshot 19:05:12 INFO - Running setup.py install for moztest 19:05:12 INFO - Running setup.py install for mozversion 19:05:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:05:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:05:12 INFO - Cleaning up... 19:05:12 INFO - Return code: 0 19:05:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6400>, '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 0x15d73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d7840>, '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': '17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077', '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 19:05:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:05:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:05:12 INFO - Using env: {'DISPLAY': ':0', 19:05:12 INFO - 'HOME': '/home/cltbld', 19:05:12 INFO - 'LANG': 'en_US.UTF-8', 19:05:12 INFO - 'LANGUAGE': 'en_US:en', 19:05:12 INFO - 'LOGNAME': 'cltbld', 19:05:12 INFO - 'MAIL': '/var/mail/cltbld', 19:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:12 INFO - 'MOZ_NO_REMOTE': '1', 19:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:12 INFO - 'NO_EM_RESTART': '1', 19:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:12 INFO - 'PWD': '/builds/slave/test', 19:05:12 INFO - 'SHELL': '/bin/bash', 19:05:12 INFO - 'SHLVL': '1', 19:05:12 INFO - 'TERM': 'linux', 19:05:12 INFO - 'TMOUT': '86400', 19:05:12 INFO - 'USER': 'cltbld', 19:05:12 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077', 19:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:12 INFO - '_': '/tools/buildbot/bin/python'} 19:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:05:13 INFO - Running setup.py (path:/tmp/pip-M7mVoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:05:13 INFO - Running setup.py (path:/tmp/pip-FejuZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:05:13 INFO - Running setup.py (path:/tmp/pip-9M2de5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:05:13 INFO - Running setup.py (path:/tmp/pip-tzRmps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:05:13 INFO - Running setup.py (path:/tmp/pip-xYxWGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:05:13 INFO - Running setup.py (path:/tmp/pip-1Qy_V_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:05:13 INFO - Running setup.py (path:/tmp/pip-BgEhk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:05:13 INFO - Running setup.py (path:/tmp/pip-PGHjuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:05:13 INFO - Running setup.py (path:/tmp/pip-x1HJmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:05:13 INFO - Running setup.py (path:/tmp/pip-TgjIgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:05:13 INFO - Running setup.py (path:/tmp/pip-9lVFDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:05:13 INFO - Running setup.py (path:/tmp/pip-NdNR90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:05:13 INFO - Running setup.py (path:/tmp/pip-wVCN3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:05:13 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)) 19:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:05:13 INFO - Running setup.py (path:/tmp/pip-x_wdcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:14 INFO - Running setup.py (path:/tmp/pip-M4EApR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:05:14 INFO - Running setup.py (path:/tmp/pip-GDqjIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:05:14 INFO - Running setup.py (path:/tmp/pip-Paur8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:05:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:16 INFO - Downloading blessings-1.6.tar.gz 19:05:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:05:16 INFO - Installing collected packages: blessings 19:05:16 INFO - Running setup.py install for blessings 19:05:16 INFO - Successfully installed blessings 19:05:16 INFO - Cleaning up... 19:05:16 INFO - Return code: 0 19:05:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:05:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:05:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:05:16 INFO - Reading from file tmpfile_stdout 19:05:16 INFO - Current package versions: 19:05:16 INFO - argparse == 1.2.1 19:05:16 INFO - blessings == 1.6 19:05:16 INFO - blobuploader == 1.2.4 19:05:16 INFO - docopt == 0.6.1 19:05:16 INFO - functools32 == 3.2.3-2 19:05:16 INFO - jsonschema == 2.5.1 19:05:16 INFO - manifestparser == 1.1 19:05:16 INFO - mozInstall == 1.12 19:05:16 INFO - mozcrash == 1.0 19:05:16 INFO - mozdebug == 0.1 19:05:16 INFO - mozdevice == 0.49 19:05:16 INFO - mozfile == 1.2 19:05:16 INFO - mozhttpd == 0.7 19:05:16 INFO - mozinfo == 0.9 19:05:16 INFO - mozleak == 0.1 19:05:16 INFO - mozlog == 3.4 19:05:16 INFO - moznetwork == 0.27 19:05:16 INFO - mozprocess == 0.25 19:05:16 INFO - mozprofile == 0.28 19:05:16 INFO - mozrunner == 6.13 19:05:16 INFO - mozscreenshot == 0.1 19:05:16 INFO - mozsystemmonitor == 0.3 19:05:16 INFO - moztest == 0.8 19:05:16 INFO - mozversion == 1.4 19:05:16 INFO - psutil == 3.1.1 19:05:16 INFO - requests == 1.2.3 19:05:16 INFO - wsgiref == 0.1.2 19:05:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6400>, '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 0x15d73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d7840>, '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': '17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077', '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 19:05:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:05:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:05:16 INFO - Using env: {'DISPLAY': ':0', 19:05:16 INFO - 'HOME': '/home/cltbld', 19:05:16 INFO - 'LANG': 'en_US.UTF-8', 19:05:16 INFO - 'LANGUAGE': 'en_US:en', 19:05:16 INFO - 'LOGNAME': 'cltbld', 19:05:16 INFO - 'MAIL': '/var/mail/cltbld', 19:05:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:16 INFO - 'MOZ_NO_REMOTE': '1', 19:05:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:16 INFO - 'NO_EM_RESTART': '1', 19:05:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:16 INFO - 'PWD': '/builds/slave/test', 19:05:16 INFO - 'SHELL': '/bin/bash', 19:05:16 INFO - 'SHLVL': '1', 19:05:16 INFO - 'TERM': 'linux', 19:05:16 INFO - 'TMOUT': '86400', 19:05:16 INFO - 'USER': 'cltbld', 19:05:16 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077', 19:05:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:16 INFO - '_': '/tools/buildbot/bin/python'} 19:05:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:05:16 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)) 19:05:16 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)) 19:05:16 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)) 19:05:16 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)) 19:05:16 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)) 19:05:16 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)) 19:05:16 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)) 19:05:16 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)) 19:05:16 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)) 19:05:16 INFO - Cleaning up... 19:05:16 INFO - Return code: 0 19:05:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:16 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 0x133b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6400>, '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 0x15d73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d7840>, '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': '17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077', '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 19:05:16 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 19:05:16 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 19:05:16 INFO - Using env: {'DISPLAY': ':0', 19:05:16 INFO - 'HOME': '/home/cltbld', 19:05:16 INFO - 'LANG': 'en_US.UTF-8', 19:05:16 INFO - 'LANGUAGE': 'en_US:en', 19:05:16 INFO - 'LOGNAME': 'cltbld', 19:05:16 INFO - 'MAIL': '/var/mail/cltbld', 19:05:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:16 INFO - 'MOZ_NO_REMOTE': '1', 19:05:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:16 INFO - 'NO_EM_RESTART': '1', 19:05:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:16 INFO - 'PWD': '/builds/slave/test', 19:05:16 INFO - 'SHELL': '/bin/bash', 19:05:16 INFO - 'SHLVL': '1', 19:05:16 INFO - 'TERM': 'linux', 19:05:16 INFO - 'TMOUT': '86400', 19:05:16 INFO - 'USER': 'cltbld', 19:05:16 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077', 19:05:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:16 INFO - '_': '/tools/buildbot/bin/python'} 19:05:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:05:17 INFO - Cleaning up... 19:05:17 INFO - Return code: 0 19:05:17 INFO - Running post-action listener: _resource_record_post_action 19:05:17 INFO - Running post-action listener: _start_resource_monitoring 19:05:17 INFO - Starting resource monitoring. 19:05:17 INFO - [mozharness: 2017-03-24 02:05:17.249268Z] Finished create-virtualenv step (success) 19:05:17 INFO - [mozharness: 2017-03-24 02:05:17.249744Z] Running install step. 19:05:17 INFO - Running pre-action listener: _resource_record_pre_action 19:05:17 INFO - Running main action method: install 19:05:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:05:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:05:17 INFO - Reading from file tmpfile_stdout 19:05:17 INFO - Detecting whether we're running mozinstall >=1.0... 19:05:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:05:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:05:17 INFO - Reading from file tmpfile_stdout 19:05:17 INFO - Output received: 19:05:17 INFO - Usage: mozinstall [options] installer 19:05:17 INFO - Options: 19:05:17 INFO - -h, --help show this help message and exit 19:05:17 INFO - -d DEST, --destination=DEST 19:05:17 INFO - Directory to install application into. [default: 19:05:17 INFO - "/builds/slave/test"] 19:05:17 INFO - --app=APP Application being installed. [default: firefox] 19:05:17 INFO - mkdir: /builds/slave/test/build/application 19:05:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:05:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:05:33 INFO - Reading from file tmpfile_stdout 19:05:33 INFO - Output received: 19:05:33 INFO - /builds/slave/test/build/application/firefox/firefox 19:05:33 INFO - Running post-action listener: _resource_record_post_action 19:05:33 INFO - [mozharness: 2017-03-24 02:05:33.181978Z] Finished install step (success) 19:05:33 INFO - [mozharness: 2017-03-24 02:05:33.182263Z] Running run-tests step. 19:05:33 INFO - Running pre-action listener: _resource_record_pre_action 19:05:33 INFO - Running main action method: run_tests 19:05:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:05:33 INFO - Python 2.7.3 19:05:33 INFO - Return code: 0 19:05:33 INFO - grabbing minidump binary from tooltool 19:05:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:33 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6400>, '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 0x15d73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d7840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:05:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:05:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:05:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:05:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:05:33 INFO - Return code: 0 19:05:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:05:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:05:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:05:33 INFO - ENV: RUST_BACKTRACE is now 1 19:05:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:05:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:05:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L2z-0K3WS3Wl8DUv-yQl8w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 19:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Pine --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L2z-0K3WS3Wl8DUv-yQl8w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 19:05:33 INFO - Using env: {'DISPLAY': ':0', 19:05:33 INFO - 'HOME': '/home/cltbld', 19:05:33 INFO - 'LANG': 'en_US.UTF-8', 19:05:33 INFO - 'LANGUAGE': 'en_US:en', 19:05:33 INFO - 'LOGNAME': 'cltbld', 19:05:33 INFO - 'MAIL': '/var/mail/cltbld', 19:05:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:05:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:33 INFO - 'MOZ_NO_REMOTE': '1', 19:05:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:05:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:33 INFO - 'NO_EM_RESTART': '1', 19:05:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:33 INFO - 'PWD': '/builds/slave/test', 19:05:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:05:33 INFO - 'RUST_BACKTRACE': '1', 19:05:33 INFO - 'SHELL': '/bin/bash', 19:05:33 INFO - 'SHLVL': '1', 19:05:33 INFO - 'TERM': 'linux', 19:05:33 INFO - 'TMOUT': '86400', 19:05:33 INFO - 'USER': 'cltbld', 19:05:33 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077', 19:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:33 INFO - '_': '/tools/buildbot/bin/python'} 19:05:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L2z-0K3WS3Wl8DUv-yQl8w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 19:05:33 INFO - mozversion application_buildid: 20170323163103 19:05:33 INFO - mozversion application_changeset: ca70726efd142fc7b8d7658b528b3d8da0310f0e 19:05:33 INFO - mozversion application_display_name: Nightly 19:05:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:05:33 INFO - mozversion application_name: Firefox 19:05:33 INFO - mozversion application_remotingname: firefox 19:05:33 INFO - mozversion application_repository: https://hg.mozilla.org/projects/pine 19:05:33 INFO - mozversion application_vendor: Mozilla 19:05:33 INFO - mozversion application_version: 55.0a1 19:05:33 INFO - mozversion platform_buildid: 20170323163103 19:05:33 INFO - mozversion platform_changeset: ca70726efd142fc7b8d7658b528b3d8da0310f0e 19:05:33 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/pine 19:05:33 INFO - mozversion platform_version: 55.0a1 19:05:33 INFO - using testdate: 1490321133 19:05:33 INFO - actual date: 1490321133 19:05:33 INFO - starting webserver on 'localhost:35575' 19:05:33 INFO - SUITE-START | Running 2 tests 19:05:33 INFO - TEST-START | dromaeo_css 19:05:33 INFO - operating with platform_type : linux_ 19:05:33 INFO - Initialising browser for dromaeo_css test... 19:05:33 INFO - TEST-INFO | started process 4420 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1ONwQA/profile http://localhost:35575/getInfo.html) 19:05:34 INFO - PID 4420 | 19:05:34 INFO - PID 4420 | { 19:05:34 INFO - PID 4420 | "TopSites": { 19:05:34 INFO - PID 4420 | "rows": [ 19:05:34 INFO - PID 4420 | { 19:05:34 INFO - PID 4420 | "title": "Facebook", 19:05:34 INFO - PID 4420 | "url": "https://www.facebook.com/" 19:05:34 INFO - PID 4420 | }, 19:05:34 INFO - PID 4420 | { 19:05:34 INFO - PID 4420 | "title": "YouTube", 19:05:34 INFO - PID 4420 | "url": "https://www.youtube.com/" 19:05:34 INFO - PID 4420 | }, 19:05:34 INFO - PID 4420 | { 19:05:34 INFO - PID 4420 | "title": "Amazon", 19:05:34 INFO - PID 4420 | "url": "http://www.amazon.com/" 19:05:34 INFO - PID 4420 | }, 19:05:34 INFO - PID 4420 | { 19:05:34 INFO - PID 4420 | "title": "Yahoo", 19:05:34 INFO - PID 4420 | "url": "https://www.yahoo.com/" 19:05:34 INFO - PID 4420 | }, 19:05:34 INFO - PID 4420 | { 19:05:34 INFO - PID 4420 | "title": "eBay", 19:05:34 INFO - PID 4420 | "url": "http://www.ebay.com" 19:05:34 INFO - PID 4420 | }, 19:05:34 INFO - PID 4420 | { 19:05:34 INFO - PID 4420 | "title": "Twitter", 19:05:34 INFO - PID 4420 | "url": "https://twitter.com/" 19:05:34 INFO - PID 4420 | } 19:05:34 INFO - PID 4420 | ] 19:05:34 INFO - PID 4420 | } 19:05:34 INFO - PID 4420 | } 19:05:37 INFO - PID 4420 | __metrics Screen width/height:1600/1200 19:05:37 INFO - PID 4420 | colorDepth:24 19:05:37 INFO - PID 4420 | Browser inner width/height: 1024/697 19:05:37 INFO - PID 4420 | __metrics 19:05:38 INFO - PID 4420 | 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" 19:05:38 INFO - PID 4420 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:05:39 INFO - TEST-INFO | 4420: exit 0 19:05:39 INFO - Browser initialized. 19:05:39 INFO - Running cycle 1/1 for dromaeo_css test... 19:05:39 INFO - TEST-INFO | started process 4514 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1ONwQA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:05:40 INFO - PID 4514 | 19:05:40 INFO - PID 4514 | { 19:05:40 INFO - PID 4514 | "TopSites": { 19:05:40 INFO - PID 4514 | "rows": [ 19:05:40 INFO - PID 4514 | { 19:05:40 INFO - PID 4514 | "title": "Facebook", 19:05:40 INFO - PID 4514 | "url": "https://www.facebook.com/" 19:05:40 INFO - PID 4514 | }, 19:05:40 INFO - PID 4514 | { 19:05:40 INFO - PID 4514 | "title": "YouTube", 19:05:40 INFO - PID 4514 | "url": "https://www.youtube.com/" 19:05:40 INFO - PID 4514 | }, 19:05:40 INFO - PID 4514 | { 19:05:40 INFO - PID 4514 | "title": "Amazon", 19:05:40 INFO - PID 4514 | "url": "http://www.amazon.com/" 19:05:40 INFO - PID 4514 | }, 19:05:40 INFO - PID 4514 | { 19:05:40 INFO - PID 4514 | "title": "Yahoo", 19:05:40 INFO - PID 4514 | "url": "https://www.yahoo.com/" 19:05:40 INFO - PID 4514 | }, 19:05:40 INFO - PID 4514 | { 19:05:40 INFO - PID 4514 | "title": "eBay", 19:05:40 INFO - PID 4514 | "url": "http://www.ebay.com" 19:05:40 INFO - PID 4514 | }, 19:05:40 INFO - PID 4514 | { 19:05:40 INFO - PID 4514 | "title": "Twitter", 19:05:40 INFO - PID 4514 | "url": "https://twitter.com/" 19:05:40 INFO - PID 4514 | } 19:05:40 INFO - PID 4514 | ] 19:05:40 INFO - PID 4514 | } 19:05:40 INFO - PID 4514 | } 19:05:51 INFO - PID 4514 | RSS: Main: 150028288 19:05:51 INFO - PID 4514 | 19:08:58 INFO - PID 4514 | Cycle 1(1): loaded http://localhost:35575/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35575/tests/dromaeo/cssquery-ext.html) 19:09:00 INFO - PID 4514 | RSS: Main: 278011904 19:09:00 INFO - PID 4514 | 19:10:40 INFO - PID 4514 | ************************* 19:10:40 INFO - PID 4514 | A coding exception was thrown and uncaught in a Task. 19:10:40 INFO - PID 4514 | 19:10:40 ERROR - PID 4514 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:10:40 INFO - PID 4514 | Full stack: 19:10:40 INFO - PID 4514 | ************************* 19:12:02 INFO - PID 4514 | Cycle 1(1): loaded http://localhost:35575/tests/dromaeo/cssquery-ext.html (next: http://localhost:35575/tests/dromaeo/cssquery-jquery.html) 19:12:03 INFO - PID 4514 | RSS: Main: 237391872 19:12:03 INFO - PID 4514 | 19:15:05 INFO - PID 4514 | Cycle 1(1): loaded http://localhost:35575/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35575/tests/dromaeo/cssquery-mootools.html) 19:15:06 INFO - PID 4514 | RSS: Main: 184758272 19:15:06 INFO - PID 4514 | 19:18:08 INFO - PID 4514 | Cycle 1(1): loaded http://localhost:35575/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35575/tests/dromaeo/cssquery-prototype.html) 19:18:09 INFO - PID 4514 | RSS: Main: 182390784 19:18:09 INFO - PID 4514 | 19:21:12 INFO - PID 4514 | Cycle 1(1): loaded http://localhost:35575/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35575/tests/dromaeo/cssquery-yui.html) 19:21:13 INFO - PID 4514 | RSS: Main: 186867712 19:21:13 INFO - PID 4514 | 19:24:16 INFO - PID 4514 | Cycle 1(1): loaded http://localhost:35575/tests/dromaeo/cssquery-yui.html (next: http://localhost:35575/tests/dromaeo/cssquery-dojo.html) 19:24:16 INFO - PID 4514 | RSS: Main: 279502848 19:24:16 INFO - PID 4514 | 19:24:16 INFO - PID 4514 | __start_tp_report 19:24:16 INFO - PID 4514 | _x_x_mozilla_page_load 19:24:16 INFO - PID 4514 | _x_x_mozilla_page_load_details 19:24:16 INFO - PID 4514 | |i|pagename|runs| 19:24:16 INFO - PID 4514 | |0;dojo.html;2657.3755167535633;2670.1055146525914;2703.391736859207;2708.444768822392;2711.254405038614;4970.975145124269;5052.974735126329;5113.3097031900725;5126.8974620507615;5159.303494028305;5119;5146.6140039497;5157.226416037596;5170.767315470804;5192.428832828386;4567.063751930847;4598.97700511497;4625.653076019286;4686.718796872182;4754.9286760698615;4647.8838029049375;4664.997025639487;4712.481627021025;4719.52804719527;4729.52704729526;4527.818887244506;4560.908781824378;4561.1105834362315;4570.588647021751;4585.954140458586;4612.815487380501;4617.953820461786;4620.075984803019;4623.075384922995;4627.907441851178;4564.0871825635;4567.497575266718;4574.771261436948;4578.45058592971;4579.7252164870215;5032.748362581893;5035.84892453227;5037.546620804109;5048.419431765321;5095.5159259870625;5499.257600223998;5510.889782204334;5517.917231241495;5572.665640061609;5587.608867379285;5544.112941929272;5579.609427340088;5584.385717571064;5589.273394458735;5636.661800291996;5118.488151184852;5160.354955630546;5169.276301317818;5170.715610641376;5218.6868787872845;5515.669059856422;5578.358488773762;5592.7762889483965;5595.636283641632;5679.034564124109;5312.787488500417;5319.627626066215;5326.280952071421;5329.280547126166;5332.9733351333;5425.647332923348;5426.348838139448;5430.70131142791;5432.375276843135;5444.428335024844;5382.381026181961;5394.973025134849;5468.371137319259;5472.972635136799;5476.616636835383;5440.102383106822;5453.972730136324;5460.099083651233;5462.098753705594;5466.180072989004;4518.706284091523;4561.2245918193985;4561.771911404417;4565.954340456553;4570.908581828345;3933.1347103637154;3943.191645712622;3978.9403158952637;3982.542007669097;3996.420519024783;4606.332081848113;4711.175544279738;4715.976420117946;4734.07685501324;4761.857144285677;5388.622796404214;5457.290552228185;5538.667679939216;5540.113581826889;5550.500454959073;4678.578927896506;4744.074905393484;4777.761111944389;4786.1863483207935;4798.760061996886;4885.316055752198;4905.092557876804;4910.8281210157475;4910.901781964412;4951.133551628451;5124.30821839047;5124.538791508782;5155.072087024221;5168.3539557555305;5205.609579281493;5393.7033463159905;5464.617476776588;5466.480684334982;5532.723363831873;5565.053940830149;5131.25596788471;5141.485851414828;5150.175971844487;5164.9741751291;5204.063268611686;5432.456754324536;5436.6194366393975;5437.483439073281;5439.428859969805;5492.423295553909;5334.306540149756;5378.435264297349;5524.723763811874;5542.0301447245765;5551.139573366135;5242.082635538689;5367.892642147213;5376.1398176291605;5425.538829199562;5426.647267927572;5242.239875217996;5275.709835959059;5301.6818990860675;5354.892902142014;5363.758630861698;5263.894722105613;5330.760115794721;5333.679979201261;5336.2529245904825;5364.839054828361;5218.295530103387;5302.920456193237;5411.161270003156;5413.269208656781;5465.699386533779;5182.844514664566;5247.5539579134675;5266.394364648115;5308.867278317918;5321.920171197357 19:24:16 INFO - PID 4514 | |1;ext.html;576.7894718427773;628.9842753931151;643.7714611312982;959.616153538585;973.3673112476894;23426.765732342672;23923.999999999978;23932.521349573;32599;33235.34411214764;37097.62902370982;37151.628483715154;37181;37194.14029298531;37682.623173768254;7361.190269070398;7524.097108347006;7532.9246707532775;7533.246675332478;7541.660625271848;5558.666480011212;5686.971565142189;7075.646217689095;7208.9639551802165;7474.439417043744;7398.223186565414;7478.177400485943;7480.4389670774635;7484.663190156456;7485.775426737179;7380.1512826025155;7446.739364122284;7451.366633836131;7451.552906825581;7452.5901075440825;5443.265159203536;5550.084236101038;7078.433725301964;7244.673989670478;7340.743073992438;34982;35602;35678;35686.6470029495;35736.10659733501;2595.9870200648875;2603.557395242813;2614.2810727050023;2630.973690263111;2637.222019504251;22699.432514187276;23127.884360578257;24351.391215219584;24392;24886.25341239766;2809.8454584997817;2852.1728698677357;2856.7857410694073;2858.6712528059334;2903.5209190483547;144207;145511;146062.99999999892;146134;146770;41204;41294.793526032176;41307;41341.58658413438;41401.1719765603;44031;44088;44131.11737765227;44182.11635767267;44192.55807441949;12827.102102852898;13185.60443186706;13204;13204.141730787467;13218.73562528744;10542.525586348633;10562.260641755158;10562.366258024544;10574.206934479946;10576.312539684895;9674.129328360481;9840.95079524612;12300.81548776769;12421.378931053592;12623.368831558386;5166.225066240019;5341.919871201935;5348.5186333230195;5368.597355198376;5395.109806881899;860.6815478272954;885.2121611765534;885.8228354329032;886.1050339157497;913.3241401362943;20378.388648340573;21337;21443.249486267905;21499.892500537397;21635;912.6668765900398;950.3442624589012;968.6367612145445;976.8876579193484;995.348047029197;11186.496607652674;11203.327800332007;11381.829272560919;11448.427578621036;11453.370064646359;241155;242060;242971;243066;243581;43145.784271078446;43535.12929741388;43577;43657.56342436599;43684.12631747347;1197.0961923747516;1216.5012344938532;1230.8522977242787;1235.32057368447;1260.6596219020996;19031.809681903003;19394.224231031167;19422.320218792276;20733.481662957944;20778.792212077686;31604.841975789976;31778.364432711678;31814.681853182097;31871;31886.52170217495;237811;238221;238311;238416;239252;24322.391940201636;28873.711262887104;29165.562516561844;29323.41353172882;29969.55045674273;28488.718007690117;28492.715072849005;33698.32603347969;34135.31729365449;34416;25863.870680646476;26252;26331.736682633695;26828.195154145407;27935.161945141677;26467;27630.585541216496;27809.304767380978;27852.86073569619;28707;29957.70042299549;30503.389932201677;30826.69173308238;30907.845460773453;30925.845370773;26323.21030369092;26491.205263841344;26708.465830683665;26861;27174.72825271722;20949.581008380053;21357.46606334854;22225.66661500111;22835.657465138367;22948.770512294665 19:24:16 INFO - PID 4514 | |2;jquery.html;407.8592885454517;414.78845788647783;419.73346924702804;423.4748911349926;439.1721604774998;15987.760183597255;17299.221535030923;17988.460346189604;18964.051797410142;18966.525836854067;17446.912765436155;17863.374781882638;17943.10284485777;18621.16204770785;18878.15048322825;6301.338359472258;6341.143945567359;6399.5840270382505;6509.4466970307585;6511.869762604745;6293.874122517547;6401.199850018747;6503.089567460559;6503.544751867371;6507.479401647881;6382.617042977413;6407.743690252384;6462.192225971754;6468.547201695883;6473.996530537775;6279.0895320178315;6330.240371155468;6399.232092148972;6438.098666186737;6444.130042444281;6302.87394252117;6304.653244071575;6306.180196574416;6308.936910630927;6312;23933.64099538508;24162.87918560396;24512.142075027466;24901.62647560288;25065.87467062653;1612.4114698135213;1638.9836101639069;1648.967020659592;1694;1697.957551061221;14723;15471.845281547154;15638.765418518731;16220;16278;1738.9217485213196;1799.4871461633502;1801.369520667769;1804.6390721855682;1828.4697437743039;89153;90107.54946225227;90298;91915.54042229813;93005.5349723247;17355.30578776835;17593.472195834147;17872.731909021375;17943.551411214565;18407.26370945174;32927.67072329294;33232.66767332344;33460.330793384484;33472.49791253133;33480.49779253313;9002.819943601091;9271.304652151115;9343.159115679486;9394;9604.75988100289;7470.738524151629;7564.583947882919;7672.73145439907;7765.107012693613;7777.533347999138;9281.628734850665;9423.811523769624;9557.952210238904;9686.709398717909;9786.510674466248;3914.4911161548816;3918.1575961168487;3925.7644541327613;3926.1951299983434;4012.6589239914933;827.2224109337204;852.7228650688551;857.3355649371787;859.6776208921655;860.2129051917425;16349.509514714578;16453.012819230884;16482.42311519091;17220.397286094925;17436.215370308368;874.3835595904999;877.6840337478502;878.9121087891288;879.859222524393;894.3918135667678;9058.411203271766;9085.77285567853;9620.37467564606;9787.853182202272;9796.65711700087;315228;319199;320550;323601;445773;82336.58831705803;84557;85522.5723871389;85693;88735.55632221927;1090.6019302954364;1144.8282757586262;1154.3997121496775;1155.624422062833;1157.9189456738115;17474.12629368552;17491.950482971064;18103.547411314823;18266.36067737623;18381.26474941041;34748.82625586957;40441;40665.52679205226;41371.1725765489;42030.579694202665;51877.48122518878;53823.192652111036;54010.45989540054;54184.729076354364;54261.72869135629;8127.634256458592;8201;8414.873776893473;8438.324934005142;8446.197611226924;11802.409879506162;11907.82138267944;12912.612621621367;13036.41336139857;13059.869401306245;10117;10310.948445257725;10665.46672666348;10760.83858742135;11069.557217711523;9927.950360248153;10310.639127630497;10401.115905148146;10406.58373665045;10472.371657700562;9894.802103958025;10095.639229509421;10181.287309888237;10665;10906.836397453886;8237.46456480327;8251.546164960984;8321.625526851427;8413.831723365622;8455.450395724258;5909.409059094056;7924.801879953047;10238.53926573291;10403.271770975958;10478.895211047791 19:24:16 INFO - PID 4514 | |3;mootools.html;1103.9227254092216;1229.526632246585;1283.2813624370353;1297.5588299978008;1307.0719788949846;8201.835963280739;9561.617535298588;9776.16902563283;9782.461964591945;9789.804203915926;9491.857622135674;9589;9590.664326748565;9594.040595940403;9600.087991640801;1825.2334019711752;1894.933677321294;2162.87022778633;2203.6584329428965;2204.526026904215;2172.728408948881;2219.8002179803816;2239.8432109752325;2243.652233903739;2257.525919556895;2140.678898165272;2141.1114387529233;2147.2162660628837;2154.2890846020855;2158.3956492182215;2144.785521447858;2146.967795483069;2149.1833103420677;2156.4069880782754;2157.65477523597;2068.327793467114;2082;2085.708000879878;2091;2091.1321801452377;9863.90136098637;9911.207103431709;9944.35361701487;9990.250731195189;10043.447610381427;5137.255098010804;5301.7084060376665;5316.893662126736;5322.04203243416;5333.626646134772;2987.357718090599;3111.1910903165112;3173.349463360029;3192.5211218317204;3198.9360212795614;1015.1878497202209;1079.7894410589938;1098.6045023791428;1098.8626421697288;1151.372501986411;14705.70588588233;14744.336504857307;14768.556943291718;14851.777223341658;14867.107973521623;4725.10223057618;4933.605311575066;5052.949470505321;5078.568321692624;5111.003354345867;12188.573399931138;12191.32947687868;12198.817017744741;12201.145919785708;12202.267863928193;5485.945140548623;5488.121900495981;5490.423505531941;5494.945050549523;5495.148252020943;4660.091282199938;4714.175019371665;4744.430668319824;4871.103117505981;4960.553550180501;3914.236723838824;3954.7627142370975;4008.6993475489453;4051.108756073659;4082.8366865325056;1216.5559570756786;1222.541546919905;1229.1518851992275;1237.8638349781518;1241.1064033895582;665.4809248785955;691.1188235000415;692.9986169984425;696.1611258433576;705.3546005404997;5246.23929530216;5359.839204823861;5684.744186511617;6342.619442833445;6436.227652681615;819.4141189049858;825.2201669422338;833.4915701422127;834.9916500835035;859.6518410043942;3479.1302174456387;3540.858365665396;3542.6103128655827;3548.733844961638;3700.7224458165206;12413.44139513724;12788.424520896582;12881.806772898413;13060.869391305965;13127.081104322606;12670.429830657642;12832.294223817593;12852.935735321264;12886.29125398112;12926.41831117602;9348.766280842898;9560.952195238979;9574.712758617252;9575.138237558653;9617.615295388106;5364.839054828361;5375.543078838343;5417.566594672496;5441.809536666197;5574.9721251393485;11621.88378116208;11653.59212427561;11684.70788230301;11693.649190524298;11715.531378745096;11170.27393219438;12011;12164.756704865677;12247;12312.26126432417;7728.652210650422;7934.246246606564;7938.64276107565;7938.722144724907;7942.64258108375;8713.564321784012;8982.236509896471;9041.276697864287;9080.455172689659;9082.682106126254;7821.92178078212;7982.760517184493;7984.401169912396;8003.839923201387;8224.300934420402;7590.658420371207;7669.501482403626;7730.806729831799;7799.220077992155;7939.126696063544;6780.694868731018;6864.759733409307;6878.209005964378;6886.827829304308;6888.827779305558;4993.151164302005;5035.697858128524;5088.643794934319;5108.438071812172;5314.574834013347;4861.295112208639;5090.287359769709;5176.585873130065;5177.119889618699;5280.920786188287 19:24:16 INFO - PID 4514 | |4;prototype.html;345.96367381424966;382.63076131533046;387.15406836063204;387.9786611736355;388.7356597513689;5038.57172140368;5201.973990130049;5365.731713414333;5370.838874833751;5405.540529055035;5133.255677926699;5216.347956505437;5268.6575372600755;5285.814996475124;5296.496832800887;3998.3802510610903;4113.588641135878;4224.61978421942;4231.957680423187;4239.27932251518;4120.505539335269;4130.586941305861;4133.545310015896;4156.355764856452;4161.979190104061;4089.263932492165;4093.263212621727;4100.692448066392;4106.404571337154;4119.299719047769;4127.236461254663;4135.875923722293;4141.772202528859;4144.3990621360035;4155.750654960697;3448.81031543265;3572.8749493767596;3580.695640870529;3583.4266517357096;3597.956592588146;5200.6619569727845;5202.791888324463;5205.843824685266;5206.349206349207;5207.297014902978;4708.246680531133;4724.5984091352275;4728.71627702339;4729.952700472985;4743.264793956942;5311.601629877775;5493;5589.74846131925;5613.214150019001;5620.269364982526;3987.7806720630356;3991.1020020495157;3995.440638310639;3999.7600143991453;4007.6192761687594;5668.376478587352;5719.513841323451;5874.206982057453;5914.9187060927825;5986.221791167164;4057.107436363995;4061.8066244228376;4063.4311196432523;4074.7351422157467;4086.4891888513935;4106.91786164281;4125.278076336629;4127.545969943304;4130.421740956269;4142.668586513072;4391.758453285036;4424.75663838492;4444.888877778081;4696.201645720235;4723.645726570521;5571.88562287536;5581.413951535031;5592.692401917852;5604.6917419541505;5612.803551875665;1408.7675533537056;1430.6065831896103;1431.2843578210895;1432.1120905038943;1438.6834896322791;938.648006997376;970.1995853420956;973.8149751547184;981.9312648114707;984.0995489127369;4904.117258893433;4908.779104940286;4909.140900342426;4909.3126962225315;4921.704697718148;5735.684537350402;5809.186713859978;5813.970930145322;5818.709064546756;5820.708964551755;4804.739890640605;4806.687565308243;4869;4915.606751459946;4925.532074452921;3042.9847850760602;3068.5704001439817;3081.1680846171857;3089.1968088297203;3090.1502086925825;5349.679019258857;5358.651687640291;5373.194020896819;5375.118708452089;5400.756965936543;5705.4009329019855;5917.171595976567;5997.220361352996;6008.549358798107;6043.4645732246245;5452.318460192476;5457.372402173801;5466.480684334982;5467.726613669301;5467.917981230365;5717.656940583578;5893.381194974466;5899.174115623902;5899.587028907935;5903.380145084876;5717.514011308919;5727.140928860537;5742.368339482737;5752.395998420273;5758.1362795579325;5177.974110129425;5231.764570594256;5324.733763311741;5419.620626556103;5442.319710036246;4048.2510735514024;4063.715539912178;4069.4099355593867;4097.8975525612095;4101.692373072091;5803.390643982321;5808.564357673107;5833.620814647034;5835.328937172279;5875.911861322169;5425.403205647297;5646.153077038477;5669.376368599534;5673.404292549223;5690.743916523849;5663.433656634304;5665.518430933417;5666;5686.152000599905;5687.658740475585;5325;5615.3823079462045;5618;5627.155926611041;5630.60585758993;5691.8861622768145;5710.942890571041;5711.343195532567;5725.112607545837;5734.770609175586;5564.638298510584;5566.916496252478;5576.944230557642;5578.86052848682;5602.299712535933 19:24:16 INFO - PID 4514 | |5;yui.html;685.2154283345573;688.6935313785366;693.4833549005991;693.524935419238;699.3880354689646;11238.831417528743;11472.311661300308;11491;11502.079833613312;11503.712407189825;11512.654620361382;11583.768324633502;11597.6520704379;11700.531978720841;12119.697007574792;786.076360276674;805.3637626275265;805.842860642175;810.1088802317433;810.254565799463;837.3510529339779;838.4885220015785;844.0082902589463;844.6916875340487;845.3026253340987;884.6328773558965;886.4105369929022;887.529609307065;887.5429153985671;888.2938064238946;872.9825403491894;882.686646240585;883.147762409275;883.571467838098;884.456059523395;643.2313385504324;643.4466358931315;646.5312648329971;646.7897933171691;650.1612919334053;13075.476980920752;13315.067945243836;13378.531751388655;13388.464461421532;13693.109947853358;13099.148555343872;13823.377947992263;13837.377318020714;13999.300034998209;14239.932005099556;9806.411615303034;10175.13511351536;10253.641122560675;10320.638777642747;10698.197635177316;2630.8026897982727;2657.7740892024203;2685.0468083830156;2686.6910305314946;2709.3632996245865;65226.67386663084;66583.66708166429;67378.3262167377;68091.65954170197;70096.6495167526;10341.861216777364;10412.167026638002;10498.475076246157;10530.526126324334;10610;20948.47628809292;21331.14675412997;21369.358919232447;21386.78613213879;21394.786052139592;6060.272767267956;6064.575479716465;6125.9693701531205;6206.782762603287;6255.937440625536;3322.427882101642;3332.133645252252;3374.325134972966;3374.5613070301197;3407.0800883761244;3411.710004649583;3428.485727140899;3442.122258823984;3453.7582369233915;3477.5479187705437;613.7115555688819;623.2801114712514;624.2197253433209;638.5211091681239;642.1010585180784;497.692831137092;498.36209651645953;501.0080041517815;512.451676705921;524.7743470307728;7904;8045.275925166763;8064.193580641889;8093.554854482943;8227.13615070409;501.70900877490965;518.2795913679988;521.2858384013849;521.9138842091088;523.8847453560211;3439.9828000859834;3613.56637203532;3642.7814331140216;3781.905452363713;3808.257389808961;61449.38550614526;61554.38445615487;62414.375856240855;63788.36211637917;63944.36055639384;54267.72866135644;54285.1857222142;54748.45251547434;55421;58900.41099589035;48701.512984869696;49381.506184937694;49485.50514494809;49810.75094624504;50248.49751502511;8250.834983300421;8848.823023539622;8911.331650126136;8929.508877011827;9053.68312109073;24141.15505957283;24179.879100604383;24568.385790355384;24629.753702462745;25100;41373.79313103415;41717.95705107275;42269;42289;45172;11457.427128643702;11580.768384632429;11614.825777613174;11783.410829458322;11935.701607459883;12553.246805191719;12868.549600763929;12873;12972.935135324264;13521.526746563823;11872.584459543874;11906.464209110438;11993.34036627959;12005;12051.638450846138;11060.723481913017;11134.3876086816;11253.943730281297;11282.43587820622;11744.060475161796;11017.338959662446;11281.943590281997;11422.714432139262;11441.542338306708;11837.46731397072;8360.581970901552;8385.790355240924;8541.188587084218;8581.35639827028;8839.911600883908;9527.38072025316;9895.505224738878;9918.702438926844;9923.900760992587;10013.39919604826 19:24:16 INFO - PID 4514 | __end_tp_report 19:24:16 INFO - PID 4514 | __start_cc_report 19:24:16 INFO - PID 4514 | _x_x_mozilla_cycle_collect,1448 19:24:16 INFO - PID 4514 | __end_cc_report 19:24:16 INFO - PID 4514 | __startTimestamp1490322256579__endTimestamp 19:24:16 INFO - PID 4514 | 19:24:16 INFO - PID 4514 | ------- Summary: start ------- 19:24:16 INFO - PID 4514 | Number of tests: 6 19:24:16 INFO - PID 4514 | 19:24:16 INFO - PID 4514 | [#0] dojo.html Cycles:165 Average:5040.86 Median:5192.43 stddev:571.73 (11.0%) stddev-sans-first:542.04 19:24:16 INFO - PID 4514 | Values: 2657.4 2670.1 2703.4 2708.4 2711.3 4971.0 5053.0 5113.3 5126.9 5159.3 5119.0 5146.6 5157.2 5170.8 5192.4 4567.1 4599.0 4625.7 4686.7 4754.9 4647.9 4665.0 4712.5 4719.5 4729.5 4527.8 4560.9 4561.1 4570.6 4586.0 4612.8 4618.0 4620.1 4623.1 4627.9 4564.1 4567.5 4574.8 4578.5 4579.7 5032.7 5035.8 5037.5 5048.4 5095.5 5499.3 5510.9 5517.9 5572.7 5587.6 5544.1 5579.6 5584.4 5589.3 5636.7 5118.5 5160.4 5169.3 5170.7 5218.7 5515.7 5578.4 5592.8 5595.6 5679.0 5312.8 5319.6 5326.3 5329.3 5333.0 5425.6 5426.3 5430.7 5432.4 5444.4 5382.4 5395.0 5468.4 5473.0 5476.6 5440.1 5454.0 5460.1 5462.1 5466.2 4518.7 4561.2 4561.8 4566.0 4570.9 3933.1 3943.2 3978.9 3982.5 3996.4 4606.3 4711.2 4716.0 4734.1 4761.9 5388.6 5457.3 5538.7 5540.1 5550.5 4678.6 4744.1 4777.8 4786.2 4798.8 4885.3 4905.1 4910.8 4910.9 4951.1 5124.3 5124.5 5155.1 5168.4 5205.6 5393.7 5464.6 5466.5 5532.7 5565.1 5131.3 5141.5 5150.2 5165.0 5204.1 5432.5 5436.6 5437.5 5439.4 5492.4 5334.3 5378.4 5524.7 5542.0 5551.1 5242.1 5367.9 5376.1 5425.5 5426.6 5242.2 5275.7 5301.7 5354.9 5363.8 5263.9 5330.8 5333.7 5336.3 5364.8 5218.3 5302.9 5411.2 5413.3 5465.7 5182.8 5247.6 5266.4 5308.9 5321.9 19:24:16 INFO - PID 4514 | 19:24:16 INFO - PID 4514 | [#1] ext.html Cycles:180 Average:34532.42 Median:29244.49 stddev:55852.30 (191.0%) stddev-sans-first:55950.79 19:24:16 INFO - PID 4514 | Values: 576.8 629.0 643.8 959.6 973.4 23426.8 23924.0 23932.5 32599.0 33235.3 37097.6 37151.6 37181.0 37194.1 37682.6 7361.2 7524.1 7532.9 7533.2 7541.7 5558.7 5687.0 7075.6 7209.0 7474.4 7398.2 7478.2 7480.4 7484.7 7485.8 7380.2 7446.7 7451.4 7451.6 7452.6 5443.3 5550.1 7078.4 7244.7 7340.7 34982.0 35602.0 35678.0 35686.6 35736.1 2596.0 2603.6 2614.3 2631.0 2637.2 22699.4 23127.9 24351.4 24392.0 24886.3 2809.8 2852.2 2856.8 2858.7 2903.5 144207.0 145511.0 146063.0 146134.0 146770.0 41204.0 41294.8 41307.0 41341.6 41401.2 44031.0 44088.0 44131.1 44182.1 44192.6 12827.1 13185.6 13204.0 13204.1 13218.7 10542.5 10562.3 10562.4 10574.2 10576.3 9674.1 9841.0 12300.8 12421.4 12623.4 5166.2 5341.9 5348.5 5368.6 5395.1 860.7 885.2 885.8 886.1 913.3 20378.4 21337.0 21443.2 21499.9 21635.0 912.7 950.3 968.6 976.9 995.3 11186.5 11203.3 11381.8 11448.4 11453.4 241155.0 242060.0 242971.0 243066.0 243581.0 43145.8 43535.1 43577.0 43657.6 43684.1 1197.1 1216.5 1230.9 1235.3 1260.7 19031.8 19394.2 19422.3 20733.5 20778.8 31604.8 31778.4 31814.7 31871.0 31886.5 237811.0 238221.0 238311.0 238416.0 239252.0 24322.4 28873.7 29165.6 29323.4 29969.6 28488.7 28492.7 33698.3 34135.3 34416.0 25863.9 26252.0 26331.7 26828.2 27935.2 26467.0 27630.6 27809.3 27852.9 28707.0 29957.7 30503.4 30826.7 30907.8 30925.8 26323.2 26491.2 26708.5 26861.0 27174.7 20949.6 21357.5 22225.7 22835.7 22948.8 19:24:16 INFO - PID 4514 | 19:24:16 INFO - PID 4514 | [#2] jquery.html Cycles:180 Average:25687.82 Median:417.26 stddev:58508.30 (14022.0%) stddev-sans-first:58641.64 19:24:16 INFO - PID 4514 | Values: 407.9 414.8 419.7 423.5 439.2 15987.8 17299.2 17988.5 18964.1 18966.5 17446.9 17863.4 17943.1 18621.2 18878.2 6301.3 6341.1 6399.6 6509.4 6511.9 6293.9 6401.2 6503.1 6503.5 6507.5 6382.6 6407.7 6462.2 6468.5 6474.0 6279.1 6330.2 6399.2 6438.1 6444.1 6302.9 6304.7 6306.2 6308.9 6312.0 23933.6 24162.9 24512.1 24901.6 25065.9 1612.4 1639.0 1649.0 1694.0 1698.0 14723.0 15471.8 15638.8 16220.0 16278.0 1738.9 1799.5 1801.4 1804.6 1828.5 89153.0 90107.5 90298.0 91915.5 93005.5 17355.3 17593.5 17872.7 17943.6 18407.3 32927.7 33232.7 33460.3 33472.5 33480.5 9002.8 9271.3 9343.2 9394.0 9604.8 7470.7 7564.6 7672.7 7765.1 7777.5 9281.6 9423.8 9558.0 9686.7 9786.5 3914.5 3918.2 3925.8 3926.2 4012.7 827.2 852.7 857.3 859.7 860.2 16349.5 16453.0 16482.4 17220.4 17436.2 874.4 877.7 878.9 879.9 894.4 9058.4 9085.8 9620.4 9787.9 9796.7 315228.0 319199.0 320550.0 323601.0 445773.0 82336.6 84557.0 85522.6 85693.0 88735.6 1090.6 1144.8 1154.4 1155.6 1157.9 17474.1 17492.0 18103.5 18266.4 18381.3 34748.8 40441.0 40665.5 41371.2 42030.6 51877.5 53823.2 54010.5 54184.7 54261.7 8127.6 8201.0 8414.9 8438.3 8446.2 11802.4 11907.8 12912.6 13036.4 13059.9 10117.0 10310.9 10665.5 10760.8 11069.6 9928.0 10310.6 10401.1 10406.6 10472.4 9894.8 10095.6 10181.3 10665.0 10906.8 8237.5 8251.5 8321.6 8413.8 8455.5 5909.4 7924.8 10238.5 10403.3 10478.9 19:24:16 INFO - PID 4514 | 19:24:16 INFO - PID 4514 | [#3] mootools.html Cycles:180 Average:6187.91 Median:4866.20 stddev:3998.69 (82.2%) stddev-sans-first:3991.66 19:24:16 INFO - PID 4514 | Values: 1103.9 1229.5 1283.3 1297.6 1307.1 8201.8 9561.6 9776.2 9782.5 9789.8 9491.9 9589.0 9590.7 9594.0 9600.1 1825.2 1894.9 2162.9 2203.7 2204.5 2172.7 2219.8 2239.8 2243.7 2257.5 2140.7 2141.1 2147.2 2154.3 2158.4 2144.8 2147.0 2149.2 2156.4 2157.7 2068.3 2082.0 2085.7 2091.0 2091.1 9863.9 9911.2 9944.4 9990.3 10043.4 5137.3 5301.7 5316.9 5322.0 5333.6 2987.4 3111.2 3173.3 3192.5 3198.9 1015.2 1079.8 1098.6 1098.9 1151.4 14705.7 14744.3 14768.6 14851.8 14867.1 4725.1 4933.6 5052.9 5078.6 5111.0 12188.6 12191.3 12198.8 12201.1 12202.3 5485.9 5488.1 5490.4 5494.9 5495.1 4660.1 4714.2 4744.4 4871.1 4960.6 3914.2 3954.8 4008.7 4051.1 4082.8 1216.6 1222.5 1229.2 1237.9 1241.1 665.5 691.1 693.0 696.2 705.4 5246.2 5359.8 5684.7 6342.6 6436.2 819.4 825.2 833.5 835.0 859.7 3479.1 3540.9 3542.6 3548.7 3700.7 12413.4 12788.4 12881.8 13060.9 13127.1 12670.4 12832.3 12852.9 12886.3 12926.4 9348.8 9561.0 9574.7 9575.1 9617.6 5364.8 5375.5 5417.6 5441.8 5575.0 11621.9 11653.6 11684.7 11693.6 11715.5 11170.3 12011.0 12164.8 12247.0 12312.3 7728.7 7934.2 7938.6 7938.7 7942.6 8713.6 8982.2 9041.3 9080.5 9082.7 7821.9 7982.8 7984.4 8003.8 8224.3 7590.7 7669.5 7730.8 7799.2 7939.1 6780.7 6864.8 6878.2 6886.8 6888.8 4993.2 5035.7 5088.6 5108.4 5314.6 4861.3 5090.3 5176.6 5177.1 5280.9 19:24:16 INFO - PID 4514 | 19:24:16 INFO - PID 4514 | [#4] prototype.html Cycles:180 Average:4650.06 Median:5250.21 stddev:1359.08 (25.9%) stddev-sans-first:1323.94 19:24:16 INFO - PID 4514 | Values: 346.0 382.6 387.2 388.0 388.7 5038.6 5202.0 5365.7 5370.8 5405.5 5133.3 5216.3 5268.7 5285.8 5296.5 3998.4 4113.6 4224.6 4232.0 4239.3 4120.5 4130.6 4133.5 4156.4 4162.0 4089.3 4093.3 4100.7 4106.4 4119.3 4127.2 4135.9 4141.8 4144.4 4155.8 3448.8 3572.9 3580.7 3583.4 3598.0 5200.7 5202.8 5205.8 5206.3 5207.3 4708.2 4724.6 4728.7 4730.0 4743.3 5311.6 5493.0 5589.7 5613.2 5620.3 3987.8 3991.1 3995.4 3999.8 4007.6 5668.4 5719.5 5874.2 5914.9 5986.2 4057.1 4061.8 4063.4 4074.7 4086.5 4106.9 4125.3 4127.5 4130.4 4142.7 4391.8 4424.8 4444.9 4696.2 4723.6 5571.9 5581.4 5592.7 5604.7 5612.8 1408.8 1430.6 1431.3 1432.1 1438.7 938.6 970.2 973.8 981.9 984.1 4904.1 4908.8 4909.1 4909.3 4921.7 5735.7 5809.2 5814.0 5818.7 5820.7 4804.7 4806.7 4869.0 4915.6 4925.5 3043.0 3068.6 3081.2 3089.2 3090.2 5349.7 5358.7 5373.2 5375.1 5400.8 5705.4 5917.2 5997.2 6008.5 6043.5 5452.3 5457.4 5466.5 5467.7 5467.9 5717.7 5893.4 5899.2 5899.6 5903.4 5717.5 5727.1 5742.4 5752.4 5758.1 5178.0 5231.8 5324.7 5419.6 5442.3 4048.3 4063.7 4069.4 4097.9 4101.7 5803.4 5808.6 5833.6 5835.3 5875.9 5425.4 5646.2 5669.4 5673.4 5690.7 5663.4 5665.5 5666.0 5686.2 5687.7 5325.0 5615.4 5618.0 5627.2 5630.6 5691.9 5710.9 5711.3 5725.1 5734.8 5564.6 5566.9 5576.9 5578.9 5602.3 19:24:16 INFO - PID 4514 | 19:24:16 INFO - PID 4514 | [#5] yui.html Cycles:180 Average:14300.38 Median:49041.51 stddev:17907.91 (36.5%) stddev-sans-first:17928.96 19:24:16 INFO - PID 4514 | Values: 685.2 688.7 693.5 693.5 699.4 11238.8 11472.3 11491.0 11502.1 11503.7 11512.7 11583.8 11597.7 11700.5 12119.7 786.1 805.4 805.8 810.1 810.3 837.4 838.5 844.0 844.7 845.3 884.6 886.4 887.5 887.5 888.3 873.0 882.7 883.1 883.6 884.5 643.2 643.4 646.5 646.8 650.2 13075.5 13315.1 13378.5 13388.5 13693.1 13099.1 13823.4 13837.4 13999.3 14239.9 9806.4 10175.1 10253.6 10320.6 10698.2 2630.8 2657.8 2685.0 2686.7 2709.4 65226.7 66583.7 67378.3 68091.7 70096.6 10341.9 10412.2 10498.5 10530.5 10610.0 20948.5 21331.1 21369.4 21386.8 21394.8 6060.3 6064.6 6126.0 6206.8 6255.9 3322.4 3332.1 3374.3 3374.6 3407.1 3411.7 3428.5 3442.1 3453.8 3477.5 613.7 623.3 624.2 638.5 642.1 497.7 498.4 501.0 512.5 524.8 7904.0 8045.3 8064.2 8093.6 8227.1 501.7 518.3 521.3 521.9 523.9 3440.0 3613.6 3642.8 3781.9 3808.3 61449.4 61554.4 62414.4 63788.4 63944.4 54267.7 54285.2 54748.5 55421.0 58900.4 48701.5 49381.5 49485.5 49810.8 50248.5 8250.8 8848.8 8911.3 8929.5 9053.7 24141.2 24179.9 24568.4 24629.8 25100.0 41373.8 41718.0 42269.0 42289.0 45172.0 11457.4 11580.8 11614.8 11783.4 11935.7 12553.2 12868.5 12873.0 12972.9 13521.5 11872.6 11906.5 11993.3 12005.0 12051.6 11060.7 11134.4 11253.9 11282.4 11744.1 11017.3 11281.9 11422.7 11441.5 11837.5 8360.6 8385.8 8541.2 8581.4 8839.9 9527.4 9895.5 9918.7 9923.9 10013.4 19:24:16 INFO - PID 4514 | -------- Summary: end -------- 19:24:16 INFO - PID 4514 | 19:24:17 INFO - TEST-INFO | 4514: exit 0 19:24:17 INFO - TEST-OK | dromaeo_css | took 1123996ms 19:24:17 INFO - TEST-START | kraken 19:24:17 INFO - operating with platform_type : linux_ 19:24:17 INFO - Initialising browser for kraken test... 19:24:17 INFO - TEST-INFO | started process 4838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIeX2VZ/profile http://localhost:35575/getInfo.html) 19:24:18 INFO - PID 4838 | 19:24:18 INFO - PID 4838 | { 19:24:18 INFO - PID 4838 | "TopSites": { 19:24:18 INFO - PID 4838 | "rows": [ 19:24:18 INFO - PID 4838 | { 19:24:18 INFO - PID 4838 | "title": "Facebook", 19:24:18 INFO - PID 4838 | "url": "https://www.facebook.com/" 19:24:18 INFO - PID 4838 | }, 19:24:18 INFO - PID 4838 | { 19:24:18 INFO - PID 4838 | "title": "YouTube", 19:24:18 INFO - PID 4838 | "url": "https://www.youtube.com/" 19:24:18 INFO - PID 4838 | }, 19:24:18 INFO - PID 4838 | { 19:24:18 INFO - PID 4838 | "title": "Amazon", 19:24:18 INFO - PID 4838 | "url": "http://www.amazon.com/" 19:24:18 INFO - PID 4838 | }, 19:24:18 INFO - PID 4838 | { 19:24:18 INFO - PID 4838 | "title": "Yahoo", 19:24:18 INFO - PID 4838 | "url": "https://www.yahoo.com/" 19:24:18 INFO - PID 4838 | }, 19:24:18 INFO - PID 4838 | { 19:24:18 INFO - PID 4838 | "title": "eBay", 19:24:18 INFO - PID 4838 | "url": "http://www.ebay.com" 19:24:18 INFO - PID 4838 | }, 19:24:18 INFO - PID 4838 | { 19:24:18 INFO - PID 4838 | "title": "Twitter", 19:24:18 INFO - PID 4838 | "url": "https://twitter.com/" 19:24:18 INFO - PID 4838 | } 19:24:18 INFO - PID 4838 | ] 19:24:18 INFO - PID 4838 | } 19:24:18 INFO - PID 4838 | } 19:24:21 INFO - PID 4838 | __metrics Screen width/height:1600/1200 19:24:21 INFO - PID 4838 | colorDepth:24 19:24:21 INFO - PID 4838 | Browser inner width/height: 1024/697 19:24:21 INFO - PID 4838 | __metrics 19:24:22 INFO - PID 4838 | 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" 19:24:22 INFO - PID 4838 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:24:23 INFO - TEST-INFO | 4838: exit 0 19:24:23 INFO - Browser initialized. 19:24:23 INFO - Running cycle 1/1 for kraken test... 19:24:23 INFO - TEST-INFO | started process 4933 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIeX2VZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:24:24 INFO - PID 4933 | 19:24:24 INFO - PID 4933 | { 19:24:24 INFO - PID 4933 | "TopSites": { 19:24:24 INFO - PID 4933 | "rows": [ 19:24:24 INFO - PID 4933 | { 19:24:24 INFO - PID 4933 | "title": "Facebook", 19:24:24 INFO - PID 4933 | "url": "https://www.facebook.com/" 19:24:24 INFO - PID 4933 | }, 19:24:24 INFO - PID 4933 | { 19:24:24 INFO - PID 4933 | "title": "YouTube", 19:24:24 INFO - PID 4933 | "url": "https://www.youtube.com/" 19:24:24 INFO - PID 4933 | }, 19:24:24 INFO - PID 4933 | { 19:24:24 INFO - PID 4933 | "title": "Amazon", 19:24:24 INFO - PID 4933 | "url": "http://www.amazon.com/" 19:24:24 INFO - PID 4933 | }, 19:24:24 INFO - PID 4933 | { 19:24:24 INFO - PID 4933 | "title": "Yahoo", 19:24:24 INFO - PID 4933 | "url": "https://www.yahoo.com/" 19:24:24 INFO - PID 4933 | }, 19:24:24 INFO - PID 4933 | { 19:24:24 INFO - PID 4933 | "title": "eBay", 19:24:24 INFO - PID 4933 | "url": "http://www.ebay.com" 19:24:24 INFO - PID 4933 | }, 19:24:24 INFO - PID 4933 | { 19:24:24 INFO - PID 4933 | "title": "Twitter", 19:24:24 INFO - PID 4933 | "url": "https://twitter.com/" 19:24:24 INFO - PID 4933 | } 19:24:24 INFO - PID 4933 | ] 19:24:24 INFO - PID 4933 | } 19:24:24 INFO - PID 4933 | } 19:24:35 INFO - PID 4933 | RSS: Main: 150519808 19:24:35 INFO - PID 4933 | 19:24:38 INFO - PID 4933 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35575/tests/kraken/driver.html?testName=audio-beat-detection) 19:24:39 INFO - PID 4933 | RSS: Main: 205312000 19:24:39 INFO - PID 4933 | 19:24:42 INFO - PID 4933 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35575/tests/kraken/driver.html?testName=audio-dft) 19:24:42 INFO - PID 4933 | RSS: Main: 184549376 19:24:42 INFO - PID 4933 | 19:24:45 INFO - PID 4933 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35575/tests/kraken/driver.html?testName=audio-fft) 19:24:46 INFO - PID 4933 | RSS: Main: 266579968 19:24:46 INFO - PID 4933 | 19:24:48 INFO - PID 4933 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35575/tests/kraken/driver.html?testName=audio-oscillator) 19:24:49 INFO - PID 4933 | RSS: Main: 177967104 19:24:49 INFO - PID 4933 | 19:24:51 INFO - PID 4933 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35575/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:24:52 INFO - PID 4933 | RSS: Main: 181477376 19:24:52 INFO - PID 4933 | 19:24:55 INFO - PID 4933 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35575/tests/kraken/driver.html?testName=imaging-darkroom) 19:24:55 INFO - PID 4933 | RSS: Main: 220385280 19:24:55 INFO - PID 4933 | 19:24:59 INFO - PID 4933 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35575/tests/kraken/driver.html?testName=imaging-desaturate) 19:25:00 INFO - PID 4933 | RSS: Main: 215465984 19:25:00 INFO - PID 4933 | 19:25:02 INFO - PID 4933 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35575/tests/kraken/driver.html?testName=json-parse-financial) 19:25:03 INFO - PID 4933 | RSS: Main: 217235456 19:25:03 INFO - PID 4933 | 19:25:05 INFO - PID 4933 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35575/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:25:05 INFO - PID 4933 | RSS: Main: 180633600 19:25:05 INFO - PID 4933 | 19:25:07 INFO - PID 4933 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35575/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:25:08 INFO - PID 4933 | RSS: Main: 187449344 19:25:08 INFO - PID 4933 | 19:25:10 INFO - PID 4933 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35575/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:25:11 INFO - PID 4933 | RSS: Main: 196882432 19:25:11 INFO - PID 4933 | 19:25:13 INFO - PID 4933 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35575/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:25:14 INFO - PID 4933 | RSS: Main: 205914112 19:25:14 INFO - PID 4933 | 19:25:17 INFO - PID 4933 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35575/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:25:18 INFO - PID 4933 | RSS: Main: 203182080 19:25:18 INFO - PID 4933 | 19:25:20 INFO - PID 4933 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35575/tests/kraken/driver.html?testName=ai-astar) 19:25:20 INFO - PID 4933 | RSS: Main: 271462400 19:25:20 INFO - PID 4933 | 19:25:20 INFO - PID 4933 | __start_tp_report 19:25:20 INFO - PID 4933 | _x_x_mozilla_page_load 19:25:20 INFO - PID 4933 | _x_x_mozilla_page_load_details 19:25:20 INFO - PID 4933 | |i|pagename|runs| 19:25:20 INFO - PID 4933 | |0;ai-astar;103;110;111;111;110;111;110;110;110;111 19:25:20 INFO - PID 4933 | |1;audio-beat-detection;162;124;124;165;128;124;123;124;147;125 19:25:20 INFO - PID 4933 | |2;audio-dft;162;163;161;164;163;162;162;164;165;162 19:25:20 INFO - PID 4933 | |3;audio-fft;74;76;75;109;76;76;75;75;90;75 19:25:20 INFO - PID 4933 | |4;audio-oscillator;85;84;105;85;85;85;101;84;84;111 19:25:20 INFO - PID 4933 | |5;imaging-gaussian-blur;113;113;113;114;113;113;113;113;113;113 19:25:20 INFO - PID 4933 | |6;imaging-darkroom;148;149;149;149;148;149;149;148;148;148 19:25:20 INFO - PID 4933 | |7;imaging-desaturate;94;94;94;94;94;93;95;94;94;94 19:25:20 INFO - PID 4933 | |8;json-parse-financial;66;65;65;64;65;66;67;66;67;66 19:25:20 INFO - PID 4933 | |9;json-stringify-tinderbox;55;55;55;55;55;55;55;55;55;55 19:25:20 INFO - PID 4933 | |10;stanford-crypto-aes;83;83;82;83;82;84;83;82;84;83 19:25:20 INFO - PID 4933 | |11;stanford-crypto-ccm;133;143;136;138;137;136;133;131;183;149 19:25:20 INFO - PID 4933 | |12;stanford-crypto-pbkdf2;194;198;187;195;193;196;198;192;197;199 19:25:20 INFO - PID 4933 | |13;stanford-crypto-sha256-iterative;70;71;70;70;72;74;73;71;72;74 19:25:20 INFO - PID 4933 | __end_tp_report 19:25:20 INFO - PID 4933 | __start_cc_report 19:25:20 INFO - PID 4933 | _x_x_mozilla_cycle_collect,2054 19:25:20 INFO - PID 4933 | __end_cc_report 19:25:20 INFO - PID 4933 | __startTimestamp1490322320638__endTimestamp 19:25:20 INFO - PID 4933 | 19:25:20 INFO - PID 4933 | ------- Summary: start ------- 19:25:20 INFO - PID 4933 | Number of tests: 14 19:25:20 INFO - PID 4933 | 19:25:20 INFO - PID 4933 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:2.41 (2.2%) stddev-sans-first:0.53 19:25:20 INFO - PID 4933 | Values: 103.0 110.0 111.0 111.0 110.0 111.0 110.0 110.0 110.0 111.0 19:25:20 INFO - PID 4933 | 19:25:20 INFO - PID 4933 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:126.50 stddev:16.83 (13.3%) stddev-sans-first:14.64 19:25:20 INFO - PID 4933 | Values: 162.0 124.0 124.0 165.0 128.0 124.0 123.0 124.0 147.0 125.0 19:25:20 INFO - PID 4933 | 19:25:20 INFO - PID 4933 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.23 (0.8%) stddev-sans-first:1.27 19:25:20 INFO - PID 4933 | Values: 162.0 163.0 161.0 164.0 163.0 162.0 162.0 164.0 165.0 162.0 19:25:20 INFO - PID 4933 | 19:25:20 INFO - PID 4933 | [#3] audio-fft Cycles:10 Average:80.10 Median:75.50 stddev:11.18 (14.8%) stddev-sans-first:11.64 19:25:20 INFO - PID 4933 | Values: 74.0 76.0 75.0 109.0 76.0 76.0 75.0 75.0 90.0 75.0 19:25:20 INFO - PID 4933 | 19:25:20 INFO - PID 4933 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:84.50 stddev:10.47 (12.4%) stddev-sans-first:10.89 19:25:20 INFO - PID 4933 | Values: 85.0 84.0 105.0 85.0 85.0 85.0 101.0 84.0 84.0 111.0 19:25:20 INFO - PID 4933 | 19:25:20 INFO - PID 4933 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:113.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:25:20 INFO - PID 4933 | Values: 113.0 113.0 113.0 114.0 113.0 113.0 113.0 113.0 113.0 113.0 19:25:20 INFO - PID 4933 | 19:25:20 INFO - PID 4933 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:149.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 19:25:20 INFO - PID 4933 | Values: 148.0 149.0 149.0 149.0 148.0 149.0 149.0 148.0 148.0 148.0 19:25:20 INFO - PID 4933 | 19:25:20 INFO - PID 4933 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 19:25:20 INFO - PID 4933 | Values: 94.0 94.0 94.0 94.0 94.0 93.0 95.0 94.0 94.0 94.0 19:25:20 INFO - PID 4933 | 19:25:20 INFO - PID 4933 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:66.00 stddev:0.95 (1.4%) stddev-sans-first:1.00 19:25:20 INFO - PID 4933 | Values: 66.0 65.0 65.0 64.0 65.0 66.0 67.0 66.0 67.0 66.0 19:25:20 INFO - PID 4933 | 19:25:20 INFO - PID 4933 | [#9] json-stringify-tinderbox Cycles:10 Average:55.00 Median:55.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 19:25:20 INFO - PID 4933 | Values: 55.0 55.0 55.0 55.0 55.0 55.0 55.0 55.0 55.0 55.0 19:25:20 INFO - PID 4933 | 19:25:20 INFO - PID 4933 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:0.74 (0.9%) stddev-sans-first:0.78 19:25:20 INFO - PID 4933 | Values: 83.0 83.0 82.0 83.0 82.0 84.0 83.0 82.0 84.0 83.0 19:25:20 INFO - PID 4933 | 19:25:20 INFO - PID 4933 | [#11] stanford-crypto-ccm Cycles:10 Average:141.90 Median:137.50 stddev:15.37 (11.2%) stddev-sans-first:15.96 19:25:20 INFO - PID 4933 | Values: 133.0 143.0 136.0 138.0 137.0 136.0 133.0 131.0 183.0 149.0 19:25:20 INFO - PID 4933 | 19:25:20 INFO - PID 4933 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.90 Median:196.50 stddev:3.60 (1.8%) stddev-sans-first:3.81 19:25:20 INFO - PID 4933 | Values: 194.0 198.0 187.0 195.0 193.0 196.0 198.0 192.0 197.0 199.0 19:25:20 INFO - PID 4933 | 19:25:20 INFO - PID 4933 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:72.00 stddev:1.57 (2.2%) stddev-sans-first:1.54 19:25:20 INFO - PID 4933 | Values: 70.0 71.0 70.0 70.0 72.0 74.0 73.0 71.0 72.0 74.0 19:25:20 INFO - PID 4933 | -------- Summary: end -------- 19:25:20 INFO - PID 4933 | 19:25:21 INFO - TEST-INFO | 4933: exit 0 19:25:21 INFO - TEST-OK | kraken | took 64379ms 19:25:21 INFO - SUITE-END | took 1188s 19:25:22 INFO - Completed test suite (00:19:48) 19:25:22 INFO - javascript benchmark 19:25:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6648.348656893692, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2657.3755167535633, 2670.1055146525914, 2703.391736859207, 2708.444768822392, 2711.254405038614, 4970.975145124269, 5052.974735126329, 5113.3097031900725, 5126.8974620507615, 5159.303494028305, 5119.0, 5146.6140039497, 5157.226416037596, 5170.767315470804, 5192.428832828386, 4567.063751930847, 4598.97700511497, 4625.653076019286, 4686.718796872182, 4754.9286760698615, 4647.8838029049375, 4664.997025639487, 4712.481627021025, 4719.52804719527, 4729.52704729526, 4527.818887244506, 4560.908781824378, 4561.1105834362315, 4570.588647021751, 4585.954140458586, 4612.815487380501, 4617.953820461786, 4620.075984803019, 4623.075384922995, 4627.907441851178, 4564.0871825635, 4567.497575266718, 4574.771261436948, 4578.45058592971, 4579.7252164870215, 5032.748362581893, 5035.84892453227, 5037.546620804109, 5048.419431765321, 5095.5159259870625, 5499.257600223998, 5510.889782204334, 5517.917231241495, 5572.665640061609, 5587.608867379285, 5544.112941929272, 5579.609427340088, 5584.385717571064, 5589.273394458735, 5636.661800291996, 5118.488151184852, 5160.354955630546, 5169.276301317818, 5170.715610641376, 5218.6868787872845, 5515.669059856422, 5578.358488773762, 5592.7762889483965, 5595.636283641632, 5679.034564124109, 5312.787488500417, 5319.627626066215, 5326.280952071421, 5329.280547126166, 5332.9733351333, 5425.647332923348, 5426.348838139448, 5430.70131142791, 5432.375276843135, 5444.428335024844, 5382.381026181961, 5394.973025134849, 5468.371137319259, 5472.972635136799, 5476.616636835383, 5440.102383106822, 5453.972730136324, 5460.099083651233, 5462.098753705594, 5466.180072989004, 4518.706284091523, 4561.2245918193985, 4561.771911404417, 4565.954340456553, 4570.908581828345, 3933.1347103637154, 3943.191645712622, 3978.9403158952637, 3982.542007669097, 3996.420519024783, 4606.332081848113, 4711.175544279738, 4715.976420117946, 4734.07685501324, 4761.857144285677, 5388.622796404214, 5457.290552228185, 5538.667679939216, 5540.113581826889, 5550.500454959073, 4678.578927896506, 4744.074905393484, 4777.761111944389, 4786.1863483207935, 4798.760061996886, 4885.316055752198, 4905.092557876804, 4910.8281210157475, 4910.901781964412, 4951.133551628451, 5124.30821839047, 5124.538791508782, 5155.072087024221, 5168.3539557555305, 5205.609579281493, 5393.7033463159905, 5464.617476776588, 5466.480684334982, 5532.723363831873, 5565.053940830149, 5131.25596788471, 5141.485851414828, 5150.175971844487, 5164.9741751291, 5204.063268611686, 5432.456754324536, 5436.6194366393975, 5437.483439073281, 5439.428859969805, 5492.423295553909, 5334.306540149756, 5378.435264297349, 5524.723763811874, 5542.0301447245765, 5551.139573366135, 5242.082635538689, 5367.892642147213, 5376.1398176291605, 5425.538829199562, 5426.647267927572, 5242.239875217996, 5275.709835959059, 5301.6818990860675, 5354.892902142014, 5363.758630861698, 5263.894722105613, 5330.760115794721, 5333.679979201261, 5336.2529245904825, 5364.839054828361, 5218.295530103387, 5302.920456193237, 5411.161270003156, 5413.269208656781, 5465.699386533779, 5182.844514664566, 5247.5539579134675, 5266.394364648115, 5308.867278317918, 5321.920171197357], "value": 5000.5055454423255, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.7894718427773, 628.9842753931151, 643.7714611312982, 959.616153538585, 973.3673112476894, 23426.765732342672, 23923.999999999978, 23932.521349573, 32599.0, 33235.34411214764, 37097.62902370982, 37151.628483715154, 37181.0, 37194.14029298531, 37682.623173768254, 7361.190269070398, 7524.097108347006, 7532.9246707532775, 7533.246675332478, 7541.660625271848, 5558.666480011212, 5686.971565142189, 7075.646217689095, 7208.9639551802165, 7474.439417043744, 7398.223186565414, 7478.177400485943, 7480.4389670774635, 7484.663190156456, 7485.775426737179, 7380.1512826025155, 7446.739364122284, 7451.366633836131, 7451.552906825581, 7452.5901075440825, 5443.265159203536, 5550.084236101038, 7078.433725301964, 7244.673989670478, 7340.743073992438, 34982.0, 35602.0, 35678.0, 35686.6470029495, 35736.10659733501, 2595.9870200648875, 2603.557395242813, 2614.2810727050023, 2630.973690263111, 2637.222019504251, 22699.432514187276, 23127.884360578257, 24351.391215219584, 24392.0, 24886.25341239766, 2809.8454584997817, 2852.1728698677357, 2856.7857410694073, 2858.6712528059334, 2903.5209190483547, 144207.0, 145511.0, 146062.99999999892, 146134.0, 146770.0, 41204.0, 41294.793526032176, 41307.0, 41341.58658413438, 41401.1719765603, 44031.0, 44088.0, 44131.11737765227, 44182.11635767267, 44192.55807441949, 12827.102102852898, 13185.60443186706, 13204.0, 13204.141730787467, 13218.73562528744, 10542.525586348633, 10562.260641755158, 10562.366258024544, 10574.206934479946, 10576.312539684895, 9674.129328360481, 9840.95079524612, 12300.81548776769, 12421.378931053592, 12623.368831558386, 5166.225066240019, 5341.919871201935, 5348.5186333230195, 5368.597355198376, 5395.109806881899, 860.6815478272954, 885.2121611765534, 885.8228354329032, 886.1050339157497, 913.3241401362943, 20378.388648340573, 21337.0, 21443.249486267905, 21499.892500537397, 21635.0, 912.6668765900398, 950.3442624589012, 968.6367612145445, 976.8876579193484, 995.348047029197, 11186.496607652674, 11203.327800332007, 11381.829272560919, 11448.427578621036, 11453.370064646359, 241155.0, 242060.0, 242971.0, 243066.0, 243581.0, 43145.784271078446, 43535.12929741388, 43577.0, 43657.56342436599, 43684.12631747347, 1197.0961923747516, 1216.5012344938532, 1230.8522977242787, 1235.32057368447, 1260.6596219020996, 19031.809681903003, 19394.224231031167, 19422.320218792276, 20733.481662957944, 20778.792212077686, 31604.841975789976, 31778.364432711678, 31814.681853182097, 31871.0, 31886.52170217495, 237811.0, 238221.0, 238311.0, 238416.0, 239252.0, 24322.391940201636, 28873.711262887104, 29165.562516561844, 29323.41353172882, 29969.55045674273, 28488.718007690117, 28492.715072849005, 33698.32603347969, 34135.31729365449, 34416.0, 25863.870680646476, 26252.0, 26331.736682633695, 26828.195154145407, 27935.161945141677, 26467.0, 27630.585541216496, 27809.304767380978, 27852.86073569619, 28707.0, 29957.70042299549, 30503.389932201677, 30826.69173308238, 30907.845460773453, 30925.845370773, 26323.21030369092, 26491.205263841344, 26708.465830683665, 26861.0, 27174.72825271722, 20949.581008380053, 21357.46606334854, 22225.66661500111, 22835.657465138367, 22948.770512294665], "value": 14656.767797591652, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.8592885454517, 414.78845788647783, 419.73346924702804, 423.4748911349926, 439.1721604774998, 15987.760183597255, 17299.221535030923, 17988.460346189604, 18964.051797410142, 18966.525836854067, 17446.912765436155, 17863.374781882638, 17943.10284485777, 18621.16204770785, 18878.15048322825, 6301.338359472258, 6341.143945567359, 6399.5840270382505, 6509.4466970307585, 6511.869762604745, 6293.874122517547, 6401.199850018747, 6503.089567460559, 6503.544751867371, 6507.479401647881, 6382.617042977413, 6407.743690252384, 6462.192225971754, 6468.547201695883, 6473.996530537775, 6279.0895320178315, 6330.240371155468, 6399.232092148972, 6438.098666186737, 6444.130042444281, 6302.87394252117, 6304.653244071575, 6306.180196574416, 6308.936910630927, 6312.0, 23933.64099538508, 24162.87918560396, 24512.142075027466, 24901.62647560288, 25065.87467062653, 1612.4114698135213, 1638.9836101639069, 1648.967020659592, 1694.0, 1697.957551061221, 14723.0, 15471.845281547154, 15638.765418518731, 16220.0, 16278.0, 1738.9217485213196, 1799.4871461633502, 1801.369520667769, 1804.6390721855682, 1828.4697437743039, 89153.0, 90107.54946225227, 90298.0, 91915.54042229813, 93005.5349723247, 17355.30578776835, 17593.472195834147, 17872.731909021375, 17943.551411214565, 18407.26370945174, 32927.67072329294, 33232.66767332344, 33460.330793384484, 33472.49791253133, 33480.49779253313, 9002.819943601091, 9271.304652151115, 9343.159115679486, 9394.0, 9604.75988100289, 7470.738524151629, 7564.583947882919, 7672.73145439907, 7765.107012693613, 7777.533347999138, 9281.628734850665, 9423.811523769624, 9557.952210238904, 9686.709398717909, 9786.510674466248, 3914.4911161548816, 3918.1575961168487, 3925.7644541327613, 3926.1951299983434, 4012.6589239914933, 827.2224109337204, 852.7228650688551, 857.3355649371787, 859.6776208921655, 860.2129051917425, 16349.509514714578, 16453.012819230884, 16482.42311519091, 17220.397286094925, 17436.215370308368, 874.3835595904999, 877.6840337478502, 878.9121087891288, 879.859222524393, 894.3918135667678, 9058.411203271766, 9085.77285567853, 9620.37467564606, 9787.853182202272, 9796.65711700087, 315228.0, 319199.0, 320550.0, 323601.0, 445773.0, 82336.58831705803, 84557.0, 85522.5723871389, 85693.0, 88735.55632221927, 1090.6019302954364, 1144.8282757586262, 1154.3997121496775, 1155.624422062833, 1157.9189456738115, 17474.12629368552, 17491.950482971064, 18103.547411314823, 18266.36067737623, 18381.26474941041, 34748.82625586957, 40441.0, 40665.52679205226, 41371.1725765489, 42030.579694202665, 51877.48122518878, 53823.192652111036, 54010.45989540054, 54184.729076354364, 54261.72869135629, 8127.634256458592, 8201.0, 8414.873776893473, 8438.324934005142, 8446.197611226924, 11802.409879506162, 11907.82138267944, 12912.612621621367, 13036.41336139857, 13059.869401306245, 10117.0, 10310.948445257725, 10665.46672666348, 10760.83858742135, 11069.557217711523, 9927.950360248153, 10310.639127630497, 10401.115905148146, 10406.58373665045, 10472.371657700562, 9894.802103958025, 10095.639229509421, 10181.287309888237, 10665.0, 10906.836397453886, 8237.46456480327, 8251.546164960984, 8321.625526851427, 8413.831723365622, 8455.450395724258, 5909.409059094056, 7924.801879953047, 10238.53926573291, 10403.271770975958, 10478.895211047791], "value": 9696.461686739034, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1103.9227254092216, 1229.526632246585, 1283.2813624370353, 1297.5588299978008, 1307.0719788949846, 8201.835963280739, 9561.617535298588, 9776.16902563283, 9782.461964591945, 9789.804203915926, 9491.857622135674, 9589.0, 9590.664326748565, 9594.040595940403, 9600.087991640801, 1825.2334019711752, 1894.933677321294, 2162.87022778633, 2203.6584329428965, 2204.526026904215, 2172.728408948881, 2219.8002179803816, 2239.8432109752325, 2243.652233903739, 2257.525919556895, 2140.678898165272, 2141.1114387529233, 2147.2162660628837, 2154.2890846020855, 2158.3956492182215, 2144.785521447858, 2146.967795483069, 2149.1833103420677, 2156.4069880782754, 2157.65477523597, 2068.327793467114, 2082.0, 2085.708000879878, 2091.0, 2091.1321801452377, 9863.90136098637, 9911.207103431709, 9944.35361701487, 9990.250731195189, 10043.447610381427, 5137.255098010804, 5301.7084060376665, 5316.893662126736, 5322.04203243416, 5333.626646134772, 2987.357718090599, 3111.1910903165112, 3173.349463360029, 3192.5211218317204, 3198.9360212795614, 1015.1878497202209, 1079.7894410589938, 1098.6045023791428, 1098.8626421697288, 1151.372501986411, 14705.70588588233, 14744.336504857307, 14768.556943291718, 14851.777223341658, 14867.107973521623, 4725.10223057618, 4933.605311575066, 5052.949470505321, 5078.568321692624, 5111.003354345867, 12188.573399931138, 12191.32947687868, 12198.817017744741, 12201.145919785708, 12202.267863928193, 5485.945140548623, 5488.121900495981, 5490.423505531941, 5494.945050549523, 5495.148252020943, 4660.091282199938, 4714.175019371665, 4744.430668319824, 4871.103117505981, 4960.553550180501, 3914.236723838824, 3954.7627142370975, 4008.6993475489453, 4051.108756073659, 4082.8366865325056, 1216.5559570756786, 1222.541546919905, 1229.1518851992275, 1237.8638349781518, 1241.1064033895582, 665.4809248785955, 691.1188235000415, 692.9986169984425, 696.1611258433576, 705.3546005404997, 5246.23929530216, 5359.839204823861, 5684.744186511617, 6342.619442833445, 6436.227652681615, 819.4141189049858, 825.2201669422338, 833.4915701422127, 834.9916500835035, 859.6518410043942, 3479.1302174456387, 3540.858365665396, 3542.6103128655827, 3548.733844961638, 3700.7224458165206, 12413.44139513724, 12788.424520896582, 12881.806772898413, 13060.869391305965, 13127.081104322606, 12670.429830657642, 12832.294223817593, 12852.935735321264, 12886.29125398112, 12926.41831117602, 9348.766280842898, 9560.952195238979, 9574.712758617252, 9575.138237558653, 9617.615295388106, 5364.839054828361, 5375.543078838343, 5417.566594672496, 5441.809536666197, 5574.9721251393485, 11621.88378116208, 11653.59212427561, 11684.70788230301, 11693.649190524298, 11715.531378745096, 11170.27393219438, 12011.0, 12164.756704865677, 12247.0, 12312.26126432417, 7728.652210650422, 7934.246246606564, 7938.64276107565, 7938.722144724907, 7942.64258108375, 8713.564321784012, 8982.236509896471, 9041.276697864287, 9080.455172689659, 9082.682106126254, 7821.92178078212, 7982.760517184493, 7984.401169912396, 8003.839923201387, 8224.300934420402, 7590.658420371207, 7669.501482403626, 7730.806729831799, 7799.220077992155, 7939.126696063544, 6780.694868731018, 6864.759733409307, 6878.209005964378, 6886.827829304308, 6888.827779305558, 4993.151164302005, 5035.697858128524, 5088.643794934319, 5108.438071812172, 5314.574834013347, 4861.295112208639, 5090.287359769709, 5176.585873130065, 5177.119889618699, 5280.920786188287], "value": 4661.329600638512, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.96367381424966, 382.63076131533046, 387.15406836063204, 387.9786611736355, 388.7356597513689, 5038.57172140368, 5201.973990130049, 5365.731713414333, 5370.838874833751, 5405.540529055035, 5133.255677926699, 5216.347956505437, 5268.6575372600755, 5285.814996475124, 5296.496832800887, 3998.3802510610903, 4113.588641135878, 4224.61978421942, 4231.957680423187, 4239.27932251518, 4120.505539335269, 4130.586941305861, 4133.545310015896, 4156.355764856452, 4161.979190104061, 4089.263932492165, 4093.263212621727, 4100.692448066392, 4106.404571337154, 4119.299719047769, 4127.236461254663, 4135.875923722293, 4141.772202528859, 4144.3990621360035, 4155.750654960697, 3448.81031543265, 3572.8749493767596, 3580.695640870529, 3583.4266517357096, 3597.956592588146, 5200.6619569727845, 5202.791888324463, 5205.843824685266, 5206.349206349207, 5207.297014902978, 4708.246680531133, 4724.5984091352275, 4728.71627702339, 4729.952700472985, 4743.264793956942, 5311.601629877775, 5493.0, 5589.74846131925, 5613.214150019001, 5620.269364982526, 3987.7806720630356, 3991.1020020495157, 3995.440638310639, 3999.7600143991453, 4007.6192761687594, 5668.376478587352, 5719.513841323451, 5874.206982057453, 5914.9187060927825, 5986.221791167164, 4057.107436363995, 4061.8066244228376, 4063.4311196432523, 4074.7351422157467, 4086.4891888513935, 4106.91786164281, 4125.278076336629, 4127.545969943304, 4130.421740956269, 4142.668586513072, 4391.758453285036, 4424.75663838492, 4444.888877778081, 4696.201645720235, 4723.645726570521, 5571.88562287536, 5581.413951535031, 5592.692401917852, 5604.6917419541505, 5612.803551875665, 1408.7675533537056, 1430.6065831896103, 1431.2843578210895, 1432.1120905038943, 1438.6834896322791, 938.648006997376, 970.1995853420956, 973.8149751547184, 981.9312648114707, 984.0995489127369, 4904.117258893433, 4908.779104940286, 4909.140900342426, 4909.3126962225315, 4921.704697718148, 5735.684537350402, 5809.186713859978, 5813.970930145322, 5818.709064546756, 5820.708964551755, 4804.739890640605, 4806.687565308243, 4869.0, 4915.606751459946, 4925.532074452921, 3042.9847850760602, 3068.5704001439817, 3081.1680846171857, 3089.1968088297203, 3090.1502086925825, 5349.679019258857, 5358.651687640291, 5373.194020896819, 5375.118708452089, 5400.756965936543, 5705.4009329019855, 5917.171595976567, 5997.220361352996, 6008.549358798107, 6043.4645732246245, 5452.318460192476, 5457.372402173801, 5466.480684334982, 5467.726613669301, 5467.917981230365, 5717.656940583578, 5893.381194974466, 5899.174115623902, 5899.587028907935, 5903.380145084876, 5717.514011308919, 5727.140928860537, 5742.368339482737, 5752.395998420273, 5758.1362795579325, 5177.974110129425, 5231.764570594256, 5324.733763311741, 5419.620626556103, 5442.319710036246, 4048.2510735514024, 4063.715539912178, 4069.4099355593867, 4097.8975525612095, 4101.692373072091, 5803.390643982321, 5808.564357673107, 5833.620814647034, 5835.328937172279, 5875.911861322169, 5425.403205647297, 5646.153077038477, 5669.376368599534, 5673.404292549223, 5690.743916523849, 5663.433656634304, 5665.518430933417, 5666.0, 5686.152000599905, 5687.658740475585, 5325.0, 5615.3823079462045, 5618.0, 5627.155926611041, 5630.60585758993, 5691.8861622768145, 5710.942890571041, 5711.343195532567, 5725.112607545837, 5734.770609175586, 5564.638298510584, 5566.916496252478, 5576.944230557642, 5578.86052848682, 5602.299712535933], "value": 4233.604450642442, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.2154283345573, 688.6935313785366, 693.4833549005991, 693.524935419238, 699.3880354689646, 11238.831417528743, 11472.311661300308, 11491.0, 11502.079833613312, 11503.712407189825, 11512.654620361382, 11583.768324633502, 11597.6520704379, 11700.531978720841, 12119.697007574792, 786.076360276674, 805.3637626275265, 805.842860642175, 810.1088802317433, 810.254565799463, 837.3510529339779, 838.4885220015785, 844.0082902589463, 844.6916875340487, 845.3026253340987, 884.6328773558965, 886.4105369929022, 887.529609307065, 887.5429153985671, 888.2938064238946, 872.9825403491894, 882.686646240585, 883.147762409275, 883.571467838098, 884.456059523395, 643.2313385504324, 643.4466358931315, 646.5312648329971, 646.7897933171691, 650.1612919334053, 13075.476980920752, 13315.067945243836, 13378.531751388655, 13388.464461421532, 13693.109947853358, 13099.148555343872, 13823.377947992263, 13837.377318020714, 13999.300034998209, 14239.932005099556, 9806.411615303034, 10175.13511351536, 10253.641122560675, 10320.638777642747, 10698.197635177316, 2630.8026897982727, 2657.7740892024203, 2685.0468083830156, 2686.6910305314946, 2709.3632996245865, 65226.67386663084, 66583.66708166429, 67378.3262167377, 68091.65954170197, 70096.6495167526, 10341.861216777364, 10412.167026638002, 10498.475076246157, 10530.526126324334, 10610.0, 20948.47628809292, 21331.14675412997, 21369.358919232447, 21386.78613213879, 21394.786052139592, 6060.272767267956, 6064.575479716465, 6125.9693701531205, 6206.782762603287, 6255.937440625536, 3322.427882101642, 3332.133645252252, 3374.325134972966, 3374.5613070301197, 3407.0800883761244, 3411.710004649583, 3428.485727140899, 3442.122258823984, 3453.7582369233915, 3477.5479187705437, 613.7115555688819, 623.2801114712514, 624.2197253433209, 638.5211091681239, 642.1010585180784, 497.692831137092, 498.36209651645953, 501.0080041517815, 512.451676705921, 524.7743470307728, 7904.0, 8045.275925166763, 8064.193580641889, 8093.554854482943, 8227.13615070409, 501.70900877490965, 518.2795913679988, 521.2858384013849, 521.9138842091088, 523.8847453560211, 3439.9828000859834, 3613.56637203532, 3642.7814331140216, 3781.905452363713, 3808.257389808961, 61449.38550614526, 61554.38445615487, 62414.375856240855, 63788.36211637917, 63944.36055639384, 54267.72866135644, 54285.1857222142, 54748.45251547434, 55421.0, 58900.41099589035, 48701.512984869696, 49381.506184937694, 49485.50514494809, 49810.75094624504, 50248.49751502511, 8250.834983300421, 8848.823023539622, 8911.331650126136, 8929.508877011827, 9053.68312109073, 24141.15505957283, 24179.879100604383, 24568.385790355384, 24629.753702462745, 25100.0, 41373.79313103415, 41717.95705107275, 42269.0, 42289.0, 45172.0, 11457.427128643702, 11580.768384632429, 11614.825777613174, 11783.410829458322, 11935.701607459883, 12553.246805191719, 12868.549600763929, 12873.0, 12972.935135324264, 13521.526746563823, 11872.584459543874, 11906.464209110438, 11993.34036627959, 12005.0, 12051.638450846138, 11060.723481913017, 11134.3876086816, 11253.943730281297, 11282.43587820622, 11744.060475161796, 11017.338959662446, 11281.943590281997, 11422.714432139262, 11441.542338306708, 11837.46731397072, 8360.581970901552, 8385.790355240924, 8541.188587084218, 8581.35639827028, 8839.911600883908, 9527.38072025316, 9895.505224738878, 9918.702438926844, 9923.900760992587, 10013.39919604826], "value": 6156.893127809535, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.8000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 111.0, 111.0, 110.0, 111.0, 110.0, 110.0, 110.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 124.0, 124.0, 165.0, 128.0, 124.0, 123.0, 124.0, 147.0, 125.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 164.0, 163.0, 162.0, 162.0, 164.0, 165.0, 162.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 109.0, 76.0, 76.0, 75.0, 75.0, 90.0, 75.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 105.0, 85.0, 85.0, 85.0, 101.0, 84.0, 84.0, 111.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 149.0, 149.0, 148.0, 149.0, 149.0, 148.0, 148.0, 148.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 95.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 64.0, 65.0, 66.0, 67.0, 66.0, 67.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0], "value": 55.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 83.0, 82.0, 84.0, 83.0, 82.0, 84.0, 83.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 143.0, 136.0, 138.0, 137.0, 136.0, 133.0, 131.0, 183.0, 149.0], "value": 141.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 198.0, 187.0, 195.0, 193.0, 196.0, 198.0, 192.0, 197.0, 199.0], "value": 194.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 70.0, 70.0, 72.0, 74.0, 73.0, 71.0, 72.0, 74.0], "value": 71.7, "unit": "score"}]}]} 19:25:22 INFO - Return code: 0 19:25:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:25:22 ERROR - # TBPL SUCCESS # 19:25:22 INFO - Running post-action listener: _resource_record_post_action 19:25:22 INFO - [mozharness: 2017-03-24 02:25:22.434752Z] Finished run-tests step (success) 19:25:22 INFO - Running post-run listener: _resource_record_post_run 19:25:22 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 373121024; Read time: 16; Write time: 314976 19:25:22 INFO - TinderboxPrint: CPU usage
12.9% 19:25:22 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 19:25:22 INFO - TinderboxPrint: I/O write bytes / time
373,121,024 / 314,976 19:25:22 INFO - TinderboxPrint: CPU idle
8,372.6 (87.0%) 19:25:22 INFO - TinderboxPrint: CPU user
1,200.1 (12.5%) 19:25:22 INFO - TinderboxPrint: Swap in / out
0 / 0 19:25:22 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113786880; Read time: 0; Write time: 107260 19:25:22 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 258928640; Read time: 16; Write time: 207716 19:25:23 INFO - Running post-run listener: _upload_blobber_files 19:25:23 INFO - Blob upload gear active. 19:25:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:25:23 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 19:25:23 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', 'Pine', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:25:23 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 Pine -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:25:23 INFO - (blobuploader) - INFO - Open directory for files ... 19:25:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:25:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:25:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:24 INFO - (blobuploader) - INFO - Done attempting. 19:25:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:25:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:25:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:25 INFO - (blobuploader) - INFO - Done attempting. 19:25:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:25:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:25:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:26 INFO - (blobuploader) - INFO - Done attempting. 19:25:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:25:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:25:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:32 INFO - (blobuploader) - INFO - Done attempting. 19:25:32 INFO - (blobuploader) - INFO - Iteration through files over. 19:25:32 INFO - Return code: 0 19:25:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:25:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:25:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/493edc6d1fba874a47b9cb190c6eb2f9e192f0767d7ea9e79b4fed8664495d5d416df8377a1bb8e04090e1b4d995b9df83c85e89b53ce0badd620c9bb12499e7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/cbf335800cf678d56f732ebdaa2748d5040b20dcf7a3b2a966b5d4271a48de8c6f7fac535341d4ac85c46acc3dd4e1d17e00992dd466c2e6faf7bc16eaac2f2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/8007ce6a58821fe6c2220d007bbeec4ccbf8f6ff953ed54c084062167105ab5cff966fe2a7d91fddfe1721c2aef5c7696f723132e66114711f9c5e8ec8d951ae", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/5d24463d55c5ea9eee5f266d307dfbe823799856ee975c859a8b1fe368d3e91c549bdc1f5265efc91571e670c07edcd7785f6d2aa25451ab310f2b0bed6b59cc"} 19:25:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:25:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:25:32 INFO - Contents: 19:25:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/493edc6d1fba874a47b9cb190c6eb2f9e192f0767d7ea9e79b4fed8664495d5d416df8377a1bb8e04090e1b4d995b9df83c85e89b53ce0badd620c9bb12499e7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/cbf335800cf678d56f732ebdaa2748d5040b20dcf7a3b2a966b5d4271a48de8c6f7fac535341d4ac85c46acc3dd4e1d17e00992dd466c2e6faf7bc16eaac2f2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/8007ce6a58821fe6c2220d007bbeec4ccbf8f6ff953ed54c084062167105ab5cff966fe2a7d91fddfe1721c2aef5c7696f723132e66114711f9c5e8ec8d951ae", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/5d24463d55c5ea9eee5f266d307dfbe823799856ee975c859a8b1fe368d3e91c549bdc1f5265efc91571e670c07edcd7785f6d2aa25451ab310f2b0bed6b59cc"} 19:25:32 INFO - Running post-run listener: copy_logs_to_upload_dir 19:25:32 INFO - Copying logs to upload dir... 19:25:32 INFO - mkdir: /builds/slave/test/build/upload/logs 19:25:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.450676 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-03-23 19:25:32.015435) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 19:25:32.018667) ========= 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=17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/493edc6d1fba874a47b9cb190c6eb2f9e192f0767d7ea9e79b4fed8664495d5d416df8377a1bb8e04090e1b4d995b9df83c85e89b53ce0badd620c9bb12499e7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/cbf335800cf678d56f732ebdaa2748d5040b20dcf7a3b2a966b5d4271a48de8c6f7fac535341d4ac85c46acc3dd4e1d17e00992dd466c2e6faf7bc16eaac2f2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/8007ce6a58821fe6c2220d007bbeec4ccbf8f6ff953ed54c084062167105ab5cff966fe2a7d91fddfe1721c2aef5c7696f723132e66114711f9c5e8ec8d951ae", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/5d24463d55c5ea9eee5f266d307dfbe823799856ee975c859a8b1fe368d3e91c549bdc1f5265efc91571e670c07edcd7785f6d2aa25451ab310f2b0bed6b59cc"} build_url:https://queue.taskcluster.net/v1/task/L2z-0K3WS3Wl8DUv-yQl8w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011396 build_url: 'https://queue.taskcluster.net/v1/task/L2z-0K3WS3Wl8DUv-yQl8w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/493edc6d1fba874a47b9cb190c6eb2f9e192f0767d7ea9e79b4fed8664495d5d416df8377a1bb8e04090e1b4d995b9df83c85e89b53ce0badd620c9bb12499e7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/cbf335800cf678d56f732ebdaa2748d5040b20dcf7a3b2a966b5d4271a48de8c6f7fac535341d4ac85c46acc3dd4e1d17e00992dd466c2e6faf7bc16eaac2f2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/8007ce6a58821fe6c2220d007bbeec4ccbf8f6ff953ed54c084062167105ab5cff966fe2a7d91fddfe1721c2aef5c7696f723132e66114711f9c5e8ec8d951ae", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/5d24463d55c5ea9eee5f266d307dfbe823799856ee975c859a8b1fe368d3e91c549bdc1f5265efc91571e670c07edcd7785f6d2aa25451ab310f2b0bed6b59cc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 19:25:32.044051) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 19:25:32.044524) ========= 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=17051fcd5208b27b50bedfeb000001dd-1490321062.165419-1581287077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004342 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 19:25:32.129938) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 19:25:32.130671) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 19:25:32.131319) ========= ========= Total master_lag: 0.18 =========