builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1489592562.86 results: success (0) revision: 8c89d1991786625a64d868798281610872a2bc26 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 08:42:42.858833) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 08:42:42.859840) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 08:42:42.860430) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 08:42:42.876295) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 08:42:42.876882) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-15 08:42:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.7M=0s 2017-03-15 08:42:43 (42.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127457 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 08:42:43.021472) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 08:42:43.022038) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018728 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 08:42:43.075779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 08:42:43.076547) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8c89d1991786625a64d868798281610872a2bc26 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 8c89d1991786625a64d868798281610872a2bc26 --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=78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-15 08:42:43,532 truncating revision to first 12 chars 2017-03-15 08:42:43,532 Setting DEBUG logging. 2017-03-15 08:42:43,532 attempt 1/10 2017-03-15 08:42:43,532 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8c89d1991786?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-15 08:42:44,048 unpacking tar archive at: mozilla-central-8c89d1991786/testing/mozharness/ program finished with exit code 0 elapsedTime=0.820121 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 08:42:43.914283) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 08:42:43.914701) ========= script_repo_revision: 8c89d1991786625a64d868798281610872a2bc26 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 08:42:43.915139) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 08:42:43.915470) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 08:42:43.927416) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-03-15 08:42:43.928078) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:42:44 INFO - MultiFileLogger online at 20170315 08:42:44 in /builds/slave/test 08:42:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:42:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:42:44 INFO - {'append_to_log': False, 08:42:44 INFO - 'base_work_dir': '/builds/slave/test', 08:42:44 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:42:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:42:44 INFO - 'branch': 'Firefox-Non-PGO', 08:42:44 INFO - 'buildbot_json_path': 'buildprops.json', 08:42:44 INFO - 'config_files': ('talos/linux_config.py',), 08:42:44 INFO - 'default_actions': ('clobber', 08:42:44 INFO - 'read-buildbot-config', 08:42:44 INFO - 'download-and-extract', 08:42:44 INFO - 'populate-webroot', 08:42:44 INFO - 'create-virtualenv', 08:42:44 INFO - 'install', 08:42:44 INFO - 'run-tests'), 08:42:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:42:44 INFO - 'download_minidump_stackwalk': True, 08:42:44 INFO - 'download_symbols': 'ondemand', 08:42:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:42:44 INFO - 'tooltool.py': '/tools/tooltool.py', 08:42:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:42:44 INFO - '/tools/misc-python/virtualenv.py')}, 08:42:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:42:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:42:44 INFO - 'gecko_profile': False, 08:42:44 INFO - 'gecko_profile_interval': 0, 08:42:44 INFO - 'installer_path': 'installer.exe', 08:42:44 INFO - 'log_level': 'info', 08:42:44 INFO - 'log_name': 'talos', 08:42:44 INFO - 'log_to_console': True, 08:42:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:42:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:42:44 INFO - 'opt_config_files': (), 08:42:44 INFO - 'pip_index': False, 08:42:44 INFO - 'suite': 'dromaeojs', 08:42:44 INFO - 'system_bits': '32', 08:42:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:42:44 INFO - 'title': 'talos-linux64-ix-019', 08:42:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:42:44 INFO - 'use_talos_json': True, 08:42:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:42:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:42:44 INFO - 'work_dir': 'build'} 08:42:44 INFO - [mozharness: 2017-03-15 15:42:44.475648Z] Running clobber step. 08:42:44 INFO - Running pre-action listener: _resource_record_pre_action 08:42:44 INFO - Running main action method: clobber 08:42:44 INFO - rmtree: /builds/slave/test/build 08:42:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:42:45 INFO - Running post-action listener: _resource_record_post_action 08:42:45 INFO - [mozharness: 2017-03-15 15:42:45.412664Z] Finished clobber step (success) 08:42:45 INFO - [mozharness: 2017-03-15 15:42:45.412765Z] Running read-buildbot-config step. 08:42:45 INFO - Running pre-action listener: _resource_record_pre_action 08:42:45 INFO - Running main action method: read_buildbot_config 08:42:45 INFO - Using buildbot properties: 08:42:45 INFO - { 08:42:45 INFO - "project": "", 08:42:45 INFO - "product": "firefox", 08:42:45 INFO - "who": "ffxbld@noreply.mozilla.org", 08:42:45 INFO - "installer_path": "public/build/target.tar.bz2", 08:42:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:42:45 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:42:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:42:45 INFO - "stage_platform": "linux64", 08:42:45 INFO - "basedir": "/builds/slave/test", 08:42:45 INFO - "buildnumber": 494, 08:42:45 INFO - "platform": "ubuntu64_hw", 08:42:45 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:42:45 INFO - "slavebuilddir": "test", 08:42:45 INFO - "taskId": "emNwyUhES6WamvejtLMWRw", 08:42:45 INFO - "branch": "mozilla-central", 08:42:45 INFO - "script_repo_revision": "production", 08:42:45 INFO - "revision": "8c89d1991786625a64d868798281610872a2bc26", 08:42:45 INFO - "slavename": "talos-linux64-ix-019", 08:42:45 INFO - "repo_path": "mozilla-central" 08:42:45 INFO - } 08:42:45 INFO - Finding installer, test and symbols from parent task. 08:42:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/emNwyUhES6WamvejtLMWRw'}, attempt #1 08:42:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/emNwyUhES6WamvejtLMWRw'}, attempt #1 08:42:46 INFO - Task dependencies: Fun8OAyKRYeVvGTo2wsRmA 08:42:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA'}, attempt #1 08:42:46 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.tar.bz2 08:42:46 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/test_packages.json 08:42:46 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.crashreporter-symbols.zip 08:42:46 INFO - Running post-action listener: _resource_record_post_action 08:42:46 INFO - [mozharness: 2017-03-15 15:42:46.799230Z] Finished read-buildbot-config step (success) 08:42:46 INFO - [mozharness: 2017-03-15 15:42:46.799450Z] Running download-and-extract step. 08:42:46 INFO - Running pre-action listener: _resource_record_pre_action 08:42:46 INFO - Running main action method: download_and_extract 08:42:46 INFO - mkdir: /builds/slave/test/build/tests 08:42:46 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')]} 08:42:46 INFO - trying https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.test_packages.json 08:42:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:42:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:42:47 INFO - Downloaded 896 bytes. 08:42:47 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:42:47 INFO - Using the following test package requirements: 08:42:47 INFO - {u'common': [u'target.common.tests.zip'], 08:42:47 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:42:47 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:42:47 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:42:47 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:42:47 INFO - u'mozbase': [u'target.common.tests.zip'], 08:42:47 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:42:47 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:42:47 INFO - u'web-platform': [u'target.common.tests.zip', 08:42:47 INFO - u'target.web-platform.tests.zip'], 08:42:47 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:42:47 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:42:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.common.tests.zip 08:42:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:42:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.common.tests.zip into memory 08:42:48 INFO - Expected file size: 58185627 08:42:48 INFO - Obtained file size: 58185627 08:42:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:42:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.common.tests.zip 08:42:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:42:58 INFO - Fetch https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.common.tests.zip into memory 08:42:59 INFO - Expected file size: 58185627 08:42:59 INFO - Obtained file size: 58185627 08:43:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.talos.tests.zip 08:43:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:43:09 INFO - Fetch https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.talos.tests.zip into memory 08:43:10 INFO - Expected file size: 14404452 08:43:10 INFO - Obtained file size: 14404452 08:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:10 INFO - trying https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.tar.bz2 08:43:10 INFO - Downloading https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:43:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:43:11 INFO - Downloaded 61644587 bytes. 08:43:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.tar.bz2 08:43:11 INFO - mkdir: /builds/slave/test/properties 08:43:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:43:11 INFO - Writing to file /builds/slave/test/properties/build_url 08:43:11 INFO - Contents: 08:43:11 INFO - build_url:https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.tar.bz2 08:43:11 INFO - Running post-action listener: _resource_record_post_action 08:43:11 INFO - Running post-action listener: set_extra_try_arguments 08:43:11 INFO - [mozharness: 2017-03-15 15:43:11.824543Z] Finished download-and-extract step (success) 08:43:11 INFO - [mozharness: 2017-03-15 15:43:11.824639Z] Running populate-webroot step. 08:43:11 INFO - Running pre-action listener: _resource_record_pre_action 08:43:11 INFO - Running main action method: populate_webroot 08:43:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:43:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:43:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:43:11 INFO - '--tppagecycles', 08:43:11 INFO - '7'], 08:43:11 INFO - 'tests': ['tsvgm']}}, 08:43:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:43:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:43:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:43:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:43:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:43:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:43:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:43:11 INFO - 'talos_options': ['--disable-e10s'], 08:43:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:43:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:43:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:43:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:43:11 INFO - 'talos_options': ['--disable-e10s'], 08:43:11 INFO - 'tests': ['damp', 'tps']}, 08:43:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:43:11 INFO - 'tests': ['damp', 'tps']}, 08:43:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:43:11 INFO - 'tests': ['dromaeo_dom']}, 08:43:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:43:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:43:11 INFO - 'tests': ['basic_compositor_video']}, 08:43:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:43:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:43:11 INFO - 'tests': ['a11yr', 08:43:11 INFO - 'ts_paint', 08:43:11 INFO - 'tpaint', 08:43:11 INFO - 'sessionrestore', 08:43:11 INFO - 'sessionrestore_no_auto_restore', 08:43:11 INFO - 'tabpaint']}, 08:43:11 INFO - 'other-e10s': {'tests': ['a11yr', 08:43:11 INFO - 'ts_paint', 08:43:11 INFO - 'tpaint', 08:43:11 INFO - 'sessionrestore', 08:43:11 INFO - 'sessionrestore_no_auto_restore', 08:43:11 INFO - 'tabpaint']}, 08:43:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:43:11 INFO - 'ts_paint', 08:43:11 INFO - 'tpaint', 08:43:11 INFO - 'sessionrestore', 08:43:11 INFO - 'sessionrestore_no_auto_restore', 08:43:11 INFO - 'tabpaint']}, 08:43:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:43:11 INFO - 'ts_paint', 08:43:11 INFO - 'tpaint', 08:43:11 INFO - 'sessionrestore', 08:43:11 INFO - 'sessionrestore_no_auto_restore', 08:43:11 INFO - 'tabpaint']}, 08:43:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:43:11 INFO - 'tests': ['a11yr', 08:43:11 INFO - 'ts_paint', 08:43:11 INFO - 'tpaint', 08:43:11 INFO - 'sessionrestore', 08:43:11 INFO - 'sessionrestore_no_auto_restore', 08:43:11 INFO - 'tabpaint']}, 08:43:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:43:11 INFO - 'tests': ['a11yr', 08:43:11 INFO - 'ts_paint', 08:43:11 INFO - 'tpaint', 08:43:11 INFO - 'sessionrestore', 08:43:11 INFO - 'sessionrestore_no_auto_restore', 08:43:11 INFO - 'tabpaint']}, 08:43:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:43:11 INFO - 'tests': ['tsvgx', 08:43:11 INFO - 'tsvgr_opacity', 08:43:11 INFO - 'tart', 08:43:11 INFO - 'tscrollx', 08:43:11 INFO - 'cart', 08:43:11 INFO - 'tsvg_static']}, 08:43:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:43:11 INFO - 'tsvgr_opacity', 08:43:11 INFO - 'tart', 08:43:11 INFO - 'tscrollx', 08:43:11 INFO - 'cart', 08:43:11 INFO - 'tsvg_static']}, 08:43:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:43:11 INFO - 'talos_options': ['--disable-e10s'], 08:43:11 INFO - 'tests': ['tp5o']}, 08:43:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:43:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:43:11 INFO - 'talos_options': ['--disable-e10s', 08:43:11 INFO - '--xperf_path', 08:43:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:43:11 INFO - 'tests': ['tp5n']}, 08:43:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:43:11 INFO - 'talos_options': ['--xperf_path', 08:43:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:43:11 INFO - 'tests': ['tp5n']}}, 08:43:11 INFO - 'talos.zip': {'path': '', 08:43:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:43:11 INFO - Running post-action listener: _resource_record_post_action 08:43:11 INFO - [mozharness: 2017-03-15 15:43:11.837769Z] Finished populate-webroot step (success) 08:43:11 INFO - [mozharness: 2017-03-15 15:43:11.837860Z] Running create-virtualenv step. 08:43:11 INFO - Running pre-action listener: _resource_record_pre_action 08:43:11 INFO - Running main action method: create_virtualenv 08:43:11 INFO - Creating virtualenv /builds/slave/test/build/venv 08:43:11 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 08:43:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:43:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:43:11 INFO - Using real prefix '/usr' 08:43:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:43:12 INFO - Installing distribute.............................................................................................................................................................................................done. 08:43:14 INFO - Installing pip.................done. 08:43:14 INFO - Return code: 0 08:43:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:43:14 INFO - Reading from file tmpfile_stdout 08:43:14 INFO - Output received: 08:43:14 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) 08:43:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1602290>, '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 0x1602b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1603040>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931', '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 08:43:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:43:14 INFO - Using env: {'DISPLAY': ':0', 08:43:14 INFO - 'HOME': '/home/cltbld', 08:43:14 INFO - 'LANG': 'en_US.UTF-8', 08:43:14 INFO - 'LANGUAGE': 'en_US:en', 08:43:14 INFO - 'LOGNAME': 'cltbld', 08:43:14 INFO - 'MAIL': '/var/mail/cltbld', 08:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:14 INFO - 'MOZ_NO_REMOTE': '1', 08:43:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:14 INFO - 'NO_EM_RESTART': '1', 08:43:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:14 INFO - 'PWD': '/builds/slave/test', 08:43:14 INFO - 'SHELL': '/bin/bash', 08:43:14 INFO - 'SHLVL': '1', 08:43:14 INFO - 'TERM': 'linux', 08:43:14 INFO - 'TMOUT': '86400', 08:43:14 INFO - 'USER': 'cltbld', 08:43:14 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931', 08:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:14 INFO - '_': '/tools/buildbot/bin/python'} 08:43:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:14 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 08:43:14 INFO - Cleaning up... 08:43:14 INFO - Return code: 0 08:43:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1602290>, '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 0x1602b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1603040>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931', '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 08:43:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:43:14 INFO - Using env: {'DISPLAY': ':0', 08:43:14 INFO - 'HOME': '/home/cltbld', 08:43:14 INFO - 'LANG': 'en_US.UTF-8', 08:43:14 INFO - 'LANGUAGE': 'en_US:en', 08:43:14 INFO - 'LOGNAME': 'cltbld', 08:43:14 INFO - 'MAIL': '/var/mail/cltbld', 08:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:14 INFO - 'MOZ_NO_REMOTE': '1', 08:43:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:14 INFO - 'NO_EM_RESTART': '1', 08:43:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:14 INFO - 'PWD': '/builds/slave/test', 08:43:14 INFO - 'SHELL': '/bin/bash', 08:43:14 INFO - 'SHLVL': '1', 08:43:14 INFO - 'TERM': 'linux', 08:43:14 INFO - 'TMOUT': '86400', 08:43:14 INFO - 'USER': 'cltbld', 08:43:14 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931', 08:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:14 INFO - '_': '/tools/buildbot/bin/python'} 08:43:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:15 INFO - Downloading/unpacking psutil>=3.1.1 08:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:43:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:43:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:43:17 INFO - Installing collected packages: psutil 08:43:17 INFO - Running setup.py install for psutil 08:43:17 INFO - building 'psutil._psutil_linux' extension 08:43:17 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 08:43:17 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 08:43:17 INFO - building 'psutil._psutil_posix' extension 08:43:17 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 08:43:17 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 08:43:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:43:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:43:17 INFO - Successfully installed psutil 08:43:17 INFO - Cleaning up... 08:43:17 INFO - Return code: 0 08:43:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1602290>, '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 0x1602b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1603040>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931', '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 08:43:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:43:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:43:17 INFO - Using env: {'DISPLAY': ':0', 08:43:17 INFO - 'HOME': '/home/cltbld', 08:43:17 INFO - 'LANG': 'en_US.UTF-8', 08:43:17 INFO - 'LANGUAGE': 'en_US:en', 08:43:17 INFO - 'LOGNAME': 'cltbld', 08:43:17 INFO - 'MAIL': '/var/mail/cltbld', 08:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:17 INFO - 'MOZ_NO_REMOTE': '1', 08:43:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:17 INFO - 'NO_EM_RESTART': '1', 08:43:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:17 INFO - 'PWD': '/builds/slave/test', 08:43:17 INFO - 'SHELL': '/bin/bash', 08:43:17 INFO - 'SHLVL': '1', 08:43:17 INFO - 'TERM': 'linux', 08:43:17 INFO - 'TMOUT': '86400', 08:43:17 INFO - 'USER': 'cltbld', 08:43:17 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931', 08:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:17 INFO - '_': '/tools/buildbot/bin/python'} 08:43:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:43:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:43:20 INFO - Installing collected packages: mozsystemmonitor 08:43:20 INFO - Running setup.py install for mozsystemmonitor 08:43:20 INFO - Successfully installed mozsystemmonitor 08:43:20 INFO - Cleaning up... 08:43:20 INFO - Return code: 0 08:43:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:43:20 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')]} 08:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:20 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')]} 08:43:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:20 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 0x13671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1602290>, '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 0x1602b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1603040>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931', '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 08:43:20 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 08:43:20 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 08:43:20 INFO - Using env: {'DISPLAY': ':0', 08:43:20 INFO - 'HOME': '/home/cltbld', 08:43:20 INFO - 'LANG': 'en_US.UTF-8', 08:43:20 INFO - 'LANGUAGE': 'en_US:en', 08:43:20 INFO - 'LOGNAME': 'cltbld', 08:43:20 INFO - 'MAIL': '/var/mail/cltbld', 08:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:20 INFO - 'MOZ_NO_REMOTE': '1', 08:43:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:20 INFO - 'NO_EM_RESTART': '1', 08:43:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:20 INFO - 'PWD': '/builds/slave/test', 08:43:20 INFO - 'SHELL': '/bin/bash', 08:43:20 INFO - 'SHLVL': '1', 08:43:20 INFO - 'TERM': 'linux', 08:43:20 INFO - 'TMOUT': '86400', 08:43:20 INFO - 'USER': 'cltbld', 08:43:20 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931', 08:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:20 INFO - '_': '/tools/buildbot/bin/python'} 08:43:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:20 INFO - Downloading/unpacking jsonschema==2.5.1 08:43:20 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 08:43:20 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 08:43:20 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 08:43:20 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 08:43:20 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 08:43:20 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 08:43:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:43:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:43:22 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 08:43:22 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 08:43:22 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 08:43:22 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 08:43:22 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 08:43:22 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 08:43:22 INFO - Downloading functools32-3.2.3-2.tar.gz 08:43:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:43:22 INFO - warning: no files found matching '*.txt' 08:43:22 INFO - no previously-included directories found matching 'build' 08:43:22 INFO - no previously-included directories found matching 'dist' 08:43:22 INFO - no previously-included directories found matching '.git*' 08:43:22 INFO - Installing collected packages: jsonschema, functools32 08:43:22 INFO - Running setup.py install for functools32 08:43:22 INFO - warning: no files found matching '*.txt' 08:43:22 INFO - no previously-included directories found matching 'build' 08:43:22 INFO - no previously-included directories found matching 'dist' 08:43:22 INFO - no previously-included directories found matching '.git*' 08:43:22 INFO - Successfully installed jsonschema functools32 08:43:22 INFO - Cleaning up... 08:43:22 INFO - Return code: 0 08:43:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:43:22 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')]} 08:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:22 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')]} 08:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:22 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 0x13671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1602290>, '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 0x1602b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1603040>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931', '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 08:43:23 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 08:43:23 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 08:43:23 INFO - Using env: {'DISPLAY': ':0', 08:43:23 INFO - 'HOME': '/home/cltbld', 08:43:23 INFO - 'LANG': 'en_US.UTF-8', 08:43:23 INFO - 'LANGUAGE': 'en_US:en', 08:43:23 INFO - 'LOGNAME': 'cltbld', 08:43:23 INFO - 'MAIL': '/var/mail/cltbld', 08:43:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:23 INFO - 'MOZ_NO_REMOTE': '1', 08:43:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:23 INFO - 'NO_EM_RESTART': '1', 08:43:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:23 INFO - 'PWD': '/builds/slave/test', 08:43:23 INFO - 'SHELL': '/bin/bash', 08:43:23 INFO - 'SHLVL': '1', 08:43:23 INFO - 'TERM': 'linux', 08:43:23 INFO - 'TMOUT': '86400', 08:43:23 INFO - 'USER': 'cltbld', 08:43:23 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931', 08:43:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:23 INFO - '_': '/tools/buildbot/bin/python'} 08:43:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:43:23 INFO - Cleaning up... 08:43:23 INFO - Return code: 0 08:43:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:43:23 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')]} 08:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:23 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')]} 08:43:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:23 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 0x13671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1602290>, '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 0x1602b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1603040>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931', '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 08:43:23 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 08:43:23 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 08:43:23 INFO - Using env: {'DISPLAY': ':0', 08:43:23 INFO - 'HOME': '/home/cltbld', 08:43:23 INFO - 'LANG': 'en_US.UTF-8', 08:43:23 INFO - 'LANGUAGE': 'en_US:en', 08:43:23 INFO - 'LOGNAME': 'cltbld', 08:43:23 INFO - 'MAIL': '/var/mail/cltbld', 08:43:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:23 INFO - 'MOZ_NO_REMOTE': '1', 08:43:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:23 INFO - 'NO_EM_RESTART': '1', 08:43:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:23 INFO - 'PWD': '/builds/slave/test', 08:43:23 INFO - 'SHELL': '/bin/bash', 08:43:23 INFO - 'SHLVL': '1', 08:43:23 INFO - 'TERM': 'linux', 08:43:23 INFO - 'TMOUT': '86400', 08:43:23 INFO - 'USER': 'cltbld', 08:43:23 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931', 08:43:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:23 INFO - '_': '/tools/buildbot/bin/python'} 08:43:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:23 INFO - Downloading/unpacking blobuploader==1.2.4 08:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:25 INFO - Downloading blobuploader-1.2.4.tar.gz 08:43:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:43:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:43:25 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 08:43:25 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 08:43:25 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 08:43:25 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 08:43:25 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 08:43:25 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 08:43:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:43:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:43:25 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 08:43:25 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 08:43:25 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 08:43:25 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 08:43:25 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 08:43:25 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 08:43:26 INFO - Downloading docopt-0.6.1.tar.gz 08:43:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:43:26 INFO - Installing collected packages: blobuploader, requests, docopt 08:43:26 INFO - Running setup.py install for blobuploader 08:43:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:43:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:43:26 INFO - Running setup.py install for requests 08:43:26 INFO - Running setup.py install for docopt 08:43:26 INFO - Successfully installed blobuploader requests docopt 08:43:26 INFO - Cleaning up... 08:43:26 INFO - Return code: 0 08:43:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:26 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 0x13671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1602290>, '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 0x1602b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1603040>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931', '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 08:43:26 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 08:43:26 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 08:43:26 INFO - Using env: {'DISPLAY': ':0', 08:43:26 INFO - 'HOME': '/home/cltbld', 08:43:26 INFO - 'LANG': 'en_US.UTF-8', 08:43:26 INFO - 'LANGUAGE': 'en_US:en', 08:43:26 INFO - 'LOGNAME': 'cltbld', 08:43:26 INFO - 'MAIL': '/var/mail/cltbld', 08:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:26 INFO - 'MOZ_NO_REMOTE': '1', 08:43:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:26 INFO - 'NO_EM_RESTART': '1', 08:43:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:26 INFO - 'PWD': '/builds/slave/test', 08:43:26 INFO - 'SHELL': '/bin/bash', 08:43:26 INFO - 'SHLVL': '1', 08:43:26 INFO - 'TERM': 'linux', 08:43:26 INFO - 'TMOUT': '86400', 08:43:26 INFO - 'USER': 'cltbld', 08:43:26 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931', 08:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:26 INFO - '_': '/tools/buildbot/bin/python'} 08:43:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:43:27 INFO - Running setup.py (path:/tmp/pip-QSXDQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:43:27 INFO - Running setup.py (path:/tmp/pip-ECfqcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:43:27 INFO - Running setup.py (path:/tmp/pip-Go_dUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:43:27 INFO - Running setup.py (path:/tmp/pip-aDwMLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:43:27 INFO - Running setup.py (path:/tmp/pip-wKgMXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:43:27 INFO - Running setup.py (path:/tmp/pip-GKjFEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:43:27 INFO - Running setup.py (path:/tmp/pip-c7sKXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:43:27 INFO - Running setup.py (path:/tmp/pip-JvmjRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:43:27 INFO - Running setup.py (path:/tmp/pip-Jcgwf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:43:27 INFO - Running setup.py (path:/tmp/pip-HfSApQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:43:27 INFO - Running setup.py (path:/tmp/pip-Pki1U3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:43:27 INFO - Running setup.py (path:/tmp/pip-pyupmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:43:27 INFO - Running setup.py (path:/tmp/pip-8f4SDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:43:28 INFO - Running setup.py (path:/tmp/pip-e87q7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:28 INFO - Running setup.py (path:/tmp/pip-ubtlJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:43:28 INFO - Running setup.py (path:/tmp/pip-NoQefL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:43:28 INFO - Running setup.py (path:/tmp/pip-w_CNJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:43:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:43:28 INFO - Running setup.py install for manifestparser 08:43:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:43:28 INFO - Running setup.py install for mozcrash 08:43:28 INFO - Running setup.py install for mozdebug 08:43:28 INFO - Running setup.py install for mozdevice 08:43:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:43:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:43:28 INFO - Running setup.py install for mozfile 08:43:28 INFO - Running setup.py install for mozhttpd 08:43:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:43:28 INFO - Running setup.py install for mozinfo 08:43:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:43:29 INFO - Running setup.py install for mozInstall 08:43:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:43:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:43:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:43:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:43:29 INFO - Running setup.py install for mozleak 08:43:29 INFO - Running setup.py install for mozlog 08:43:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:43:29 INFO - Running setup.py install for moznetwork 08:43:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:43:29 INFO - Running setup.py install for mozprocess 08:43:29 INFO - Running setup.py install for mozprofile 08:43:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:43:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:43:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:43:29 INFO - Running setup.py install for mozrunner 08:43:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:43:29 INFO - Running setup.py install for mozscreenshot 08:43:29 INFO - Running setup.py install for moztest 08:43:30 INFO - Running setup.py install for mozversion 08:43:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:43:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:43:30 INFO - Cleaning up... 08:43:30 INFO - Return code: 0 08:43:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:30 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')]} 08:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:30 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')]} 08:43:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:30 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 0x13671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1602290>, '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 0x1602b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1603040>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931', '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 08:43:30 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 08:43:30 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 08:43:30 INFO - Using env: {'DISPLAY': ':0', 08:43:30 INFO - 'HOME': '/home/cltbld', 08:43:30 INFO - 'LANG': 'en_US.UTF-8', 08:43:30 INFO - 'LANGUAGE': 'en_US:en', 08:43:30 INFO - 'LOGNAME': 'cltbld', 08:43:30 INFO - 'MAIL': '/var/mail/cltbld', 08:43:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:30 INFO - 'MOZ_NO_REMOTE': '1', 08:43:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:30 INFO - 'NO_EM_RESTART': '1', 08:43:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:30 INFO - 'PWD': '/builds/slave/test', 08:43:30 INFO - 'SHELL': '/bin/bash', 08:43:30 INFO - 'SHLVL': '1', 08:43:30 INFO - 'TERM': 'linux', 08:43:30 INFO - 'TMOUT': '86400', 08:43:30 INFO - 'USER': 'cltbld', 08:43:30 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931', 08:43:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:30 INFO - '_': '/tools/buildbot/bin/python'} 08:43:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:43:30 INFO - Running setup.py (path:/tmp/pip-wxes0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:43:30 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)) 08:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:43:30 INFO - Running setup.py (path:/tmp/pip-_jsVk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:43:30 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)) 08:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:43:30 INFO - Running setup.py (path:/tmp/pip-j8srk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:43:30 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)) 08:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:43:30 INFO - Running setup.py (path:/tmp/pip-rwOAHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:43:30 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)) 08:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:43:30 INFO - Running setup.py (path:/tmp/pip-XBMCFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:43:30 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)) 08:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:43:30 INFO - Running setup.py (path:/tmp/pip-EmCNJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:43:30 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)) 08:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:43:30 INFO - Running setup.py (path:/tmp/pip-hXxNMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:43:30 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)) 08:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:43:30 INFO - Running setup.py (path:/tmp/pip-_5cE4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:43:30 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)) 08:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:43:30 INFO - Running setup.py (path:/tmp/pip-udIUzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:43:31 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)) 08:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:43:31 INFO - Running setup.py (path:/tmp/pip-HaGgt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:43:31 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)) 08:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:43:31 INFO - Running setup.py (path:/tmp/pip-QMtTE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:43:31 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)) 08:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:43:31 INFO - Running setup.py (path:/tmp/pip-3PZctL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:43:31 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)) 08:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:43:31 INFO - Running setup.py (path:/tmp/pip-xKcfX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:43:31 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)) 08:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:43:31 INFO - Running setup.py (path:/tmp/pip-OC1pNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:43:31 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)) 08:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:31 INFO - Running setup.py (path:/tmp/pip-_hZ7L4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:31 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)) 08:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:43:31 INFO - Running setup.py (path:/tmp/pip-IXIE57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:43:31 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)) 08:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:43:31 INFO - Running setup.py (path:/tmp/pip-sxApdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:43:31 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)) 08:43:31 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)) 08:43:31 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)) 08:43:31 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)) 08:43:31 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)) 08:43:31 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)) 08:43:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:43:31 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 08:43:31 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 08:43:31 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 08:43:31 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 08:43:31 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 08:43:31 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 08:43:33 INFO - Downloading blessings-1.6.tar.gz 08:43:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:43:33 INFO - Installing collected packages: blessings 08:43:33 INFO - Running setup.py install for blessings 08:43:33 INFO - Successfully installed blessings 08:43:33 INFO - Cleaning up... 08:43:33 INFO - Return code: 0 08:43:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:43:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:43:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:43:34 INFO - Reading from file tmpfile_stdout 08:43:34 INFO - Current package versions: 08:43:34 INFO - argparse == 1.2.1 08:43:34 INFO - blessings == 1.6 08:43:34 INFO - blobuploader == 1.2.4 08:43:34 INFO - docopt == 0.6.1 08:43:34 INFO - functools32 == 3.2.3-2 08:43:34 INFO - jsonschema == 2.5.1 08:43:34 INFO - manifestparser == 1.1 08:43:34 INFO - mozInstall == 1.12 08:43:34 INFO - mozcrash == 1.0 08:43:34 INFO - mozdebug == 0.1 08:43:34 INFO - mozdevice == 0.49 08:43:34 INFO - mozfile == 1.2 08:43:34 INFO - mozhttpd == 0.7 08:43:34 INFO - mozinfo == 0.9 08:43:34 INFO - mozleak == 0.1 08:43:34 INFO - mozlog == 3.4 08:43:34 INFO - moznetwork == 0.27 08:43:34 INFO - mozprocess == 0.25 08:43:34 INFO - mozprofile == 0.28 08:43:34 INFO - mozrunner == 6.13 08:43:34 INFO - mozscreenshot == 0.1 08:43:34 INFO - mozsystemmonitor == 0.3 08:43:34 INFO - moztest == 0.8 08:43:34 INFO - mozversion == 1.4 08:43:34 INFO - psutil == 3.1.1 08:43:34 INFO - requests == 1.2.3 08:43:34 INFO - wsgiref == 0.1.2 08:43:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:34 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')]} 08:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:34 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')]} 08:43:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:34 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 0x13671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1602290>, '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 0x1602b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1603040>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931', '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 08:43:34 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 08:43:34 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 08:43:34 INFO - Using env: {'DISPLAY': ':0', 08:43:34 INFO - 'HOME': '/home/cltbld', 08:43:34 INFO - 'LANG': 'en_US.UTF-8', 08:43:34 INFO - 'LANGUAGE': 'en_US:en', 08:43:34 INFO - 'LOGNAME': 'cltbld', 08:43:34 INFO - 'MAIL': '/var/mail/cltbld', 08:43:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:34 INFO - 'MOZ_NO_REMOTE': '1', 08:43:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:34 INFO - 'NO_EM_RESTART': '1', 08:43:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:34 INFO - 'PWD': '/builds/slave/test', 08:43:34 INFO - 'SHELL': '/bin/bash', 08:43:34 INFO - 'SHLVL': '1', 08:43:34 INFO - 'TERM': 'linux', 08:43:34 INFO - 'TMOUT': '86400', 08:43:34 INFO - 'USER': 'cltbld', 08:43:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931', 08:43:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:34 INFO - '_': '/tools/buildbot/bin/python'} 08:43:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:34 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)) 08:43:34 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)) 08:43:34 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)) 08:43:34 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)) 08:43:34 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)) 08:43:34 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)) 08:43:34 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)) 08:43:34 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)) 08:43:34 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)) 08:43:34 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)) 08:43:34 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)) 08:43:34 INFO - Cleaning up... 08:43:34 INFO - Return code: 0 08:43:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:43:34 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')]} 08:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:34 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')]} 08:43:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:34 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 0x13671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1602290>, '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 0x1602b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1603040>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931', '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 08:43:34 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 08:43:34 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 08:43:34 INFO - Using env: {'DISPLAY': ':0', 08:43:34 INFO - 'HOME': '/home/cltbld', 08:43:34 INFO - 'LANG': 'en_US.UTF-8', 08:43:34 INFO - 'LANGUAGE': 'en_US:en', 08:43:34 INFO - 'LOGNAME': 'cltbld', 08:43:34 INFO - 'MAIL': '/var/mail/cltbld', 08:43:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:34 INFO - 'MOZ_NO_REMOTE': '1', 08:43:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:34 INFO - 'NO_EM_RESTART': '1', 08:43:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:34 INFO - 'PWD': '/builds/slave/test', 08:43:34 INFO - 'SHELL': '/bin/bash', 08:43:34 INFO - 'SHLVL': '1', 08:43:34 INFO - 'TERM': 'linux', 08:43:34 INFO - 'TMOUT': '86400', 08:43:34 INFO - 'USER': 'cltbld', 08:43:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931', 08:43:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:34 INFO - '_': '/tools/buildbot/bin/python'} 08:43:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:43:34 INFO - Cleaning up... 08:43:34 INFO - Return code: 0 08:43:34 INFO - Running post-action listener: _resource_record_post_action 08:43:34 INFO - Running post-action listener: _start_resource_monitoring 08:43:34 INFO - Starting resource monitoring. 08:43:34 INFO - [mozharness: 2017-03-15 15:43:34.598628Z] Finished create-virtualenv step (success) 08:43:34 INFO - [mozharness: 2017-03-15 15:43:34.599101Z] Running install step. 08:43:34 INFO - Running pre-action listener: _resource_record_pre_action 08:43:34 INFO - Running main action method: install 08:43:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:43:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:43:34 INFO - Reading from file tmpfile_stdout 08:43:34 INFO - Detecting whether we're running mozinstall >=1.0... 08:43:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:43:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:43:34 INFO - Reading from file tmpfile_stdout 08:43:34 INFO - Output received: 08:43:34 INFO - Usage: mozinstall [options] installer 08:43:34 INFO - Options: 08:43:34 INFO - -h, --help show this help message and exit 08:43:34 INFO - -d DEST, --destination=DEST 08:43:34 INFO - Directory to install application into. [default: 08:43:34 INFO - "/builds/slave/test"] 08:43:34 INFO - --app=APP Application being installed. [default: firefox] 08:43:34 INFO - mkdir: /builds/slave/test/build/application 08:43:34 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'] 08:43:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:43:50 INFO - Reading from file tmpfile_stdout 08:43:50 INFO - Output received: 08:43:50 INFO - /builds/slave/test/build/application/firefox/firefox 08:43:50 INFO - Running post-action listener: _resource_record_post_action 08:43:50 INFO - [mozharness: 2017-03-15 15:43:50.336168Z] Finished install step (success) 08:43:50 INFO - [mozharness: 2017-03-15 15:43:50.336442Z] Running run-tests step. 08:43:50 INFO - Running pre-action listener: _resource_record_pre_action 08:43:50 INFO - Running main action method: run_tests 08:43:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:43:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:43:50 INFO - Python 2.7.3 08:43:50 INFO - Return code: 0 08:43:50 INFO - grabbing minidump binary from tooltool 08:43:50 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')]} 08:43:50 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 0x1602290>, '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 0x1602b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1603040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:43:50 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 08:43:50 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 08:43:50 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 08:43:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:43:50 INFO - Return code: 0 08:43:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:43:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:43:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:43:50 INFO - ENV: RUST_BACKTRACE is now 1 08:43:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:43:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:43:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 08:43:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 08:43:50 INFO - Using env: {'DISPLAY': ':0', 08:43:50 INFO - 'HOME': '/home/cltbld', 08:43:50 INFO - 'LANG': 'en_US.UTF-8', 08:43:50 INFO - 'LANGUAGE': 'en_US:en', 08:43:50 INFO - 'LOGNAME': 'cltbld', 08:43:50 INFO - 'MAIL': '/var/mail/cltbld', 08:43:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:43:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:50 INFO - 'MOZ_NO_REMOTE': '1', 08:43:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:43:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:50 INFO - 'NO_EM_RESTART': '1', 08:43:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:50 INFO - 'PWD': '/builds/slave/test', 08:43:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:43:50 INFO - 'RUST_BACKTRACE': '1', 08:43:50 INFO - 'SHELL': '/bin/bash', 08:43:50 INFO - 'SHLVL': '1', 08:43:50 INFO - 'TERM': 'linux', 08:43:50 INFO - 'TMOUT': '86400', 08:43:50 INFO - 'USER': 'cltbld', 08:43:50 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931', 08:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:50 INFO - '_': '/tools/buildbot/bin/python'} 08:43:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 08:43:50 INFO - mozversion application_buildid: 20170315151240 08:43:50 INFO - mozversion application_changeset: 8c89d1991786625a64d868798281610872a2bc26 08:43:50 INFO - mozversion application_display_name: Nightly 08:43:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:43:50 INFO - mozversion application_name: Firefox 08:43:50 INFO - mozversion application_remotingname: firefox 08:43:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:43:50 INFO - mozversion application_vendor: Mozilla 08:43:50 INFO - mozversion application_version: 55.0a1 08:43:50 INFO - mozversion platform_buildid: 20170315151240 08:43:50 INFO - mozversion platform_changeset: 8c89d1991786625a64d868798281610872a2bc26 08:43:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:43:50 INFO - mozversion platform_version: 55.0a1 08:43:50 INFO - using testdate: 1489592630 08:43:50 INFO - actual date: 1489592630 08:43:50 INFO - starting webserver on 'localhost:36912' 08:43:50 INFO - SUITE-START | Running 2 tests 08:43:50 INFO - TEST-START | dromaeo_css 08:43:50 INFO - operating with platform_type : linux_ 08:43:50 INFO - Initialising browser for dromaeo_css test... 08:43:50 INFO - TEST-INFO | started process 18660 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp00rCxR/profile http://localhost:36912/getInfo.html) 08:43:54 INFO - PID 18660 | __metrics Screen width/height:1600/1200 08:43:54 INFO - PID 18660 | colorDepth:24 08:43:54 INFO - PID 18660 | Browser inner width/height: 1024/697 08:43:54 INFO - PID 18660 | __metrics 08:43:56 INFO - PID 18660 | 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" 08:43:56 INFO - PID 18660 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:43:57 INFO - TEST-INFO | 18660: exit 0 08:43:57 INFO - Browser initialized. 08:43:57 INFO - Running cycle 1/1 for dromaeo_css test... 08:43:57 INFO - TEST-INFO | started process 18752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp00rCxR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:44:09 INFO - PID 18752 | RSS: Main: 153870336 08:44:09 INFO - PID 18752 | 08:47:15 INFO - PID 18752 | Cycle 1(1): loaded http://localhost:36912/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36912/tests/dromaeo/cssquery-ext.html) 08:47:16 INFO - PID 18752 | RSS: Main: 279715840 08:47:16 INFO - PID 18752 | 08:48:59 INFO - PID 18752 | ************************* 08:48:59 INFO - PID 18752 | A coding exception was thrown and uncaught in a Task. 08:48:59 INFO - PID 18752 | 08:48:59 ERROR - PID 18752 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:48:59 INFO - PID 18752 | Full stack: 08:48:59 INFO - PID 18752 | ************************* 08:50:19 INFO - PID 18752 | Cycle 1(1): loaded http://localhost:36912/tests/dromaeo/cssquery-ext.html (next: http://localhost:36912/tests/dromaeo/cssquery-jquery.html) 08:50:19 INFO - PID 18752 | RSS: Main: 235347968 08:50:19 INFO - PID 18752 | 08:53:22 INFO - PID 18752 | Cycle 1(1): loaded http://localhost:36912/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36912/tests/dromaeo/cssquery-mootools.html) 08:53:22 INFO - PID 18752 | RSS: Main: 180031488 08:53:22 INFO - PID 18752 | 08:56:25 INFO - PID 18752 | Cycle 1(1): loaded http://localhost:36912/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36912/tests/dromaeo/cssquery-prototype.html) 08:56:25 INFO - PID 18752 | RSS: Main: 205008896 08:56:25 INFO - PID 18752 | 08:59:29 INFO - PID 18752 | Cycle 1(1): loaded http://localhost:36912/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36912/tests/dromaeo/cssquery-yui.html) 08:59:29 INFO - PID 18752 | RSS: Main: 182480896 08:59:29 INFO - PID 18752 | 09:02:32 INFO - PID 18752 | Cycle 1(1): loaded http://localhost:36912/tests/dromaeo/cssquery-yui.html (next: http://localhost:36912/tests/dromaeo/cssquery-dojo.html) 09:02:32 INFO - PID 18752 | RSS: Main: 271888384 09:02:32 INFO - PID 18752 | 09:02:32 INFO - PID 18752 | __start_tp_report 09:02:32 INFO - PID 18752 | _x_x_mozilla_page_load 09:02:32 INFO - PID 18752 | _x_x_mozilla_page_load_details 09:02:32 INFO - PID 18752 | |i|pagename|runs| 09:02:32 INFO - PID 18752 | |0;dojo.html;2553.93615159621;2573.292344605234;2573.8455692658454;2588.2235329401174;2626.277773612257;4864.14877396456;4870.074685809694;4921.9015619687625;4929.8028078876805;4984.850454486371;4880.591310045614;4933.358663373757;4948.480409556999;4965.900681986367;4988.052270068693;4313.374560688699;4446.088551846871;4576.153411618861;4625.074985002996;4645.814167433316;4537.682362234645;4578.862634120982;4621.838235661752;4630.884227894296;4672.462666793312;4349.151915376503;4422.778861056967;4426.136903303857;4437.667174961858;4539.16025535277;4420.425344705168;4434.11317736454;4445.711028783151;4446.444194475691;4449.710768800018;4373.190959672471;4388.912221755579;4389.122175564868;4396.582324679182;4402.119576084796;4800.831970881002;4811.037792441526;4817.927731084036;4820.30105634681;4822.348982887301;5241.842744717665;5244.606654500928;5246.816361427332;5247.816326428595;5247.921281180786;5233.528982391603;5304.310439642861;5348.759305831247;5403.78384864605;5417.349918009824;4932.7286999215385;4956.653034287601;4962.60299176065;4977.9751101244265;4981.32752078472;5257.474252574789;5461.42655021225;5463.153211252262;5471.863203419866;5473.67157970523;5069.264956581349;5081.441041485434;5186.429492755794;5232.03207406631;5257.526822585909;5284.762185701653;5285.656432331886;5286.471352864683;5286.550643195372;5302.469753024744;5244.082285600005;5262.500062494057;5268.6575372600655;5273.393559740679;5326.014687282865;5159.561437277874;5196.53231209193;5197.7401129943355;5242.842714718565;5278.683279003272;4492.550744925481;4492.550744925481;4497.235469970113;4524.04994951064;4536.455625324982;3825.732198746061;3832.789196594214;3835.846566137379;3864.71014673895;3865.8453661853773;4428.202923473741;4507.594316511464;4576.794044268016;4585.312203169551;4633.930491042637;5279.9208011879855;5306.442823503554;5345.33183352081;5345.786168553214;5351.625386222927;4529.365888775574;4548.044910568751;4549.226631472658;4551.112533056023;4588.977055114703;4627.62978961689;4750.619950404029;4758.762061896891;4765.666403351802;4818.060478206786;4871.537203965618;4885.609151267961;4969.527894849984;4975.0547395994645;4983.277424773315;5308.442613525679;5317.494837990384;5320.17537281722;5321.308229930084;5352.571794256528;4929;4969.304297398295;4978.27814966835;4981.676191047571;5028.296038554532;5056.797728090835;5121.8719532012;5176.223566465061;5231.267622532924;5237.554807841224;5360.597955153301;5364.839054828361;5372.865678358073;5380.730963451733;5420.051490988983;5029.44676085623;5078.542931136068;5079.3650793650795;5193.221016847503;5222.529972302511;5040.672356296829;5072.365954255718;5085.720285384339;5088.0587091388215;5093.974530127326;4963.454020057863;5009.624278179078;5018.824341148043;5021.196608542616;5023.296738456692;5105.770240339268;5161.122609156528;5185.248139019896;5203.115470370122;5217.973910130425;4878.731669758197;4950.504949505021;5022.221555658879;5033.697978121324;5038.949610503848 09:02:32 INFO - PID 18752 | |1;ext.html;626.564537646336;681.9352161544653;697.6511744127936;738.2764890407401;745.2212438002288;25400.872995635018;31025.844870775643;31617.525737113905;31655.20861978446;31720.841395793017;33529;34092.488612670764;34124.658753412456;34131.65868341316;34146;5145.151050076743;5285.445028272034;5286.127788914843;5289.523942845143;6601.2408573014;6656.768497827918;8864;9106.089391060907;9110.954445227764;9113.453192808453;9433.95283023584;9524.238060955107;9535.570899309512;9540.666076687317;9549.904500954972;9388.108129727665;9463.337566370288;9466.19537339327;9483.430994140304;9484.288678349083;9155.404898681565;9224;9231.492267925261;9232.215261702764;9239.769005774842;34417.311653767036;34717.47923781145;34808;34843.477347839806;34862.12844678878;3392.1858753899132;3417.829108544563;3428.9828550857087;3468.8959331220103;3480.164760457472;24293.028278869002;24384.390390240387;24480.755192448203;24576.262712118485;24951.251462456155;3070.8157510549213;3127.4758358421964;3133.6552979172275;3167.8732850685947;3273.6398996110647;145669;147334;147480;147577.52422475745;148111.25944370317;41664.166716665495;41954.79022604867;41969.37045944313;42077.579224207366;42123;47961.5203847957;48149.51850481451;48175;48306.27540586894;48351.75824120857;12148.5140594377;12239.632811015685;12277.754444911052;12282.815757763641;12293.385330733428;8838;9031.729048128567;9594.520273986273;9651.469169195761;9659.034096590285;12848.421821018077;12966.935165324114;13075.215487070805;13103;13115.737685246242;5305.469453054741;5519.558435325164;5521.917171242435;5534.363548192009;5685.431456854281;797.7487091566138;831.1563762780783;832.2094010689868;833.0378412933072;851.8040850604395;22128.33614991553;22846.8857655714;22951;22978.540429191322;23235;887.8401887660283;890.4390234152443;891.6522556203086;898.1916275352105;903.9005709371963;11900.583479578174;11928.46321915516;12229.327386993622;12325.69185770345;12337;240652;243015;243111;243126;243420;31000.379992400027;31537.8423107883;36193.63806361955;36829.63170368315;36990;1201.006407988351;1215.167610187007;1216.8600610929857;1224.797908345113;1225.993870030644;21831.126754929624;22114.336569902927;23084.076636935006;24697.87651061733;24740.876295618407;34045;34109.82945085259;34117.31765364728;34187.4871876927;34192.31615367728;181359;183463;183531;183668;183843;29150.562741558468;29424.705752942198;29695;29715.702842972158;29794.70205298006;34846;35019;35413.82293088518;36177;36178.63821361858;29287.41425171442;29931.70068299289;31471.21321966969;31519.84240078785;31540.36919261648;30248.243793905327;30380.24049398783;30436.934707285138;30576.235594110327;31788;29578.408431830812;30134.2466438332;30436.391272174875;30550;30985.53521697131;25988.090416836076;27072.72927270702;27283.86358068197;27435.86282068577;27674.44651106926;20969.685454718496;21466.463338416663;22400.663990039837;22436.439089022904;22446.949436376686 09:02:32 INFO - PID 18752 | |2;jquery.html;367.79587329032375;392.80978634736755;412.6348181859055;423.7499875073707;424.5181718749221;11869.169158158933;13658.521951731691;17969.7304540432;18072.277108915627;18358.54103647408;17466.825331746677;17626.383076592323;18097.4570762877;18286.817131828677;18297.99361035146;4723.62211023119;4866.878328041809;4870.220764677652;4870.829520966767;4872.780724867372;4706.788194531255;4790.42514898211;4931.482194369593;4955.405351357824;4961.181405068178;4960.7767650455635;4962.975185124069;4966.329545511346;4969.055879382924;4970.577500912426;4924.753762311888;4959.082569724595;6337.683115844189;6647.069410282565;6683.7660681875905;6288.968555157241;6511.479081673502;6516.446102081329;6517.4786017118995;6519.771807986745;21183.763247350438;21520.89239553792;21695;22077.116915323368;22178.667319990214;2302.7236731592316;2360.7403185649564;2394.928152155438;2431.5866302728577;2442.6213936839818;13178.275194864278;13389.397477113553;13649;13959.930200349036;14429;1705.84647381735;1759.8856074355126;1797.2271923073074;1799.62222806122;1799.8830076045015;86117.56941215254;86595.56702216575;86658.5667071667;88835;89814;15315.92342038305;15571.454999074978;15647.530574082795;16093.436729714404;16159.192040397933;27926.441471170463;27961.16116516508;27961.860190699324;28013.859930700215;28108.43783124367;8565.614547345385;8648.43785153963;8651.005134409623;8790.42862213954;8918.241949434241;7086.92913070873;7142.392896603743;7321.78034658961;7348.448866335047;7363.48455608113;8350.958245208856;8417.92745647834;8735.737927862174;8804.163604457694;8884.244839188612;3161.743797983633;3237.271613886857;3284.523744057098;3516.0330908999717;3606.549181352331;722.266899097406;770.9961450192714;773.2074623510833;773.9226077392216;779.7972527142983;18085.36701215451;18098.46163076127;18638.90680546616;18788;18959.241630334633;766.7239793674273;776.6466257852663;778.260652380241;780.3523075847033;787.2049230277461;9438.244940404751;10359.741006474898;11037.83443248352;11043.875183956403;11231.66305010851;520643;523682;527471;529618;538778;90809;93100;93893;96563;96755.51622241843;1075.8655168103987;1126.301692950376;1152.5505053029158;1160.640201537526;1165.9941700291613;16594.58513537171;16848.747268790732;17222.138893055548;17583.824161758217;17899.910500447935;41360;41550.376744349465;41683.7915810419;41924.37113443362;42163.36754948617;52729.472705272456;53252;53835;53852;55610.44389556053;10064.798704025732;10785.784284314113;10866.619668311887;10880.510377033212;11283.830742539032;12624;12807.679808004874;13025.674358141123;13041;13475.595732128051;9854.063863932915;10157.9492102539;10232;10546.103581195377;10812.729681758019;9953.850692239766;10832.5125369357;11052.834207486734;11084.057855082408;11104.833427498432;9881.258905582254;10696;10833.29583577065;11166.832497512381;11321.71695707614;11082.778344433227;11161.330320180816;11277;11313.886861131283;11408.885911140782;11071.50178241965;11140.721481963015;11484.598039068593;11615.186936914335;11635.941820290844 09:02:32 INFO - PID 18752 | |3;mootools.html;1406.465543093625;1423.5444657709534;1430.8569143085685;1436.3967133803808;1490.1878476230454;9064.456132632047;9386.765330866723;9448.95275523623;9458.432494050361;9459.337846350758;9248.121428464285;9251;9515.42907425555;9521.523923803818;9522.381045232056;2118.110393634673;2155.4503601581573;2155.5581105873257;2159.8920053997317;2174.0325555127974;1647.6045749020209;1700.3368686212386;2028.7971202879667;2068.5552606189667;2080.209520382253;2023.2918478532542;2072.243631074662;2074.678424844152;2082.6563617003176;2087.780783017784;2041.0407108659056;2055.3731112010832;2060.763012253595;2061.608294424062;2062.7215325931106;1643.761654560094;1697.6180359419157;2036.908339124743;2076.979230207709;2077.200277893022;9021.458712477272;9306.674266400643;9317.16145546904;9318.534073296376;9321.533923303876;4507.909841803145;4653.674242803005;4660.743659098748;4666.53334666534;4670.299455081731;2501.862397568133;2549.7195308516048;2625.0812215724536;2631.8947242110294;2635.143578337048;994.5673631970116;1001.4241810958728;1003.8193125237455;1030.3766221436;1058.7935352606246;12939.935300323532;13212.86787132126;13326.133801302884;13344.399502022432;13365.599032029055;3742.6818720408523;3843.461915331856;3911;3916.5691773904846;3926.9214615708097;10207.846882296772;10217.591296348211;10225.744356391;10226;10232.437215953194;4763.476017638126;4766.547178018082;4767.523247675204;4769.785359658755;4775.331453596499;4173.561776013475;4272.551382104896;4339.132173565299;4349.804258808361;4360.869173924787;3281.3273278977754;3303.9174020649193;3402.6427225141006;3404.2851001290005;3416.265502916885;757.8332766791297;765.2309429023907;771.9112302085332;777.7977725791335;785.2500861677084;791.9604019799102;806.766037849029;809.8218391953761;810.7324582887633;811.2820154163608;5435.021696094662;5613.775448982076;5738.225339579187;5757.337906140848;5852.180694702745;873.886394768676;879.5646155153112;885.2298500304776;897.8832751742232;926.6432423516994;3680.5215322008503;3691.557013158438;3710.888673339804;3726.459663348799;3755.7746535207975;9935.65225217114;10197.490125493696;11468.54125834974;11537.173392518718;11744.17790754656;11531.827022594667;11612.303261804318;11621.24461909973;11641.88358116408;11660.650180494598;8770;8994.28045756338;9034.186923176945;9037.367384283038;9045.864312035194;6059.0608455689435;6072.666003369857;6095.603785753912;6096.573239873166;6126.326104128453;10406.739831504274;10449.58201671955;10501.632442864464;10515.526801294112;10613.310134841211;10892.61875834342;10935.726606834893;11061.612843550438;11062.944685276843;11168.609098681507;7470.775876723707;7489.176190619137;7574.621268936641;7577.886331705139;7581.166071732216;9074.364794464589;9193.724188274362;9233.861492077489;9293.767655808388;9297.628094876129;7883.960580197292;7889.566073865993;7909.406794490551;7969.043714754266;8025;7773.922260777546;7817.179196184319;7896.526208427513;7956.045274567089;8057.234562716532;6911.930880691129;7051.224365319913;7052.858942821217;7061.435085193275;7062.505624606229;4978.9551375396695;5035.194368900959;5069.417017043087;5183.092958732283;5255.080360936744;4885.389326334208;4927.901441971212;5032.144535428913;5066.594672426123;5085.796568137381 09:02:32 INFO - PID 18752 | |4;prototype.html;372.5306114295988;377.5959723096287;378.3152493985884;381.0435806126623;384.1855266834312;5229.267902493654;5240.868978275545;5252.789888404459;5278.999999999995;5288.524032837044;4997.1760307487775;5118.309028281181;5153.1239689252825;5155.4586768389345;5167.974160129194;4294;4306.935395969047;4311.827526898928;4313.8058787354485;4329.372241025049;4337.327714204288;4342.109867477159;4350;4362.19299429605;4374.8906277343;4219.556946520617;4268.914621707564;4299.26912424887;4323.978380108095;4352.955290730218;4287;4297.226499230137;4301.440812694361;4325.74045557266;4327.653787696992;3979.5821438748803;3985.3822657488136;3994.3609022556543;4013.779242141681;4026.375911733686;4914.238293064581;5031.270465782478;5097.3118628984985;5117.488251174853;5125.487451254882;4962.305277261186;4967.279744437036;4986.326845875797;4999.375078115236;5012.298278241049;5484.2047903053835;5518.806841760559;5521.895620875841;5529.281193444866;5533.889322213533;4438.556144385568;4440.844570440051;4440.955590444087;4568.538067818299;4785.162596545625;5521.365043020064;5648.322201335866;5682.659040457585;5747.741351639186;5867.941320586782;4990.2764099205415;5003.3495645565845;5012.172991456442;5017.37282839645;5026.346574945233;5074.619403544675;5091.719955402415;5097.235414687826;5105.642605017613;5121.564667003347;4869.366982292279;4972.428170760409;5021.246812978009;5231.032259032091;5243.528082472596;5552.555795536347;5554.805581804618;5564.276644036249;5581.57669794208;5583.162525621108;1763.0831967376891;1783.8929664220188;1800.3698705452987;1804.1520485371855;1806;1425.465450456079;1426.2583456602715;1437.3891096284037;1439.9208043557705;1482.5107714454205;4757.762111894392;4776.23580227162;4779.498152693917;4781.258904869751;4788.545088216614;5651.039323315046;5653.236813030188;5658.519025882763;5680.841280313537;5703.600747947687;4601.217792975202;4763.833265835679;4780.1873681474235;4793.376861008116;4805.543473370024;2972.7770417218794;2997.2057404787747;3001.3397052648384;3003.459377312061;3003.474391981438;5261.158214685632;5269.445513573505;5269.627438439402;5292.126799078109;5294.629375943647;5573.331200255914;5734.340550836624;5778.468705792969;5789.45000224978;5790.768369265266;5262.394824595221;5268.417476116278;5272.31112132815;5275.683458992473;5282.392524859613;5486.259354987025;5662;5664.461876121762;5677.318721753416;5691.886162276648;5527.143292789624;5535.391106978149;5557.638753481011;5574.470425309589;5578.721063946868;5043.823466178666;5143.3570803649545;5181.844544663666;5288.127458969227;5297.576193904555;4974.477679843709;4977.427595826382;5001.324821149098;5006.448001119665;5017.720481277251;5480.479354461319;5651.519620832275;5721.310983837589;5735.942640573541;5737.56968227393;5491.258680078138;5498.642588231912;5505.559555235652;5519.503244707996;5531.446855314597;5337.066013447708;5430.294061771944;5434.157705555645;5441.374241962225;5463.121183959433;5142.794288228429;5392.865178370572;5407.594430417813;5421.972890135524;5425.267588875609;5546.195801608825;5565.860853478695;5567.777288908398;5570.693611851225;5582.106862901916;5387;5393.8921221574565;5415.377231618414;5421.484958928895;5428.348598168245 09:02:32 INFO - PID 18752 | |5;yui.html;675.7634827810264;684.7774473296179;686.3411125319693;710.7512370670263;730.466759265736;13268.137571057887;13795.379207935643;13805;13862.37619307131;13899.791503127448;14260.500882469116;14268.571942841705;14299.571012869605;14523.346449409775;14799.482018129367;830.2942498875967;847.7965288330787;858.8797568340437;859.2395729779159;859.6346552715071;817.9222973817477;843.8227972125861;849.3757088539918;857.3826844671827;862.5428522882883;878.8242351529688;882.8543290357084;883.7967267528472;883.8409086364452;884.6417201033591;871.0375035585713;871.9258862996653;877.0746862060523;879.336101243557;880.1462581296132;648.4552975500555;649.8115546491512;651.6709061923698;652.1326635574675;652.5758257132854;13934.442622295095;14024.509142180077;14237;14279.143251404948;14738.189399583125;13652.385642646006;14332.928335358361;14409.207493587848;14437.566872993826;14521.20133392663;10421.32261403014;10496.68509944703;10735.570577176904;10745.623903163352;10767;3260.396826587089;3273.9836300818583;3293.6212335581477;3335.4329763939945;3421.3328400961823;61053.38946610522;61536.38463615396;61613.6919315405;62348.68825655888;62712;10381.2214083944;10451.52077114541;10506.842397364046;10672.839907401396;10678.839817402744;21160.894195528923;21413.78586214118;21441;21619.783802162092;21707.131714731233;6544.378284063102;6634.601923884582;6755.7973260802255;6844.863102737917;6887.173539175331;3421.0934102462866;3475.2528206435736;3548.538689970287;3578.8926332210076;3601.657842504958;2776.3891943772337;2835.5463125899755;2847.757940575033;2848.245215018022;2853.1583182961076;510.72420892717514;525.332827309315;531.7500774635915;539.5872157799287;540.227474711159;591.2727345365225;614.5421660862686;632.1434456311723;638.7636574467384;644.7163248170883;8591.398602097917;8606.5696715164;9155.679551215808;9533.570989305497;9637.277204209713;583.1136672258228;600.5915977135502;608.2791891608458;608.948239399656;613.6256883301182;4372.6939114261695;4539.228331183706;4541.205289074399;4557.589816916494;4579.519150489217;48756.5124348752;50414.495855041714;51366.97266054658;61329.69335153296;62937.37062629407;39926.80036599799;40493.797531012155;41127;42036.57963420388;42390.36414453786;43557.34663980043;44184.558154418046;44857.775711121234;45241.773791130836;46148;9121.361504694607;9658;9675.758106047406;9686.321957463191;9753.366031207948;29633.407331853672;30273;31151.68848311488;31545.36909261848;31572;40548;40765.38851917164;41647.791761042216;42291.788541058326;42990.57009429866;11570.652880413601;11605;11690.532378704756;11936.462859171532;11964;11588.79809346234;11645.184837061324;11832;11851.585194518151;11927.701807454883;11863.34751588671;11972.461239244081;12036.75926481448;12129.090318226345;12326;10897.182711296842;11361.318320900773;11459.48432320531;11496.310221386744;11592.188546801981;11131.387773672202;11653.242539235262;11681.649550513499;11685.824712629488;12111.031117510402;9742.171915386987;9764.462954537285;10127.088562029452;10207.642732504326;10513.684589462327;8972.846516836044;9266.583003764712;9453.669121580711;10159.441230732085;10183.694489165337 09:02:32 INFO - PID 18752 | __end_tp_report 09:02:32 INFO - PID 18752 | __start_cc_report 09:02:32 INFO - PID 18752 | _x_x_mozilla_cycle_collect,1493 09:02:32 INFO - PID 18752 | __end_cc_report 09:02:32 INFO - PID 18752 | __startTimestamp1489593752911__endTimestamp 09:02:32 INFO - PID 18752 | 09:02:32 INFO - PID 18752 | ------- Summary: start ------- 09:02:32 INFO - PID 18752 | Number of tests: 6 09:02:32 INFO - PID 18752 | 09:02:32 INFO - PID 18752 | [#0] dojo.html Cycles:165 Average:4855.70 Median:4981.33 stddev:544.98 (10.9%) stddev-sans-first:515.87 09:02:32 INFO - PID 18752 | Values: 2553.9 2573.3 2573.8 2588.2 2626.3 4864.1 4870.1 4921.9 4929.8 4984.9 4880.6 4933.4 4948.5 4965.9 4988.1 4313.4 4446.1 4576.2 4625.1 4645.8 4537.7 4578.9 4621.8 4630.9 4672.5 4349.2 4422.8 4426.1 4437.7 4539.2 4420.4 4434.1 4445.7 4446.4 4449.7 4373.2 4388.9 4389.1 4396.6 4402.1 4800.8 4811.0 4817.9 4820.3 4822.3 5241.8 5244.6 5246.8 5247.8 5247.9 5233.5 5304.3 5348.8 5403.8 5417.3 4932.7 4956.7 4962.6 4978.0 4981.3 5257.5 5461.4 5463.2 5471.9 5473.7 5069.3 5081.4 5186.4 5232.0 5257.5 5284.8 5285.7 5286.5 5286.6 5302.5 5244.1 5262.5 5268.7 5273.4 5326.0 5159.6 5196.5 5197.7 5242.8 5278.7 4492.6 4492.6 4497.2 4524.0 4536.5 3825.7 3832.8 3835.8 3864.7 3865.8 4428.2 4507.6 4576.8 4585.3 4633.9 5279.9 5306.4 5345.3 5345.8 5351.6 4529.4 4548.0 4549.2 4551.1 4589.0 4627.6 4750.6 4758.8 4765.7 4818.1 4871.5 4885.6 4969.5 4975.1 4983.3 5308.4 5317.5 5320.2 5321.3 5352.6 4929.0 4969.3 4978.3 4981.7 5028.3 5056.8 5121.9 5176.2 5231.3 5237.6 5360.6 5364.8 5372.9 5380.7 5420.1 5029.4 5078.5 5079.4 5193.2 5222.5 5040.7 5072.4 5085.7 5088.1 5094.0 4963.5 5009.6 5018.8 5021.2 5023.3 5105.8 5161.1 5185.2 5203.1 5218.0 4878.7 4950.5 5022.2 5033.7 5038.9 09:02:32 INFO - PID 18752 | 09:02:32 INFO - PID 18752 | [#1] ext.html Cycles:180 Average:33672.87 Median:17530.82 stddev:50649.56 (288.9%) stddev-sans-first:50730.87 09:02:32 INFO - PID 18752 | Values: 626.6 681.9 697.7 738.3 745.2 25400.9 31025.8 31617.5 31655.2 31720.8 33529.0 34092.5 34124.7 34131.7 34146.0 5145.2 5285.4 5286.1 5289.5 6601.2 6656.8 8864.0 9106.1 9111.0 9113.5 9434.0 9524.2 9535.6 9540.7 9549.9 9388.1 9463.3 9466.2 9483.4 9484.3 9155.4 9224.0 9231.5 9232.2 9239.8 34417.3 34717.5 34808.0 34843.5 34862.1 3392.2 3417.8 3429.0 3468.9 3480.2 24293.0 24384.4 24480.8 24576.3 24951.3 3070.8 3127.5 3133.7 3167.9 3273.6 145669.0 147334.0 147480.0 147577.5 148111.3 41664.2 41954.8 41969.4 42077.6 42123.0 47961.5 48149.5 48175.0 48306.3 48351.8 12148.5 12239.6 12277.8 12282.8 12293.4 8838.0 9031.7 9594.5 9651.5 9659.0 12848.4 12966.9 13075.2 13103.0 13115.7 5305.5 5519.6 5521.9 5534.4 5685.4 797.7 831.2 832.2 833.0 851.8 22128.3 22846.9 22951.0 22978.5 23235.0 887.8 890.4 891.7 898.2 903.9 11900.6 11928.5 12229.3 12325.7 12337.0 240652.0 243015.0 243111.0 243126.0 243420.0 31000.4 31537.8 36193.6 36829.6 36990.0 1201.0 1215.2 1216.9 1224.8 1226.0 21831.1 22114.3 23084.1 24697.9 24740.9 34045.0 34109.8 34117.3 34187.5 34192.3 181359.0 183463.0 183531.0 183668.0 183843.0 29150.6 29424.7 29695.0 29715.7 29794.7 34846.0 35019.0 35413.8 36177.0 36178.6 29287.4 29931.7 31471.2 31519.8 31540.4 30248.2 30380.2 30436.9 30576.2 31788.0 29578.4 30134.2 30436.4 30550.0 30985.5 25988.1 27072.7 27283.9 27435.9 27674.4 20969.7 21466.5 22400.7 22436.4 22446.9 09:02:32 INFO - PID 18752 | 09:02:32 INFO - PID 18752 | [#2] jquery.html Cycles:180 Average:30709.75 Median:15635.09 stddev:86908.94 (555.9%) stddev-sans-first:87122.88 09:02:32 INFO - PID 18752 | Values: 367.8 392.8 412.6 423.7 424.5 11869.2 13658.5 17969.7 18072.3 18358.5 17466.8 17626.4 18097.5 18286.8 18298.0 4723.6 4866.9 4870.2 4870.8 4872.8 4706.8 4790.4 4931.5 4955.4 4961.2 4960.8 4963.0 4966.3 4969.1 4970.6 4924.8 4959.1 6337.7 6647.1 6683.8 6289.0 6511.5 6516.4 6517.5 6519.8 21183.8 21520.9 21695.0 22077.1 22178.7 2302.7 2360.7 2394.9 2431.6 2442.6 13178.3 13389.4 13649.0 13959.9 14429.0 1705.8 1759.9 1797.2 1799.6 1799.9 86117.6 86595.6 86658.6 88835.0 89814.0 15315.9 15571.5 15647.5 16093.4 16159.2 27926.4 27961.2 27961.9 28013.9 28108.4 8565.6 8648.4 8651.0 8790.4 8918.2 7086.9 7142.4 7321.8 7348.4 7363.5 8351.0 8417.9 8735.7 8804.2 8884.2 3161.7 3237.3 3284.5 3516.0 3606.5 722.3 771.0 773.2 773.9 779.8 18085.4 18098.5 18638.9 18788.0 18959.2 766.7 776.6 778.3 780.4 787.2 9438.2 10359.7 11037.8 11043.9 11231.7 520643.0 523682.0 527471.0 529618.0 538778.0 90809.0 93100.0 93893.0 96563.0 96755.5 1075.9 1126.3 1152.6 1160.6 1166.0 16594.6 16848.7 17222.1 17583.8 17899.9 41360.0 41550.4 41683.8 41924.4 42163.4 52729.5 53252.0 53835.0 53852.0 55610.4 10064.8 10785.8 10866.6 10880.5 11283.8 12624.0 12807.7 13025.7 13041.0 13475.6 9854.1 10157.9 10232.0 10546.1 10812.7 9953.9 10832.5 11052.8 11084.1 11104.8 9881.3 10696.0 10833.3 11166.8 11321.7 11082.8 11161.3 11277.0 11313.9 11408.9 11071.5 11140.7 11484.6 11615.2 11635.9 09:02:32 INFO - PID 18752 | 09:02:32 INFO - PID 18752 | [#3] mootools.html Cycles:180 Average:5786.66 Median:4663.64 stddev:3648.91 (78.2%) stddev-sans-first:3644.30 09:02:32 INFO - PID 18752 | Values: 1406.5 1423.5 1430.9 1436.4 1490.2 9064.5 9386.8 9449.0 9458.4 9459.3 9248.1 9251.0 9515.4 9521.5 9522.4 2118.1 2155.5 2155.6 2159.9 2174.0 1647.6 1700.3 2028.8 2068.6 2080.2 2023.3 2072.2 2074.7 2082.7 2087.8 2041.0 2055.4 2060.8 2061.6 2062.7 1643.8 1697.6 2036.9 2077.0 2077.2 9021.5 9306.7 9317.2 9318.5 9321.5 4507.9 4653.7 4660.7 4666.5 4670.3 2501.9 2549.7 2625.1 2631.9 2635.1 994.6 1001.4 1003.8 1030.4 1058.8 12939.9 13212.9 13326.1 13344.4 13365.6 3742.7 3843.5 3911.0 3916.6 3926.9 10207.8 10217.6 10225.7 10226.0 10232.4 4763.5 4766.5 4767.5 4769.8 4775.3 4173.6 4272.6 4339.1 4349.8 4360.9 3281.3 3303.9 3402.6 3404.3 3416.3 757.8 765.2 771.9 777.8 785.3 792.0 806.8 809.8 810.7 811.3 5435.0 5613.8 5738.2 5757.3 5852.2 873.9 879.6 885.2 897.9 926.6 3680.5 3691.6 3710.9 3726.5 3755.8 9935.7 10197.5 11468.5 11537.2 11744.2 11531.8 11612.3 11621.2 11641.9 11660.7 8770.0 8994.3 9034.2 9037.4 9045.9 6059.1 6072.7 6095.6 6096.6 6126.3 10406.7 10449.6 10501.6 10515.5 10613.3 10892.6 10935.7 11061.6 11062.9 11168.6 7470.8 7489.2 7574.6 7577.9 7581.2 9074.4 9193.7 9233.9 9293.8 9297.6 7884.0 7889.6 7909.4 7969.0 8025.0 7773.9 7817.2 7896.5 7956.0 8057.2 6911.9 7051.2 7052.9 7061.4 7062.5 4979.0 5035.2 5069.4 5183.1 5255.1 4885.4 4927.9 5032.1 5066.6 5085.8 09:02:32 INFO - PID 18752 | 09:02:32 INFO - PID 18752 | [#4] prototype.html Cycles:180 Average:4737.96 Median:5134.14 stddev:1225.05 (23.9%) stddev-sans-first:1183.86 09:02:32 INFO - PID 18752 | Values: 372.5 377.6 378.3 381.0 384.2 5229.3 5240.9 5252.8 5279.0 5288.5 4997.2 5118.3 5153.1 5155.5 5168.0 4294.0 4306.9 4311.8 4313.8 4329.4 4337.3 4342.1 4350.0 4362.2 4374.9 4219.6 4268.9 4299.3 4324.0 4353.0 4287.0 4297.2 4301.4 4325.7 4327.7 3979.6 3985.4 3994.4 4013.8 4026.4 4914.2 5031.3 5097.3 5117.5 5125.5 4962.3 4967.3 4986.3 4999.4 5012.3 5484.2 5518.8 5521.9 5529.3 5533.9 4438.6 4440.8 4441.0 4568.5 4785.2 5521.4 5648.3 5682.7 5747.7 5867.9 4990.3 5003.3 5012.2 5017.4 5026.3 5074.6 5091.7 5097.2 5105.6 5121.6 4869.4 4972.4 5021.2 5231.0 5243.5 5552.6 5554.8 5564.3 5581.6 5583.2 1763.1 1783.9 1800.4 1804.2 1806.0 1425.5 1426.3 1437.4 1439.9 1482.5 4757.8 4776.2 4779.5 4781.3 4788.5 5651.0 5653.2 5658.5 5680.8 5703.6 4601.2 4763.8 4780.2 4793.4 4805.5 2972.8 2997.2 3001.3 3003.5 3003.5 5261.2 5269.4 5269.6 5292.1 5294.6 5573.3 5734.3 5778.5 5789.5 5790.8 5262.4 5268.4 5272.3 5275.7 5282.4 5486.3 5662.0 5664.5 5677.3 5691.9 5527.1 5535.4 5557.6 5574.5 5578.7 5043.8 5143.4 5181.8 5288.1 5297.6 4974.5 4977.4 5001.3 5006.4 5017.7 5480.5 5651.5 5721.3 5735.9 5737.6 5491.3 5498.6 5505.6 5519.5 5531.4 5337.1 5430.3 5434.2 5441.4 5463.1 5142.8 5392.9 5407.6 5422.0 5425.3 5546.2 5565.9 5567.8 5570.7 5582.1 5387.0 5393.9 5415.4 5421.5 5428.3 09:02:32 INFO - PID 18752 | 09:02:32 INFO - PID 18752 | [#5] yui.html Cycles:180 Average:13862.53 Median:41842.19 stddev:15858.37 (37.9%) stddev-sans-first:15871.94 09:02:32 INFO - PID 18752 | Values: 675.8 684.8 686.3 710.8 730.5 13268.1 13795.4 13805.0 13862.4 13899.8 14260.5 14268.6 14299.6 14523.3 14799.5 830.3 847.8 858.9 859.2 859.6 817.9 843.8 849.4 857.4 862.5 878.8 882.9 883.8 883.8 884.6 871.0 871.9 877.1 879.3 880.1 648.5 649.8 651.7 652.1 652.6 13934.4 14024.5 14237.0 14279.1 14738.2 13652.4 14332.9 14409.2 14437.6 14521.2 10421.3 10496.7 10735.6 10745.6 10767.0 3260.4 3274.0 3293.6 3335.4 3421.3 61053.4 61536.4 61613.7 62348.7 62712.0 10381.2 10451.5 10506.8 10672.8 10678.8 21160.9 21413.8 21441.0 21619.8 21707.1 6544.4 6634.6 6755.8 6844.9 6887.2 3421.1 3475.3 3548.5 3578.9 3601.7 2776.4 2835.5 2847.8 2848.2 2853.2 510.7 525.3 531.8 539.6 540.2 591.3 614.5 632.1 638.8 644.7 8591.4 8606.6 9155.7 9533.6 9637.3 583.1 600.6 608.3 608.9 613.6 4372.7 4539.2 4541.2 4557.6 4579.5 48756.5 50414.5 51367.0 61329.7 62937.4 39926.8 40493.8 41127.0 42036.6 42390.4 43557.3 44184.6 44857.8 45241.8 46148.0 9121.4 9658.0 9675.8 9686.3 9753.4 29633.4 30273.0 31151.7 31545.4 31572.0 40548.0 40765.4 41647.8 42291.8 42990.6 11570.7 11605.0 11690.5 11936.5 11964.0 11588.8 11645.2 11832.0 11851.6 11927.7 11863.3 11972.5 12036.8 12129.1 12326.0 10897.2 11361.3 11459.5 11496.3 11592.2 11131.4 11653.2 11681.6 11685.8 12111.0 9742.2 9764.5 10127.1 10207.6 10513.7 8972.8 9266.6 9453.7 10159.4 10183.7 09:02:32 INFO - PID 18752 | -------- Summary: end -------- 09:02:32 INFO - PID 18752 | 09:02:33 INFO - TEST-INFO | 18752: exit 0 09:02:33 INFO - TEST-OK | dromaeo_css | took 1123157ms 09:02:33 INFO - TEST-START | kraken 09:02:33 INFO - operating with platform_type : linux_ 09:02:33 INFO - Initialising browser for kraken test... 09:02:33 INFO - TEST-INFO | started process 19074 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbPCoFA/profile http://localhost:36912/getInfo.html) 09:02:38 INFO - PID 19074 | __metrics Screen width/height:1600/1200 09:02:38 INFO - PID 19074 | colorDepth:24 09:02:38 INFO - PID 19074 | Browser inner width/height: 1024/697 09:02:38 INFO - PID 19074 | __metrics 09:02:39 INFO - PID 19074 | 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" 09:02:39 INFO - PID 19074 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:02:40 INFO - TEST-INFO | 19074: exit 0 09:02:40 INFO - Browser initialized. 09:02:40 INFO - Running cycle 1/1 for kraken test... 09:02:40 INFO - TEST-INFO | started process 19167 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbPCoFA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:02:52 INFO - PID 19167 | RSS: Main: 149245952 09:02:52 INFO - PID 19167 | 09:02:55 INFO - PID 19167 | Cycle 1(1): loaded http://localhost:36912/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36912/tests/kraken/driver.html?testName=audio-beat-detection) 09:02:56 INFO - PID 19167 | RSS: Main: 203939840 09:02:56 INFO - PID 19167 | 09:02:59 INFO - PID 19167 | Cycle 1(1): loaded http://localhost:36912/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36912/tests/kraken/driver.html?testName=audio-dft) 09:02:59 INFO - PID 19167 | RSS: Main: 183603200 09:02:59 INFO - PID 19167 | 09:03:02 INFO - PID 19167 | Cycle 1(1): loaded http://localhost:36912/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36912/tests/kraken/driver.html?testName=audio-fft) 09:03:03 INFO - PID 19167 | RSS: Main: 265854976 09:03:03 INFO - PID 19167 | 09:03:05 INFO - PID 19167 | Cycle 1(1): loaded http://localhost:36912/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36912/tests/kraken/driver.html?testName=audio-oscillator) 09:03:06 INFO - PID 19167 | RSS: Main: 176975872 09:03:06 INFO - PID 19167 | 09:03:08 INFO - PID 19167 | Cycle 1(1): loaded http://localhost:36912/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36912/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:03:08 INFO - PID 19167 | RSS: Main: 180215808 09:03:08 INFO - PID 19167 | 09:03:12 INFO - PID 19167 | Cycle 1(1): loaded http://localhost:36912/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36912/tests/kraken/driver.html?testName=imaging-darkroom) 09:03:12 INFO - PID 19167 | RSS: Main: 219406336 09:03:12 INFO - PID 19167 | 09:03:16 INFO - PID 19167 | Cycle 1(1): loaded http://localhost:36912/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36912/tests/kraken/driver.html?testName=imaging-desaturate) 09:03:17 INFO - PID 19167 | RSS: Main: 214417408 09:03:17 INFO - PID 19167 | 09:03:19 INFO - PID 19167 | Cycle 1(1): loaded http://localhost:36912/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36912/tests/kraken/driver.html?testName=json-parse-financial) 09:03:20 INFO - PID 19167 | RSS: Main: 216563712 09:03:20 INFO - PID 19167 | 09:03:22 INFO - PID 19167 | Cycle 1(1): loaded http://localhost:36912/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36912/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:03:22 INFO - PID 19167 | RSS: Main: 179933184 09:03:22 INFO - PID 19167 | 09:03:24 INFO - PID 19167 | Cycle 1(1): loaded http://localhost:36912/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36912/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:03:25 INFO - PID 19167 | RSS: Main: 187076608 09:03:25 INFO - PID 19167 | 09:03:27 INFO - PID 19167 | Cycle 1(1): loaded http://localhost:36912/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36912/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:03:28 INFO - PID 19167 | RSS: Main: 196378624 09:03:28 INFO - PID 19167 | 09:03:31 INFO - PID 19167 | Cycle 1(1): loaded http://localhost:36912/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36912/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:03:31 INFO - PID 19167 | RSS: Main: 205914112 09:03:31 INFO - PID 19167 | 09:03:35 INFO - PID 19167 | Cycle 1(1): loaded http://localhost:36912/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36912/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:03:35 INFO - PID 19167 | RSS: Main: 201670656 09:03:35 INFO - PID 19167 | 09:03:37 INFO - PID 19167 | Cycle 1(1): loaded http://localhost:36912/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36912/tests/kraken/driver.html?testName=ai-astar) 09:03:37 INFO - PID 19167 | RSS: Main: 271101952 09:03:37 INFO - PID 19167 | 09:03:37 INFO - PID 19167 | __start_tp_report 09:03:37 INFO - PID 19167 | _x_x_mozilla_page_load 09:03:37 INFO - PID 19167 | _x_x_mozilla_page_load_details 09:03:37 INFO - PID 19167 | |i|pagename|runs| 09:03:37 INFO - PID 19167 | |0;ai-astar;113;120;120;119;124;120;120;118;120;119 09:03:37 INFO - PID 19167 | |1;audio-beat-detection;156;124;126;163;125;125;125;124;168;125 09:03:37 INFO - PID 19167 | |2;audio-dft;163;162;162;162;163;162;162;163;164;163 09:03:37 INFO - PID 19167 | |3;audio-fft;75;76;75;118;77;76;76;75;102;76 09:03:37 INFO - PID 19167 | |4;audio-oscillator;84;84;103;85;86;84;101;85;84;104 09:03:37 INFO - PID 19167 | |5;imaging-gaussian-blur;114;114;114;114;113;113;112;113;113;113 09:03:37 INFO - PID 19167 | |6;imaging-darkroom;149;148;149;149;149;148;150;149;149;148 09:03:37 INFO - PID 19167 | |7;imaging-desaturate;93;93;93;95;94;93;94;94;94;94 09:03:37 INFO - PID 19167 | |8;json-parse-financial;68;66;67;68;67;67;68;68;68;69 09:03:37 INFO - PID 19167 | |9;json-stringify-tinderbox;56;56;56;55;58;55;56;55;56;59 09:03:37 INFO - PID 19167 | |10;stanford-crypto-aes;83;84;83;82;81;83;82;82;82;82 09:03:37 INFO - PID 19167 | |11;stanford-crypto-ccm;151;133;147;133;140;132;133;146;194;144 09:03:37 INFO - PID 19167 | |12;stanford-crypto-pbkdf2;197;204;202;194;188;197;194;194;197;191 09:03:37 INFO - PID 19167 | |13;stanford-crypto-sha256-iterative;73;71;71;72;71;70;73;74;70;72 09:03:37 INFO - PID 19167 | __end_tp_report 09:03:37 INFO - PID 19167 | __start_cc_report 09:03:37 INFO - PID 19167 | _x_x_mozilla_cycle_collect,2008 09:03:37 INFO - PID 19167 | __end_cc_report 09:03:37 INFO - PID 19167 | __startTimestamp1489593817741__endTimestamp 09:03:37 INFO - PID 19167 | 09:03:37 INFO - PID 19167 | ------- Summary: start ------- 09:03:37 INFO - PID 19167 | Number of tests: 14 09:03:37 INFO - PID 19167 | 09:03:37 INFO - PID 19167 | [#0] ai-astar Cycles:10 Average:119.30 Median:120.00 stddev:2.71 (2.3%) stddev-sans-first:1.66 09:03:37 INFO - PID 19167 | Values: 113.0 120.0 120.0 119.0 124.0 120.0 120.0 118.0 120.0 119.0 09:03:37 INFO - PID 19167 | 09:03:37 INFO - PID 19167 | [#1] audio-beat-detection Cycles:10 Average:136.10 Median:125.50 stddev:18.33 (14.6%) stddev-sans-first:17.98 09:03:37 INFO - PID 19167 | Values: 156.0 124.0 126.0 163.0 125.0 125.0 125.0 124.0 168.0 125.0 09:03:37 INFO - PID 19167 | 09:03:37 INFO - PID 19167 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 09:03:37 INFO - PID 19167 | Values: 163.0 162.0 162.0 162.0 163.0 162.0 162.0 163.0 164.0 163.0 09:03:37 INFO - PID 19167 | 09:03:37 INFO - PID 19167 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.00 stddev:14.94 (19.7%) stddev-sans-first:15.59 09:03:37 INFO - PID 19167 | Values: 75.0 76.0 75.0 118.0 77.0 76.0 76.0 75.0 102.0 76.0 09:03:37 INFO - PID 19167 | 09:03:37 INFO - PID 19167 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:84.00 stddev:8.79 (10.5%) stddev-sans-first:9.06 09:03:37 INFO - PID 19167 | Values: 84.0 84.0 103.0 85.0 86.0 84.0 101.0 85.0 84.0 104.0 09:03:37 INFO - PID 19167 | 09:03:37 INFO - PID 19167 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:113.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 09:03:37 INFO - PID 19167 | Values: 114.0 114.0 114.0 114.0 113.0 113.0 112.0 113.0 113.0 113.0 09:03:37 INFO - PID 19167 | 09:03:37 INFO - PID 19167 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 09:03:37 INFO - PID 19167 | Values: 149.0 148.0 149.0 149.0 149.0 148.0 150.0 149.0 149.0 148.0 09:03:37 INFO - PID 19167 | 09:03:37 INFO - PID 19167 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 09:03:37 INFO - PID 19167 | Values: 93.0 93.0 93.0 95.0 94.0 93.0 94.0 94.0 94.0 94.0 09:03:37 INFO - PID 19167 | 09:03:37 INFO - PID 19167 | [#8] json-parse-financial Cycles:10 Average:67.60 Median:68.00 stddev:0.84 (1.2%) stddev-sans-first:0.88 09:03:37 INFO - PID 19167 | Values: 68.0 66.0 67.0 68.0 67.0 67.0 68.0 68.0 68.0 69.0 09:03:37 INFO - PID 19167 | 09:03:37 INFO - PID 19167 | [#9] json-stringify-tinderbox Cycles:10 Average:56.20 Median:56.00 stddev:1.32 (2.4%) stddev-sans-first:1.39 09:03:37 INFO - PID 19167 | Values: 56.0 56.0 56.0 55.0 58.0 55.0 56.0 55.0 56.0 59.0 09:03:37 INFO - PID 19167 | 09:03:37 INFO - PID 19167 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.50 stddev:0.84 (1.0%) stddev-sans-first:0.87 09:03:37 INFO - PID 19167 | Values: 83.0 84.0 83.0 82.0 81.0 83.0 82.0 82.0 82.0 82.0 09:03:37 INFO - PID 19167 | 09:03:37 INFO - PID 19167 | [#11] stanford-crypto-ccm Cycles:10 Average:145.30 Median:145.00 stddev:18.46 (12.7%) stddev-sans-first:19.47 09:03:37 INFO - PID 19167 | Values: 151.0 133.0 147.0 133.0 140.0 132.0 133.0 146.0 194.0 144.0 09:03:37 INFO - PID 19167 | 09:03:37 INFO - PID 19167 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.80 Median:197.00 stddev:4.76 (2.4%) stddev-sans-first:5.02 09:03:37 INFO - PID 19167 | Values: 197.0 204.0 202.0 194.0 188.0 197.0 194.0 194.0 197.0 191.0 09:03:37 INFO - PID 19167 | 09:03:37 INFO - PID 19167 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:72.00 stddev:1.34 (1.9%) stddev-sans-first:1.33 09:03:37 INFO - PID 19167 | Values: 73.0 71.0 71.0 72.0 71.0 70.0 73.0 74.0 70.0 72.0 09:03:37 INFO - PID 19167 | -------- Summary: end -------- 09:03:37 INFO - PID 19167 | 09:03:38 INFO - TEST-INFO | 19167: exit 0 09:03:39 INFO - TEST-OK | kraken | took 65227ms 09:03:39 INFO - SUITE-END | took 1188s 09:03:39 INFO - Completed test suite (00:19:48) 09:03:39 INFO - javascript benchmark 09:03:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6642.717274776745, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2553.93615159621, 2573.292344605234, 2573.8455692658454, 2588.2235329401174, 2626.277773612257, 4864.14877396456, 4870.074685809694, 4921.9015619687625, 4929.8028078876805, 4984.850454486371, 4880.591310045614, 4933.358663373757, 4948.480409556999, 4965.900681986367, 4988.052270068693, 4313.374560688699, 4446.088551846871, 4576.153411618861, 4625.074985002996, 4645.814167433316, 4537.682362234645, 4578.862634120982, 4621.838235661752, 4630.884227894296, 4672.462666793312, 4349.151915376503, 4422.778861056967, 4426.136903303857, 4437.667174961858, 4539.16025535277, 4420.425344705168, 4434.11317736454, 4445.711028783151, 4446.444194475691, 4449.710768800018, 4373.190959672471, 4388.912221755579, 4389.122175564868, 4396.582324679182, 4402.119576084796, 4800.831970881002, 4811.037792441526, 4817.927731084036, 4820.30105634681, 4822.348982887301, 5241.842744717665, 5244.606654500928, 5246.816361427332, 5247.816326428595, 5247.921281180786, 5233.528982391603, 5304.310439642861, 5348.759305831247, 5403.78384864605, 5417.349918009824, 4932.7286999215385, 4956.653034287601, 4962.60299176065, 4977.9751101244265, 4981.32752078472, 5257.474252574789, 5461.42655021225, 5463.153211252262, 5471.863203419866, 5473.67157970523, 5069.264956581349, 5081.441041485434, 5186.429492755794, 5232.03207406631, 5257.526822585909, 5284.762185701653, 5285.656432331886, 5286.471352864683, 5286.550643195372, 5302.469753024744, 5244.082285600005, 5262.500062494057, 5268.6575372600655, 5273.393559740679, 5326.014687282865, 5159.561437277874, 5196.53231209193, 5197.7401129943355, 5242.842714718565, 5278.683279003272, 4492.550744925481, 4492.550744925481, 4497.235469970113, 4524.04994951064, 4536.455625324982, 3825.732198746061, 3832.789196594214, 3835.846566137379, 3864.71014673895, 3865.8453661853773, 4428.202923473741, 4507.594316511464, 4576.794044268016, 4585.312203169551, 4633.930491042637, 5279.9208011879855, 5306.442823503554, 5345.33183352081, 5345.786168553214, 5351.625386222927, 4529.365888775574, 4548.044910568751, 4549.226631472658, 4551.112533056023, 4588.977055114703, 4627.62978961689, 4750.619950404029, 4758.762061896891, 4765.666403351802, 4818.060478206786, 4871.537203965618, 4885.609151267961, 4969.527894849984, 4975.0547395994645, 4983.277424773315, 5308.442613525679, 5317.494837990384, 5320.17537281722, 5321.308229930084, 5352.571794256528, 4929.0, 4969.304297398295, 4978.27814966835, 4981.676191047571, 5028.296038554532, 5056.797728090835, 5121.8719532012, 5176.223566465061, 5231.267622532924, 5237.554807841224, 5360.597955153301, 5364.839054828361, 5372.865678358073, 5380.730963451733, 5420.051490988983, 5029.44676085623, 5078.542931136068, 5079.3650793650795, 5193.221016847503, 5222.529972302511, 5040.672356296829, 5072.365954255718, 5085.720285384339, 5088.0587091388215, 5093.974530127326, 4963.454020057863, 5009.624278179078, 5018.824341148043, 5021.196608542616, 5023.296738456692, 5105.770240339268, 5161.122609156528, 5185.248139019896, 5203.115470370122, 5217.973910130425, 4878.731669758197, 4950.504949505021, 5022.221555658879, 5033.697978121324, 5038.949610503848], "value": 4817.52912117095, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [626.564537646336, 681.9352161544653, 697.6511744127936, 738.2764890407401, 745.2212438002288, 25400.872995635018, 31025.844870775643, 31617.525737113905, 31655.20861978446, 31720.841395793017, 33529.0, 34092.488612670764, 34124.658753412456, 34131.65868341316, 34146.0, 5145.151050076743, 5285.445028272034, 5286.127788914843, 5289.523942845143, 6601.2408573014, 6656.768497827918, 8864.0, 9106.089391060907, 9110.954445227764, 9113.453192808453, 9433.95283023584, 9524.238060955107, 9535.570899309512, 9540.666076687317, 9549.904500954972, 9388.108129727665, 9463.337566370288, 9466.19537339327, 9483.430994140304, 9484.288678349083, 9155.404898681565, 9224.0, 9231.492267925261, 9232.215261702764, 9239.769005774842, 34417.311653767036, 34717.47923781145, 34808.0, 34843.477347839806, 34862.12844678878, 3392.1858753899132, 3417.829108544563, 3428.9828550857087, 3468.8959331220103, 3480.164760457472, 24293.028278869002, 24384.390390240387, 24480.755192448203, 24576.262712118485, 24951.251462456155, 3070.8157510549213, 3127.4758358421964, 3133.6552979172275, 3167.8732850685947, 3273.6398996110647, 145669.0, 147334.0, 147480.0, 147577.52422475745, 148111.25944370317, 41664.166716665495, 41954.79022604867, 41969.37045944313, 42077.579224207366, 42123.0, 47961.5203847957, 48149.51850481451, 48175.0, 48306.27540586894, 48351.75824120857, 12148.5140594377, 12239.632811015685, 12277.754444911052, 12282.815757763641, 12293.385330733428, 8838.0, 9031.729048128567, 9594.520273986273, 9651.469169195761, 9659.034096590285, 12848.421821018077, 12966.935165324114, 13075.215487070805, 13103.0, 13115.737685246242, 5305.469453054741, 5519.558435325164, 5521.917171242435, 5534.363548192009, 5685.431456854281, 797.7487091566138, 831.1563762780783, 832.2094010689868, 833.0378412933072, 851.8040850604395, 22128.33614991553, 22846.8857655714, 22951.0, 22978.540429191322, 23235.0, 887.8401887660283, 890.4390234152443, 891.6522556203086, 898.1916275352105, 903.9005709371963, 11900.583479578174, 11928.46321915516, 12229.327386993622, 12325.69185770345, 12337.0, 240652.0, 243015.0, 243111.0, 243126.0, 243420.0, 31000.379992400027, 31537.8423107883, 36193.63806361955, 36829.63170368315, 36990.0, 1201.006407988351, 1215.167610187007, 1216.8600610929857, 1224.797908345113, 1225.993870030644, 21831.126754929624, 22114.336569902927, 23084.076636935006, 24697.87651061733, 24740.876295618407, 34045.0, 34109.82945085259, 34117.31765364728, 34187.4871876927, 34192.31615367728, 181359.0, 183463.0, 183531.0, 183668.0, 183843.0, 29150.562741558468, 29424.705752942198, 29695.0, 29715.702842972158, 29794.70205298006, 34846.0, 35019.0, 35413.82293088518, 36177.0, 36178.63821361858, 29287.41425171442, 29931.70068299289, 31471.21321966969, 31519.84240078785, 31540.36919261648, 30248.243793905327, 30380.24049398783, 30436.934707285138, 30576.235594110327, 31788.0, 29578.408431830812, 30134.2466438332, 30436.391272174875, 30550.0, 30985.53521697131, 25988.090416836076, 27072.72927270702, 27283.86358068197, 27435.86282068577, 27674.44651106926, 20969.685454718496, 21466.463338416663, 22400.663990039837, 22436.439089022904, 22446.949436376686], "value": 15197.362887873363, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.79587329032375, 392.80978634736755, 412.6348181859055, 423.7499875073707, 424.5181718749221, 11869.169158158933, 13658.521951731691, 17969.7304540432, 18072.277108915627, 18358.54103647408, 17466.825331746677, 17626.383076592323, 18097.4570762877, 18286.817131828677, 18297.99361035146, 4723.62211023119, 4866.878328041809, 4870.220764677652, 4870.829520966767, 4872.780724867372, 4706.788194531255, 4790.42514898211, 4931.482194369593, 4955.405351357824, 4961.181405068178, 4960.7767650455635, 4962.975185124069, 4966.329545511346, 4969.055879382924, 4970.577500912426, 4924.753762311888, 4959.082569724595, 6337.683115844189, 6647.069410282565, 6683.7660681875905, 6288.968555157241, 6511.479081673502, 6516.446102081329, 6517.4786017118995, 6519.771807986745, 21183.763247350438, 21520.89239553792, 21695.0, 22077.116915323368, 22178.667319990214, 2302.7236731592316, 2360.7403185649564, 2394.928152155438, 2431.5866302728577, 2442.6213936839818, 13178.275194864278, 13389.397477113553, 13649.0, 13959.930200349036, 14429.0, 1705.84647381735, 1759.8856074355126, 1797.2271923073074, 1799.62222806122, 1799.8830076045015, 86117.56941215254, 86595.56702216575, 86658.5667071667, 88835.0, 89814.0, 15315.92342038305, 15571.454999074978, 15647.530574082795, 16093.436729714404, 16159.192040397933, 27926.441471170463, 27961.16116516508, 27961.860190699324, 28013.859930700215, 28108.43783124367, 8565.614547345385, 8648.43785153963, 8651.005134409623, 8790.42862213954, 8918.241949434241, 7086.92913070873, 7142.392896603743, 7321.78034658961, 7348.448866335047, 7363.48455608113, 8350.958245208856, 8417.92745647834, 8735.737927862174, 8804.163604457694, 8884.244839188612, 3161.743797983633, 3237.271613886857, 3284.523744057098, 3516.0330908999717, 3606.549181352331, 722.266899097406, 770.9961450192714, 773.2074623510833, 773.9226077392216, 779.7972527142983, 18085.36701215451, 18098.46163076127, 18638.90680546616, 18788.0, 18959.241630334633, 766.7239793674273, 776.6466257852663, 778.260652380241, 780.3523075847033, 787.2049230277461, 9438.244940404751, 10359.741006474898, 11037.83443248352, 11043.875183956403, 11231.66305010851, 520643.0, 523682.0, 527471.0, 529618.0, 538778.0, 90809.0, 93100.0, 93893.0, 96563.0, 96755.51622241843, 1075.8655168103987, 1126.301692950376, 1152.5505053029158, 1160.640201537526, 1165.9941700291613, 16594.58513537171, 16848.747268790732, 17222.138893055548, 17583.824161758217, 17899.910500447935, 41360.0, 41550.376744349465, 41683.7915810419, 41924.37113443362, 42163.36754948617, 52729.472705272456, 53252.0, 53835.0, 53852.0, 55610.44389556053, 10064.798704025732, 10785.784284314113, 10866.619668311887, 10880.510377033212, 11283.830742539032, 12624.0, 12807.679808004874, 13025.674358141123, 13041.0, 13475.595732128051, 9854.063863932915, 10157.9492102539, 10232.0, 10546.103581195377, 10812.729681758019, 9953.850692239766, 10832.5125369357, 11052.834207486734, 11084.057855082408, 11104.833427498432, 9881.258905582254, 10696.0, 10833.29583577065, 11166.832497512381, 11321.71695707614, 11082.778344433227, 11161.330320180816, 11277.0, 11313.886861131283, 11408.885911140782, 11071.50178241965, 11140.721481963015, 11484.598039068593, 11615.186936914335, 11635.941820290844], "value": 9630.687906015994, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1406.465543093625, 1423.5444657709534, 1430.8569143085685, 1436.3967133803808, 1490.1878476230454, 9064.456132632047, 9386.765330866723, 9448.95275523623, 9458.432494050361, 9459.337846350758, 9248.121428464285, 9251.0, 9515.42907425555, 9521.523923803818, 9522.381045232056, 2118.110393634673, 2155.4503601581573, 2155.5581105873257, 2159.8920053997317, 2174.0325555127974, 1647.6045749020209, 1700.3368686212386, 2028.7971202879667, 2068.5552606189667, 2080.209520382253, 2023.2918478532542, 2072.243631074662, 2074.678424844152, 2082.6563617003176, 2087.780783017784, 2041.0407108659056, 2055.3731112010832, 2060.763012253595, 2061.608294424062, 2062.7215325931106, 1643.761654560094, 1697.6180359419157, 2036.908339124743, 2076.979230207709, 2077.200277893022, 9021.458712477272, 9306.674266400643, 9317.16145546904, 9318.534073296376, 9321.533923303876, 4507.909841803145, 4653.674242803005, 4660.743659098748, 4666.53334666534, 4670.299455081731, 2501.862397568133, 2549.7195308516048, 2625.0812215724536, 2631.8947242110294, 2635.143578337048, 994.5673631970116, 1001.4241810958728, 1003.8193125237455, 1030.3766221436, 1058.7935352606246, 12939.935300323532, 13212.86787132126, 13326.133801302884, 13344.399502022432, 13365.599032029055, 3742.6818720408523, 3843.461915331856, 3911.0, 3916.5691773904846, 3926.9214615708097, 10207.846882296772, 10217.591296348211, 10225.744356391, 10226.0, 10232.437215953194, 4763.476017638126, 4766.547178018082, 4767.523247675204, 4769.785359658755, 4775.331453596499, 4173.561776013475, 4272.551382104896, 4339.132173565299, 4349.804258808361, 4360.869173924787, 3281.3273278977754, 3303.9174020649193, 3402.6427225141006, 3404.2851001290005, 3416.265502916885, 757.8332766791297, 765.2309429023907, 771.9112302085332, 777.7977725791335, 785.2500861677084, 791.9604019799102, 806.766037849029, 809.8218391953761, 810.7324582887633, 811.2820154163608, 5435.021696094662, 5613.775448982076, 5738.225339579187, 5757.337906140848, 5852.180694702745, 873.886394768676, 879.5646155153112, 885.2298500304776, 897.8832751742232, 926.6432423516994, 3680.5215322008503, 3691.557013158438, 3710.888673339804, 3726.459663348799, 3755.7746535207975, 9935.65225217114, 10197.490125493696, 11468.54125834974, 11537.173392518718, 11744.17790754656, 11531.827022594667, 11612.303261804318, 11621.24461909973, 11641.88358116408, 11660.650180494598, 8770.0, 8994.28045756338, 9034.186923176945, 9037.367384283038, 9045.864312035194, 6059.0608455689435, 6072.666003369857, 6095.603785753912, 6096.573239873166, 6126.326104128453, 10406.739831504274, 10449.58201671955, 10501.632442864464, 10515.526801294112, 10613.310134841211, 10892.61875834342, 10935.726606834893, 11061.612843550438, 11062.944685276843, 11168.609098681507, 7470.775876723707, 7489.176190619137, 7574.621268936641, 7577.886331705139, 7581.166071732216, 9074.364794464589, 9193.724188274362, 9233.861492077489, 9293.767655808388, 9297.628094876129, 7883.960580197292, 7889.566073865993, 7909.406794490551, 7969.043714754266, 8025.0, 7773.922260777546, 7817.179196184319, 7896.526208427513, 7956.045274567089, 8057.234562716532, 6911.930880691129, 7051.224365319913, 7052.858942821217, 7061.435085193275, 7062.505624606229, 4978.9551375396695, 5035.194368900959, 5069.417017043087, 5183.092958732283, 5255.080360936744, 4885.389326334208, 4927.901441971212, 5032.144535428913, 5066.594672426123, 5085.796568137381], "value": 4383.136604604498, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.5306114295988, 377.5959723096287, 378.3152493985884, 381.0435806126623, 384.1855266834312, 5229.267902493654, 5240.868978275545, 5252.789888404459, 5278.999999999995, 5288.524032837044, 4997.1760307487775, 5118.309028281181, 5153.1239689252825, 5155.4586768389345, 5167.974160129194, 4294.0, 4306.935395969047, 4311.827526898928, 4313.8058787354485, 4329.372241025049, 4337.327714204288, 4342.109867477159, 4350.0, 4362.19299429605, 4374.8906277343, 4219.556946520617, 4268.914621707564, 4299.26912424887, 4323.978380108095, 4352.955290730218, 4287.0, 4297.226499230137, 4301.440812694361, 4325.74045557266, 4327.653787696992, 3979.5821438748803, 3985.3822657488136, 3994.3609022556543, 4013.779242141681, 4026.375911733686, 4914.238293064581, 5031.270465782478, 5097.3118628984985, 5117.488251174853, 5125.487451254882, 4962.305277261186, 4967.279744437036, 4986.326845875797, 4999.375078115236, 5012.298278241049, 5484.2047903053835, 5518.806841760559, 5521.895620875841, 5529.281193444866, 5533.889322213533, 4438.556144385568, 4440.844570440051, 4440.955590444087, 4568.538067818299, 4785.162596545625, 5521.365043020064, 5648.322201335866, 5682.659040457585, 5747.741351639186, 5867.941320586782, 4990.2764099205415, 5003.3495645565845, 5012.172991456442, 5017.37282839645, 5026.346574945233, 5074.619403544675, 5091.719955402415, 5097.235414687826, 5105.642605017613, 5121.564667003347, 4869.366982292279, 4972.428170760409, 5021.246812978009, 5231.032259032091, 5243.528082472596, 5552.555795536347, 5554.805581804618, 5564.276644036249, 5581.57669794208, 5583.162525621108, 1763.0831967376891, 1783.8929664220188, 1800.3698705452987, 1804.1520485371855, 1806.0, 1425.465450456079, 1426.2583456602715, 1437.3891096284037, 1439.9208043557705, 1482.5107714454205, 4757.762111894392, 4776.23580227162, 4779.498152693917, 4781.258904869751, 4788.545088216614, 5651.039323315046, 5653.236813030188, 5658.519025882763, 5680.841280313537, 5703.600747947687, 4601.217792975202, 4763.833265835679, 4780.1873681474235, 4793.376861008116, 4805.543473370024, 2972.7770417218794, 2997.2057404787747, 3001.3397052648384, 3003.459377312061, 3003.474391981438, 5261.158214685632, 5269.445513573505, 5269.627438439402, 5292.126799078109, 5294.629375943647, 5573.331200255914, 5734.340550836624, 5778.468705792969, 5789.45000224978, 5790.768369265266, 5262.394824595221, 5268.417476116278, 5272.31112132815, 5275.683458992473, 5282.392524859613, 5486.259354987025, 5662.0, 5664.461876121762, 5677.318721753416, 5691.886162276648, 5527.143292789624, 5535.391106978149, 5557.638753481011, 5574.470425309589, 5578.721063946868, 5043.823466178666, 5143.3570803649545, 5181.844544663666, 5288.127458969227, 5297.576193904555, 4974.477679843709, 4977.427595826382, 5001.324821149098, 5006.448001119665, 5017.720481277251, 5480.479354461319, 5651.519620832275, 5721.310983837589, 5735.942640573541, 5737.56968227393, 5491.258680078138, 5498.642588231912, 5505.559555235652, 5519.503244707996, 5531.446855314597, 5337.066013447708, 5430.294061771944, 5434.157705555645, 5441.374241962225, 5463.121183959433, 5142.794288228429, 5392.865178370572, 5407.594430417813, 5421.972890135524, 5425.267588875609, 5546.195801608825, 5565.860853478695, 5567.777288908398, 5570.693611851225, 5582.106862901916, 5387.0, 5393.8921221574565, 5415.377231618414, 5421.484958928895, 5428.348598168245], "value": 4385.094329832422, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.7634827810264, 684.7774473296179, 686.3411125319693, 710.7512370670263, 730.466759265736, 13268.137571057887, 13795.379207935643, 13805.0, 13862.37619307131, 13899.791503127448, 14260.500882469116, 14268.571942841705, 14299.571012869605, 14523.346449409775, 14799.482018129367, 830.2942498875967, 847.7965288330787, 858.8797568340437, 859.2395729779159, 859.6346552715071, 817.9222973817477, 843.8227972125861, 849.3757088539918, 857.3826844671827, 862.5428522882883, 878.8242351529688, 882.8543290357084, 883.7967267528472, 883.8409086364452, 884.6417201033591, 871.0375035585713, 871.9258862996653, 877.0746862060523, 879.336101243557, 880.1462581296132, 648.4552975500555, 649.8115546491512, 651.6709061923698, 652.1326635574675, 652.5758257132854, 13934.442622295095, 14024.509142180077, 14237.0, 14279.143251404948, 14738.189399583125, 13652.385642646006, 14332.928335358361, 14409.207493587848, 14437.566872993826, 14521.20133392663, 10421.32261403014, 10496.68509944703, 10735.570577176904, 10745.623903163352, 10767.0, 3260.396826587089, 3273.9836300818583, 3293.6212335581477, 3335.4329763939945, 3421.3328400961823, 61053.38946610522, 61536.38463615396, 61613.6919315405, 62348.68825655888, 62712.0, 10381.2214083944, 10451.52077114541, 10506.842397364046, 10672.839907401396, 10678.839817402744, 21160.894195528923, 21413.78586214118, 21441.0, 21619.783802162092, 21707.131714731233, 6544.378284063102, 6634.601923884582, 6755.7973260802255, 6844.863102737917, 6887.173539175331, 3421.0934102462866, 3475.2528206435736, 3548.538689970287, 3578.8926332210076, 3601.657842504958, 2776.3891943772337, 2835.5463125899755, 2847.757940575033, 2848.245215018022, 2853.1583182961076, 510.72420892717514, 525.332827309315, 531.7500774635915, 539.5872157799287, 540.227474711159, 591.2727345365225, 614.5421660862686, 632.1434456311723, 638.7636574467384, 644.7163248170883, 8591.398602097917, 8606.5696715164, 9155.679551215808, 9533.570989305497, 9637.277204209713, 583.1136672258228, 600.5915977135502, 608.2791891608458, 608.948239399656, 613.6256883301182, 4372.6939114261695, 4539.228331183706, 4541.205289074399, 4557.589816916494, 4579.519150489217, 48756.5124348752, 50414.495855041714, 51366.97266054658, 61329.69335153296, 62937.37062629407, 39926.80036599799, 40493.797531012155, 41127.0, 42036.57963420388, 42390.36414453786, 43557.34663980043, 44184.558154418046, 44857.775711121234, 45241.773791130836, 46148.0, 9121.361504694607, 9658.0, 9675.758106047406, 9686.321957463191, 9753.366031207948, 29633.407331853672, 30273.0, 31151.68848311488, 31545.36909261848, 31572.0, 40548.0, 40765.38851917164, 41647.791761042216, 42291.788541058326, 42990.57009429866, 11570.652880413601, 11605.0, 11690.532378704756, 11936.462859171532, 11964.0, 11588.79809346234, 11645.184837061324, 11832.0, 11851.585194518151, 11927.701807454883, 11863.34751588671, 11972.461239244081, 12036.75926481448, 12129.090318226345, 12326.0, 10897.182711296842, 11361.318320900773, 11459.48432320531, 11496.310221386744, 11592.188546801981, 11131.387773672202, 11653.242539235262, 11681.649550513499, 11685.824712629488, 12111.031117510402, 9742.171915386987, 9764.462954537285, 10127.088562029452, 10207.642732504326, 10513.684589462327, 8972.846516836044, 9266.583003764712, 9453.669121580711, 10159.441230732085, 10183.694489165337], "value": 6339.0270502811445, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1565.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 120.0, 120.0, 119.0, 124.0, 120.0, 120.0, 118.0, 120.0, 119.0], "value": 119.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 124.0, 126.0, 163.0, 125.0, 125.0, 125.0, 124.0, 168.0, 125.0], "value": 136.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 162.0, 163.0, 162.0, 162.0, 163.0, 164.0, 163.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 118.0, 77.0, 76.0, 76.0, 75.0, 102.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 103.0, 85.0, 86.0, 84.0, 101.0, 85.0, 84.0, 104.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 112.0, 113.0, 113.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 149.0, 149.0, 149.0, 148.0, 150.0, 149.0, 149.0, 148.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 95.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 68.0, 67.0, 67.0, 68.0, 68.0, 68.0, 69.0], "value": 67.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 55.0, 58.0, 55.0, 56.0, 55.0, 56.0, 59.0], "value": 56.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 83.0, 82.0, 81.0, 83.0, 82.0, 82.0, 82.0, 82.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 133.0, 147.0, 133.0, 140.0, 132.0, 133.0, 146.0, 194.0, 144.0], "value": 145.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 204.0, 202.0, 194.0, 188.0, 197.0, 194.0, 194.0, 197.0, 191.0], "value": 195.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 71.0, 72.0, 71.0, 70.0, 73.0, 74.0, 70.0, 72.0], "value": 71.7, "unit": "score"}]}]} 09:03:39 INFO - Return code: 0 09:03:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:03:39 ERROR - # TBPL SUCCESS # 09:03:39 INFO - Running post-action listener: _resource_record_post_action 09:03:39 INFO - [mozharness: 2017-03-15 16:03:39.534936Z] Finished run-tests step (success) 09:03:39 INFO - Running post-run listener: _resource_record_post_run 09:03:39 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 0; Write bytes: 361758720; Read time: 0; Write time: 317988 09:03:39 INFO - TinderboxPrint: CPU usage
13.0% 09:03:39 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:03:39 INFO - TinderboxPrint: I/O write bytes / time
361,758,720 / 317,988 09:03:39 INFO - TinderboxPrint: CPU idle
8,361.7 (87.0%) 09:03:39 INFO - TinderboxPrint: CPU user
1,201.8 (12.5%) 09:03:39 INFO - TinderboxPrint: Swap in / out
0 / 0 09:03:39 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105259008; Read time: 0; Write time: 118712 09:03:39 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 256499712; Read time: 0; Write time: 199276 09:03:40 INFO - Running post-run listener: _upload_blobber_files 09:03:40 INFO - Blob upload gear active. 09:03:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:03:40 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 09:03:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:03:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:03:40 INFO - (blobuploader) - INFO - Open directory for files ... 09:03:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:03:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:03:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:41 INFO - (blobuploader) - INFO - Done attempting. 09:03:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:03:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:42 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:03:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:42 INFO - (blobuploader) - INFO - Done attempting. 09:03:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:03:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:03:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:43 INFO - (blobuploader) - INFO - Done attempting. 09:03:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:03:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:03:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:47 INFO - (blobuploader) - INFO - Done attempting. 09:03:47 INFO - (blobuploader) - INFO - Iteration through files over. 09:03:47 INFO - Return code: 0 09:03:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:03:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:03:47 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0cec9e589097a2f4eac42dec955280a9a2a8d41c0554beefa8676a7a83e0696b75d8153facad819615579459117e87a76d716a9fdb5bcf899723d113abe95563", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/137bd705ae4a82b6d745f884a396641b622cfdfffdc37f0374f253284ec6355413454fd1035845f9c4eb8fd3928fcabc7a84360e4a0d749e7f8e7be8d121b0d5", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1280643384c8a49b7aa6cc23534689b0eb0b0b82ba14fa079d8cd76c470fef1f1627c15234b92755ecdf214089c4db33cd929fdd3f33c26f3891803ce184c634", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8cb5649df971a01d3c696b3a5a32e9efd0c2fb3189adbc9375425c111916f0732de427bee7bd89f12bdd94ad0516d10fe34fdf8e553864edd68afc6ba886b9a9"} 09:03:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:03:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:03:47 INFO - Contents: 09:03:47 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0cec9e589097a2f4eac42dec955280a9a2a8d41c0554beefa8676a7a83e0696b75d8153facad819615579459117e87a76d716a9fdb5bcf899723d113abe95563", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/137bd705ae4a82b6d745f884a396641b622cfdfffdc37f0374f253284ec6355413454fd1035845f9c4eb8fd3928fcabc7a84360e4a0d749e7f8e7be8d121b0d5", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1280643384c8a49b7aa6cc23534689b0eb0b0b82ba14fa079d8cd76c470fef1f1627c15234b92755ecdf214089c4db33cd929fdd3f33c26f3891803ce184c634", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8cb5649df971a01d3c696b3a5a32e9efd0c2fb3189adbc9375425c111916f0732de427bee7bd89f12bdd94ad0516d10fe34fdf8e553864edd68afc6ba886b9a9"} 09:03:47 INFO - Running post-run listener: copy_logs_to_upload_dir 09:03:47 INFO - Copying logs to upload dir... 09:03:47 INFO - mkdir: /builds/slave/test/build/upload/logs 09:03:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.220409 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-03-15 09:03:47.168443) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 09:03:47.171812) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0cec9e589097a2f4eac42dec955280a9a2a8d41c0554beefa8676a7a83e0696b75d8153facad819615579459117e87a76d716a9fdb5bcf899723d113abe95563", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/137bd705ae4a82b6d745f884a396641b622cfdfffdc37f0374f253284ec6355413454fd1035845f9c4eb8fd3928fcabc7a84360e4a0d749e7f8e7be8d121b0d5", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1280643384c8a49b7aa6cc23534689b0eb0b0b82ba14fa079d8cd76c470fef1f1627c15234b92755ecdf214089c4db33cd929fdd3f33c26f3891803ce184c634", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8cb5649df971a01d3c696b3a5a32e9efd0c2fb3189adbc9375425c111916f0732de427bee7bd89f12bdd94ad0516d10fe34fdf8e553864edd68afc6ba886b9a9"} build_url:https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011356 build_url: 'https://queue.taskcluster.net/v1/task/Fun8OAyKRYeVvGTo2wsRmA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0cec9e589097a2f4eac42dec955280a9a2a8d41c0554beefa8676a7a83e0696b75d8153facad819615579459117e87a76d716a9fdb5bcf899723d113abe95563", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/137bd705ae4a82b6d745f884a396641b622cfdfffdc37f0374f253284ec6355413454fd1035845f9c4eb8fd3928fcabc7a84360e4a0d749e7f8e7be8d121b0d5", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1280643384c8a49b7aa6cc23534689b0eb0b0b82ba14fa079d8cd76c470fef1f1627c15234b92755ecdf214089c4db33cd929fdd3f33c26f3891803ce184c634", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8cb5649df971a01d3c696b3a5a32e9efd0c2fb3189adbc9375425c111916f0732de427bee7bd89f12bdd94ad0516d10fe34fdf8e553864edd68afc6ba886b9a9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 09:03:47.198605) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 09:03:47.199096) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1489592562.345338-1660779931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 09:03:47.284276) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 09:03:47.284598) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 09:03:47.284890) ========= ========= Total master_lag: 0.19 =========