builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1490614198.4 results: success (0) revision: 9577ddeaafd85554c2a855f385a87472a089d5c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 04:29:58.404763) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 04:29:58.405219) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 04:29:58.405515) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 04:29:58.508432) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 04:29:58.509070) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-27 04:29:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2017-03-27 04:29:59 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.289041 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 04:29:58.852840) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 04:29:58.853141) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015752 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 04:29:58.931874) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-27 04:29:58.932222) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9577ddeaafd85554c2a855f385a87472a089d5c0 --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 9577ddeaafd85554c2a855f385a87472a089d5c0 --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=74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-27 04:29:59,251 truncating revision to first 12 chars 2017-03-27 04:29:59,251 Setting DEBUG logging. 2017-03-27 04:29:59,251 attempt 1/10 2017-03-27 04:29:59,251 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9577ddeaafd8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-27 04:29:59,973 unpacking tar archive at: mozilla-central-9577ddeaafd8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.034943 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-27 04:29:59.993431) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 04:29:59.994185) ========= script_repo_revision: 9577ddeaafd85554c2a855f385a87472a089d5c0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 04:29:59.995090) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 04:29:59.995753) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 04:30:00.068736) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-03-27 04:30:00.069171) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:30:00 INFO - MultiFileLogger online at 20170327 04:30:00 in /builds/slave/test 04:30:00 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 04:30:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:30:00 INFO - {'append_to_log': False, 04:30:00 INFO - 'base_work_dir': '/builds/slave/test', 04:30:00 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:30:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:30:00 INFO - 'branch': 'Firefox-Non-PGO', 04:30:00 INFO - 'buildbot_json_path': 'buildprops.json', 04:30:00 INFO - 'config_files': ('talos/linux_config.py',), 04:30:00 INFO - 'default_actions': ('clobber', 04:30:00 INFO - 'read-buildbot-config', 04:30:00 INFO - 'download-and-extract', 04:30:00 INFO - 'populate-webroot', 04:30:00 INFO - 'create-virtualenv', 04:30:00 INFO - 'install', 04:30:00 INFO - 'run-tests'), 04:30:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:30:00 INFO - 'download_minidump_stackwalk': True, 04:30:00 INFO - 'download_symbols': 'ondemand', 04:30:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:30:00 INFO - 'tooltool.py': '/tools/tooltool.py', 04:30:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:30:00 INFO - '/tools/misc-python/virtualenv.py')}, 04:30:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:30:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:30:00 INFO - 'gecko_profile': False, 04:30:00 INFO - 'gecko_profile_interval': 0, 04:30:00 INFO - 'installer_path': 'installer.exe', 04:30:00 INFO - 'log_level': 'info', 04:30:00 INFO - 'log_name': 'talos', 04:30:00 INFO - 'log_to_console': True, 04:30:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:30:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:30:00 INFO - 'opt_config_files': (), 04:30:00 INFO - 'pip_index': False, 04:30:00 INFO - 'suite': 'dromaeojs', 04:30:00 INFO - 'system_bits': '32', 04:30:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:30:00 INFO - 'title': 'talos-linux64-ix-042', 04:30:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:30:00 INFO - 'use_talos_json': True, 04:30:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:30:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:30:00 INFO - 'work_dir': 'build'} 04:30:00 INFO - [mozharness: 2017-03-27 11:30:00.482575Z] Running clobber step. 04:30:00 INFO - Running pre-action listener: _resource_record_pre_action 04:30:00 INFO - Running main action method: clobber 04:30:00 INFO - rmtree: /builds/slave/test/build 04:30:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:30:01 INFO - Running post-action listener: _resource_record_post_action 04:30:01 INFO - [mozharness: 2017-03-27 11:30:01.956422Z] Finished clobber step (success) 04:30:01 INFO - [mozharness: 2017-03-27 11:30:01.956523Z] Running read-buildbot-config step. 04:30:01 INFO - Running pre-action listener: _resource_record_pre_action 04:30:01 INFO - Running main action method: read_buildbot_config 04:30:01 INFO - Using buildbot properties: 04:30:01 INFO - { 04:30:01 INFO - "project": "", 04:30:01 INFO - "product": "firefox", 04:30:01 INFO - "who": "cbook@mozilla.com", 04:30:01 INFO - "installer_path": "public/build/target.tar.bz2", 04:30:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:30:01 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:30:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:30:01 INFO - "stage_platform": "linux64", 04:30:01 INFO - "basedir": "/builds/slave/test", 04:30:01 INFO - "buildnumber": 901, 04:30:01 INFO - "platform": "ubuntu64_hw", 04:30:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:30:01 INFO - "slavebuilddir": "test", 04:30:01 INFO - "taskId": "aSdZVGv6RxmEokt94uiaCw", 04:30:01 INFO - "branch": "mozilla-central", 04:30:01 INFO - "script_repo_revision": "production", 04:30:01 INFO - "revision": "9577ddeaafd85554c2a855f385a87472a089d5c0", 04:30:01 INFO - "slavename": "talos-linux64-ix-042", 04:30:01 INFO - "repo_path": "mozilla-central" 04:30:01 INFO - } 04:30:01 INFO - Finding installer, test and symbols from parent task. 04:30:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aSdZVGv6RxmEokt94uiaCw'}, attempt #1 04:30:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aSdZVGv6RxmEokt94uiaCw'}, attempt #1 04:30:03 INFO - Task dependencies: NHWnFCYqQ9O1R46PMmJ_dQ 04:30:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ'}, attempt #1 04:30:03 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.tar.bz2 04:30:03 INFO - Set test_url: https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/test_packages.json 04:30:03 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.crashreporter-symbols.zip 04:30:03 INFO - Running post-action listener: _resource_record_post_action 04:30:03 INFO - [mozharness: 2017-03-27 11:30:03.712941Z] Finished read-buildbot-config step (success) 04:30:03 INFO - [mozharness: 2017-03-27 11:30:03.713164Z] Running download-and-extract step. 04:30:03 INFO - Running pre-action listener: _resource_record_pre_action 04:30:03 INFO - Running main action method: download_and_extract 04:30:03 INFO - mkdir: /builds/slave/test/build/tests 04:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:03 INFO - trying https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.test_packages.json 04:30:03 INFO - Downloading https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:30:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:30:04 INFO - Downloaded 986 bytes. 04:30:04 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:30:04 INFO - Using the following test package requirements: 04:30:04 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:30:04 INFO - u'common': [u'target.common.tests.zip'], 04:30:04 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:30:04 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:30:04 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:30:04 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:30:04 INFO - u'mozbase': [u'target.common.tests.zip'], 04:30:04 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:30:04 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:30:04 INFO - u'web-platform': [u'target.common.tests.zip', 04:30:04 INFO - u'target.web-platform.tests.zip'], 04:30:04 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:30:04 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:30:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.common.tests.zip 04:30:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:30:04 INFO - Fetch https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.common.tests.zip into memory 04:30:05 INFO - Expected file size: 58140496 04:30:05 INFO - Obtained file size: 58140496 04:30:15 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:30:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.common.tests.zip 04:30:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:30:15 INFO - Fetch https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.common.tests.zip into memory 04:30:16 INFO - Expected file size: 58140496 04:30:16 INFO - Obtained file size: 58140496 04:30:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.talos.tests.zip 04:30:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:30:27 INFO - Fetch https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.talos.tests.zip into memory 04:30:31 INFO - Expected file size: 14404171 04:30:31 INFO - Obtained file size: 14404171 04:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:31 INFO - trying https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.tar.bz2 04:30:31 INFO - Downloading https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:30:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:30:33 INFO - Downloaded 62583801 bytes. 04:30:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.tar.bz2 04:30:33 INFO - mkdir: /builds/slave/test/properties 04:30:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:30:33 INFO - Writing to file /builds/slave/test/properties/build_url 04:30:33 INFO - Contents: 04:30:33 INFO - build_url:https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.tar.bz2 04:30:33 INFO - Running post-action listener: _resource_record_post_action 04:30:33 INFO - Running post-action listener: set_extra_try_arguments 04:30:33 INFO - [mozharness: 2017-03-27 11:30:33.170393Z] Finished download-and-extract step (success) 04:30:33 INFO - [mozharness: 2017-03-27 11:30:33.170492Z] Running populate-webroot step. 04:30:33 INFO - Running pre-action listener: _resource_record_pre_action 04:30:33 INFO - Running main action method: populate_webroot 04:30:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:30:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:30:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:30:33 INFO - '--tppagecycles', 04:30:33 INFO - '7'], 04:30:33 INFO - 'tests': ['tsvgm']}}, 04:30:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:30:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:30:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:30:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:30:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:30:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:30:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:30:33 INFO - 'talos_options': ['--disable-e10s'], 04:30:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:30:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:30:33 INFO - 'talos_options': ['--disable-e10s'], 04:30:33 INFO - 'tests': ['damp', 'tps']}, 04:30:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:30:33 INFO - 'tests': ['damp', 'tps']}, 04:30:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:30:33 INFO - 'tests': ['dromaeo_dom']}, 04:30:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:30:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:30:33 INFO - 'tests': ['basic_compositor_video']}, 04:30:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:30:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:30:33 INFO - 'tests': ['a11yr', 04:30:33 INFO - 'ts_paint', 04:30:33 INFO - 'tpaint', 04:30:33 INFO - 'sessionrestore', 04:30:33 INFO - 'sessionrestore_no_auto_restore', 04:30:33 INFO - 'tabpaint']}, 04:30:33 INFO - 'other-e10s': {'tests': ['a11yr', 04:30:33 INFO - 'ts_paint', 04:30:33 INFO - 'tpaint', 04:30:33 INFO - 'sessionrestore', 04:30:33 INFO - 'sessionrestore_no_auto_restore', 04:30:33 INFO - 'tabpaint']}, 04:30:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:30:33 INFO - 'ts_paint', 04:30:33 INFO - 'tpaint', 04:30:33 INFO - 'sessionrestore', 04:30:33 INFO - 'sessionrestore_no_auto_restore', 04:30:33 INFO - 'tabpaint']}, 04:30:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:30:33 INFO - 'ts_paint', 04:30:33 INFO - 'tpaint', 04:30:33 INFO - 'sessionrestore', 04:30:33 INFO - 'sessionrestore_no_auto_restore', 04:30:33 INFO - 'tabpaint']}, 04:30:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:30:33 INFO - 'tests': ['a11yr', 04:30:33 INFO - 'ts_paint', 04:30:33 INFO - 'tpaint', 04:30:33 INFO - 'sessionrestore', 04:30:33 INFO - 'sessionrestore_no_auto_restore', 04:30:33 INFO - 'tabpaint']}, 04:30:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:30:33 INFO - 'tests': ['a11yr', 04:30:33 INFO - 'ts_paint', 04:30:33 INFO - 'tpaint', 04:30:33 INFO - 'sessionrestore', 04:30:33 INFO - 'sessionrestore_no_auto_restore', 04:30:33 INFO - 'tabpaint']}, 04:30:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:30:33 INFO - 'tests': ['tsvgx', 04:30:33 INFO - 'tsvgr_opacity', 04:30:33 INFO - 'tart', 04:30:33 INFO - 'tscrollx', 04:30:33 INFO - 'cart', 04:30:33 INFO - 'tsvg_static']}, 04:30:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:30:33 INFO - 'tsvgr_opacity', 04:30:33 INFO - 'tart', 04:30:33 INFO - 'tscrollx', 04:30:33 INFO - 'cart', 04:30:33 INFO - 'tsvg_static']}, 04:30:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:30:33 INFO - 'talos_options': ['--disable-e10s'], 04:30:33 INFO - 'tests': ['tp5o']}, 04:30:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:30:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:30:33 INFO - 'talos_options': ['--disable-e10s', 04:30:33 INFO - '--xperf_path', 04:30:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:33 INFO - 'tests': ['tp5n']}, 04:30:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:30:33 INFO - 'talos_options': ['--xperf_path', 04:30:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:33 INFO - 'tests': ['tp5n']}}, 04:30:33 INFO - 'talos.zip': {'path': '', 04:30:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:30:33 INFO - Running post-action listener: _resource_record_post_action 04:30:33 INFO - [mozharness: 2017-03-27 11:30:33.183750Z] Finished populate-webroot step (success) 04:30:33 INFO - [mozharness: 2017-03-27 11:30:33.183840Z] Running create-virtualenv step. 04:30:33 INFO - Running pre-action listener: _resource_record_pre_action 04:30:33 INFO - Running main action method: create_virtualenv 04:30:33 INFO - Creating virtualenv /builds/slave/test/build/venv 04:30:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:30:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:30:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:30:33 INFO - Using real prefix '/usr' 04:30:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:30:33 INFO - Installing distribute.............................................................................................................................................................................................done. 04:30:35 INFO - Installing pip.................done. 04:30:35 INFO - Return code: 0 04:30:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:30:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:30:35 INFO - Reading from file tmpfile_stdout 04:30:35 INFO - Output received: 04:30:35 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:30:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:30:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c2290>, '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 0x25c2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c3040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:30:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:30:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:30:36 INFO - Using env: {'DISPLAY': ':0', 04:30:36 INFO - 'HOME': '/home/cltbld', 04:30:36 INFO - 'LANG': 'en_US.UTF-8', 04:30:36 INFO - 'LANGUAGE': 'en_US:en', 04:30:36 INFO - 'LOGNAME': 'cltbld', 04:30:36 INFO - 'MAIL': '/var/mail/cltbld', 04:30:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:36 INFO - 'MOZ_NO_REMOTE': '1', 04:30:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:36 INFO - 'NO_EM_RESTART': '1', 04:30:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:36 INFO - 'PWD': '/builds/slave/test', 04:30:36 INFO - 'SHELL': '/bin/bash', 04:30:36 INFO - 'SHLVL': '1', 04:30:36 INFO - 'TERM': 'linux', 04:30:36 INFO - 'TMOUT': '86400', 04:30:36 INFO - 'USER': 'cltbld', 04:30:36 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501', 04:30:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:36 INFO - '_': '/tools/buildbot/bin/python'} 04:30:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:30:36 INFO - Cleaning up... 04:30:36 INFO - Return code: 0 04:30:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c2290>, '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 0x25c2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c3040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:30:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:30:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:30:36 INFO - Using env: {'DISPLAY': ':0', 04:30:36 INFO - 'HOME': '/home/cltbld', 04:30:36 INFO - 'LANG': 'en_US.UTF-8', 04:30:36 INFO - 'LANGUAGE': 'en_US:en', 04:30:36 INFO - 'LOGNAME': 'cltbld', 04:30:36 INFO - 'MAIL': '/var/mail/cltbld', 04:30:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:36 INFO - 'MOZ_NO_REMOTE': '1', 04:30:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:36 INFO - 'NO_EM_RESTART': '1', 04:30:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:36 INFO - 'PWD': '/builds/slave/test', 04:30:36 INFO - 'SHELL': '/bin/bash', 04:30:36 INFO - 'SHLVL': '1', 04:30:36 INFO - 'TERM': 'linux', 04:30:36 INFO - 'TMOUT': '86400', 04:30:36 INFO - 'USER': 'cltbld', 04:30:36 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501', 04:30:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:36 INFO - '_': '/tools/buildbot/bin/python'} 04:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:37 INFO - Downloading/unpacking psutil>=3.1.1 04:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:30:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:39 INFO - Installing collected packages: psutil 04:30:39 INFO - Running setup.py install for psutil 04:30:39 INFO - building 'psutil._psutil_linux' extension 04:30:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:30:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:30:39 INFO - building 'psutil._psutil_posix' extension 04:30:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:30:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:30:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:39 INFO - Successfully installed psutil 04:30:39 INFO - Cleaning up... 04:30:39 INFO - Return code: 0 04:30:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:40 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 0x23271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c2290>, '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 0x25c2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c3040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:30:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:30:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:30:40 INFO - Using env: {'DISPLAY': ':0', 04:30:40 INFO - 'HOME': '/home/cltbld', 04:30:40 INFO - 'LANG': 'en_US.UTF-8', 04:30:40 INFO - 'LANGUAGE': 'en_US:en', 04:30:40 INFO - 'LOGNAME': 'cltbld', 04:30:40 INFO - 'MAIL': '/var/mail/cltbld', 04:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:40 INFO - 'MOZ_NO_REMOTE': '1', 04:30:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:40 INFO - 'NO_EM_RESTART': '1', 04:30:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:40 INFO - 'PWD': '/builds/slave/test', 04:30:40 INFO - 'SHELL': '/bin/bash', 04:30:40 INFO - 'SHLVL': '1', 04:30:40 INFO - 'TERM': 'linux', 04:30:40 INFO - 'TMOUT': '86400', 04:30:40 INFO - 'USER': 'cltbld', 04:30:40 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501', 04:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:40 INFO - '_': '/tools/buildbot/bin/python'} 04:30:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:30:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:30:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:30:44 INFO - Installing collected packages: mozsystemmonitor 04:30:44 INFO - Running setup.py install for mozsystemmonitor 04:30:44 INFO - Successfully installed mozsystemmonitor 04:30:44 INFO - Cleaning up... 04:30:44 INFO - Return code: 0 04:30:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:45 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 0x23271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c2290>, '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 0x25c2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c3040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:30:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:30:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:30:45 INFO - Using env: {'DISPLAY': ':0', 04:30:45 INFO - 'HOME': '/home/cltbld', 04:30:45 INFO - 'LANG': 'en_US.UTF-8', 04:30:45 INFO - 'LANGUAGE': 'en_US:en', 04:30:45 INFO - 'LOGNAME': 'cltbld', 04:30:45 INFO - 'MAIL': '/var/mail/cltbld', 04:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:45 INFO - 'MOZ_NO_REMOTE': '1', 04:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:45 INFO - 'NO_EM_RESTART': '1', 04:30:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:45 INFO - 'PWD': '/builds/slave/test', 04:30:45 INFO - 'SHELL': '/bin/bash', 04:30:45 INFO - 'SHLVL': '1', 04:30:45 INFO - 'TERM': 'linux', 04:30:45 INFO - 'TMOUT': '86400', 04:30:45 INFO - 'USER': 'cltbld', 04:30:45 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501', 04:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:45 INFO - '_': '/tools/buildbot/bin/python'} 04:30:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:45 INFO - Downloading/unpacking jsonschema==2.5.1 04:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:30:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:47 INFO - Downloading functools32-3.2.3-2.tar.gz 04:30:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:30:48 INFO - warning: no files found matching '*.txt' 04:30:48 INFO - no previously-included directories found matching 'build' 04:30:48 INFO - no previously-included directories found matching 'dist' 04:30:48 INFO - no previously-included directories found matching '.git*' 04:30:48 INFO - Installing collected packages: jsonschema, functools32 04:30:48 INFO - Running setup.py install for functools32 04:30:48 INFO - warning: no files found matching '*.txt' 04:30:48 INFO - no previously-included directories found matching 'build' 04:30:48 INFO - no previously-included directories found matching 'dist' 04:30:48 INFO - no previously-included directories found matching '.git*' 04:30:48 INFO - Successfully installed jsonschema functools32 04:30:48 INFO - Cleaning up... 04:30:48 INFO - Return code: 0 04:30:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:48 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 0x23271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c2290>, '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 0x25c2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c3040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:30:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:30:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:30:48 INFO - Using env: {'DISPLAY': ':0', 04:30:48 INFO - 'HOME': '/home/cltbld', 04:30:48 INFO - 'LANG': 'en_US.UTF-8', 04:30:48 INFO - 'LANGUAGE': 'en_US:en', 04:30:48 INFO - 'LOGNAME': 'cltbld', 04:30:48 INFO - 'MAIL': '/var/mail/cltbld', 04:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:48 INFO - 'MOZ_NO_REMOTE': '1', 04:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:48 INFO - 'NO_EM_RESTART': '1', 04:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:48 INFO - 'PWD': '/builds/slave/test', 04:30:48 INFO - 'SHELL': '/bin/bash', 04:30:48 INFO - 'SHLVL': '1', 04:30:48 INFO - 'TERM': 'linux', 04:30:48 INFO - 'TMOUT': '86400', 04:30:48 INFO - 'USER': 'cltbld', 04:30:48 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501', 04:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:48 INFO - '_': '/tools/buildbot/bin/python'} 04:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:30:48 INFO - Cleaning up... 04:30:48 INFO - Return code: 0 04:30:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:49 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 0x23271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c2290>, '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 0x25c2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c3040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:30:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:30:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:30:49 INFO - Using env: {'DISPLAY': ':0', 04:30:49 INFO - 'HOME': '/home/cltbld', 04:30:49 INFO - 'LANG': 'en_US.UTF-8', 04:30:49 INFO - 'LANGUAGE': 'en_US:en', 04:30:49 INFO - 'LOGNAME': 'cltbld', 04:30:49 INFO - 'MAIL': '/var/mail/cltbld', 04:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:49 INFO - 'MOZ_NO_REMOTE': '1', 04:30:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:49 INFO - 'NO_EM_RESTART': '1', 04:30:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:49 INFO - 'PWD': '/builds/slave/test', 04:30:49 INFO - 'SHELL': '/bin/bash', 04:30:49 INFO - 'SHLVL': '1', 04:30:49 INFO - 'TERM': 'linux', 04:30:49 INFO - 'TMOUT': '86400', 04:30:49 INFO - 'USER': 'cltbld', 04:30:49 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501', 04:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:49 INFO - '_': '/tools/buildbot/bin/python'} 04:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:49 INFO - Downloading/unpacking blobuploader==1.2.4 04:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:52 INFO - Downloading blobuploader-1.2.4.tar.gz 04:30:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:30:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:30:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:52 INFO - Downloading docopt-0.6.1.tar.gz 04:30:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:30:53 INFO - Installing collected packages: blobuploader, requests, docopt 04:30:53 INFO - Running setup.py install for blobuploader 04:30:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:30:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:30:53 INFO - Running setup.py install for requests 04:30:53 INFO - Running setup.py install for docopt 04:30:53 INFO - Successfully installed blobuploader requests docopt 04:30:53 INFO - Cleaning up... 04:30:53 INFO - Return code: 0 04:30:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:53 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 0x23271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c2290>, '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 0x25c2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c3040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:30:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:30:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:30:53 INFO - Using env: {'DISPLAY': ':0', 04:30:53 INFO - 'HOME': '/home/cltbld', 04:30:53 INFO - 'LANG': 'en_US.UTF-8', 04:30:53 INFO - 'LANGUAGE': 'en_US:en', 04:30:53 INFO - 'LOGNAME': 'cltbld', 04:30:53 INFO - 'MAIL': '/var/mail/cltbld', 04:30:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:53 INFO - 'MOZ_NO_REMOTE': '1', 04:30:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:53 INFO - 'NO_EM_RESTART': '1', 04:30:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:53 INFO - 'PWD': '/builds/slave/test', 04:30:53 INFO - 'SHELL': '/bin/bash', 04:30:53 INFO - 'SHLVL': '1', 04:30:53 INFO - 'TERM': 'linux', 04:30:53 INFO - 'TMOUT': '86400', 04:30:53 INFO - 'USER': 'cltbld', 04:30:53 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501', 04:30:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:53 INFO - '_': '/tools/buildbot/bin/python'} 04:30:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:30:54 INFO - Running setup.py (path:/tmp/pip-1rwHKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:30:54 INFO - Running setup.py (path:/tmp/pip-AMdQa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:30:54 INFO - Running setup.py (path:/tmp/pip-xwjVMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:30:54 INFO - Running setup.py (path:/tmp/pip-E7CJjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:30:54 INFO - Running setup.py (path:/tmp/pip-mXDEto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:30:54 INFO - Running setup.py (path:/tmp/pip-jX_ynK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:30:54 INFO - Running setup.py (path:/tmp/pip-qAt6BV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:30:54 INFO - Running setup.py (path:/tmp/pip-MqgKRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:30:54 INFO - Running setup.py (path:/tmp/pip-PbfPki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:30:54 INFO - Running setup.py (path:/tmp/pip-BM5o2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:30:54 INFO - Running setup.py (path:/tmp/pip-U7cH2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:30:54 INFO - Running setup.py (path:/tmp/pip-UBt11O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:30:54 INFO - Running setup.py (path:/tmp/pip-pBx7UR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:30:54 INFO - Running setup.py (path:/tmp/pip-MHABhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:55 INFO - Running setup.py (path:/tmp/pip-Tkjwsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:30:55 INFO - Running setup.py (path:/tmp/pip-MlCOca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:30:55 INFO - Running setup.py (path:/tmp/pip-mKHUJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:30:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:30:55 INFO - Running setup.py install for manifestparser 04:30:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:30:55 INFO - Running setup.py install for mozcrash 04:30:55 INFO - Running setup.py install for mozdebug 04:30:55 INFO - Running setup.py install for mozdevice 04:30:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:30:55 INFO - Running setup.py install for mozfile 04:30:55 INFO - Running setup.py install for mozhttpd 04:30:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:30:55 INFO - Running setup.py install for mozinfo 04:30:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:30:55 INFO - Running setup.py install for mozInstall 04:30:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:30:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:30:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:30:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:30:56 INFO - Running setup.py install for mozleak 04:30:56 INFO - Running setup.py install for mozlog 04:30:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:30:56 INFO - Running setup.py install for moznetwork 04:30:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:30:56 INFO - Running setup.py install for mozprocess 04:30:56 INFO - Running setup.py install for mozprofile 04:30:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:30:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:30:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:30:56 INFO - Running setup.py install for mozrunner 04:30:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:30:56 INFO - Running setup.py install for mozscreenshot 04:30:56 INFO - Running setup.py install for moztest 04:30:56 INFO - Running setup.py install for mozversion 04:30:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:30:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:30:57 INFO - Cleaning up... 04:30:57 INFO - Return code: 0 04:30:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:57 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 0x23271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c2290>, '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 0x25c2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c3040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:30:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:30:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:30:57 INFO - Using env: {'DISPLAY': ':0', 04:30:57 INFO - 'HOME': '/home/cltbld', 04:30:57 INFO - 'LANG': 'en_US.UTF-8', 04:30:57 INFO - 'LANGUAGE': 'en_US:en', 04:30:57 INFO - 'LOGNAME': 'cltbld', 04:30:57 INFO - 'MAIL': '/var/mail/cltbld', 04:30:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:57 INFO - 'MOZ_NO_REMOTE': '1', 04:30:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:57 INFO - 'NO_EM_RESTART': '1', 04:30:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:57 INFO - 'PWD': '/builds/slave/test', 04:30:57 INFO - 'SHELL': '/bin/bash', 04:30:57 INFO - 'SHLVL': '1', 04:30:57 INFO - 'TERM': 'linux', 04:30:57 INFO - 'TMOUT': '86400', 04:30:57 INFO - 'USER': 'cltbld', 04:30:57 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501', 04:30:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:57 INFO - '_': '/tools/buildbot/bin/python'} 04:30:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:30:57 INFO - Running setup.py (path:/tmp/pip-7liSfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:30:57 INFO - Running setup.py (path:/tmp/pip-VeTLNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:30:57 INFO - Running setup.py (path:/tmp/pip-NmLx4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:30:57 INFO - Running setup.py (path:/tmp/pip-6u2YOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:30:57 INFO - Running setup.py (path:/tmp/pip-JJvXPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:30:57 INFO - Running setup.py (path:/tmp/pip-5U0IZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:30:57 INFO - Running setup.py (path:/tmp/pip-4TzC0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:30:57 INFO - Running setup.py (path:/tmp/pip-nPIZi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:30:57 INFO - Running setup.py (path:/tmp/pip-Pm_suG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:30:58 INFO - Running setup.py (path:/tmp/pip-7j1g7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:30:58 INFO - Running setup.py (path:/tmp/pip-I3JGbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:30:58 INFO - Running setup.py (path:/tmp/pip-8TRgy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:30:58 INFO - Running setup.py (path:/tmp/pip-VOh8gO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:30:58 INFO - Running setup.py (path:/tmp/pip-anIMZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:58 INFO - Running setup.py (path:/tmp/pip-9kAgYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:30:58 INFO - Running setup.py (path:/tmp/pip-KF0aNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:30:58 INFO - Running setup.py (path:/tmp/pip-8LrZEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:30:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:02 INFO - Downloading blessings-1.6.tar.gz 04:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:31:02 INFO - Installing collected packages: blessings 04:31:02 INFO - Running setup.py install for blessings 04:31:02 INFO - Successfully installed blessings 04:31:02 INFO - Cleaning up... 04:31:02 INFO - Return code: 0 04:31:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:31:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:02 INFO - Reading from file tmpfile_stdout 04:31:02 INFO - Current package versions: 04:31:02 INFO - argparse == 1.2.1 04:31:02 INFO - blessings == 1.6 04:31:02 INFO - blobuploader == 1.2.4 04:31:02 INFO - docopt == 0.6.1 04:31:02 INFO - functools32 == 3.2.3-2 04:31:02 INFO - jsonschema == 2.5.1 04:31:02 INFO - manifestparser == 1.1 04:31:02 INFO - mozInstall == 1.12 04:31:02 INFO - mozcrash == 1.0 04:31:02 INFO - mozdebug == 0.1 04:31:02 INFO - mozdevice == 0.49 04:31:02 INFO - mozfile == 1.2 04:31:02 INFO - mozhttpd == 0.7 04:31:02 INFO - mozinfo == 0.9 04:31:02 INFO - mozleak == 0.1 04:31:02 INFO - mozlog == 3.4 04:31:02 INFO - moznetwork == 0.27 04:31:02 INFO - mozprocess == 0.25 04:31:02 INFO - mozprofile == 0.28 04:31:02 INFO - mozrunner == 6.13 04:31:02 INFO - mozscreenshot == 0.1 04:31:02 INFO - mozsystemmonitor == 0.3 04:31:02 INFO - moztest == 0.8 04:31:02 INFO - mozversion == 1.4 04:31:02 INFO - psutil == 3.1.1 04:31:02 INFO - requests == 1.2.3 04:31:02 INFO - wsgiref == 0.1.2 04:31:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:03 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 0x23271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c2290>, '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 0x25c2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c3040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:03 INFO - Using env: {'DISPLAY': ':0', 04:31:03 INFO - 'HOME': '/home/cltbld', 04:31:03 INFO - 'LANG': 'en_US.UTF-8', 04:31:03 INFO - 'LANGUAGE': 'en_US:en', 04:31:03 INFO - 'LOGNAME': 'cltbld', 04:31:03 INFO - 'MAIL': '/var/mail/cltbld', 04:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:03 INFO - 'MOZ_NO_REMOTE': '1', 04:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:03 INFO - 'NO_EM_RESTART': '1', 04:31:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:03 INFO - 'PWD': '/builds/slave/test', 04:31:03 INFO - 'SHELL': '/bin/bash', 04:31:03 INFO - 'SHLVL': '1', 04:31:03 INFO - 'TERM': 'linux', 04:31:03 INFO - 'TMOUT': '86400', 04:31:03 INFO - 'USER': 'cltbld', 04:31:03 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501', 04:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:03 INFO - '_': '/tools/buildbot/bin/python'} 04:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:31:03 INFO - Cleaning up... 04:31:03 INFO - Return code: 0 04:31:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c2290>, '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 0x25c2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c3040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:31:03 INFO - Using env: {'DISPLAY': ':0', 04:31:03 INFO - 'HOME': '/home/cltbld', 04:31:03 INFO - 'LANG': 'en_US.UTF-8', 04:31:03 INFO - 'LANGUAGE': 'en_US:en', 04:31:03 INFO - 'LOGNAME': 'cltbld', 04:31:03 INFO - 'MAIL': '/var/mail/cltbld', 04:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:03 INFO - 'MOZ_NO_REMOTE': '1', 04:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:03 INFO - 'NO_EM_RESTART': '1', 04:31:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:03 INFO - 'PWD': '/builds/slave/test', 04:31:03 INFO - 'SHELL': '/bin/bash', 04:31:03 INFO - 'SHLVL': '1', 04:31:03 INFO - 'TERM': 'linux', 04:31:03 INFO - 'TMOUT': '86400', 04:31:03 INFO - 'USER': 'cltbld', 04:31:03 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501', 04:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:03 INFO - '_': '/tools/buildbot/bin/python'} 04:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:31:03 INFO - Cleaning up... 04:31:03 INFO - Return code: 0 04:31:03 INFO - Running post-action listener: _resource_record_post_action 04:31:03 INFO - Running post-action listener: _start_resource_monitoring 04:31:03 INFO - Starting resource monitoring. 04:31:03 INFO - [mozharness: 2017-03-27 11:31:03.769155Z] Finished create-virtualenv step (success) 04:31:03 INFO - [mozharness: 2017-03-27 11:31:03.769618Z] Running install step. 04:31:03 INFO - Running pre-action listener: _resource_record_pre_action 04:31:03 INFO - Running main action method: install 04:31:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:03 INFO - Reading from file tmpfile_stdout 04:31:03 INFO - Detecting whether we're running mozinstall >=1.0... 04:31:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:31:04 INFO - Reading from file tmpfile_stdout 04:31:04 INFO - Output received: 04:31:04 INFO - Usage: mozinstall [options] installer 04:31:04 INFO - Options: 04:31:04 INFO - -h, --help show this help message and exit 04:31:04 INFO - -d DEST, --destination=DEST 04:31:04 INFO - Directory to install application into. [default: 04:31:04 INFO - "/builds/slave/test"] 04:31:04 INFO - --app=APP Application being installed. [default: firefox] 04:31:04 INFO - mkdir: /builds/slave/test/build/application 04:31:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:31:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:31:19 INFO - Reading from file tmpfile_stdout 04:31:19 INFO - Output received: 04:31:19 INFO - /builds/slave/test/build/application/firefox/firefox 04:31:19 INFO - Running post-action listener: _resource_record_post_action 04:31:19 INFO - [mozharness: 2017-03-27 11:31:19.711241Z] Finished install step (success) 04:31:19 INFO - [mozharness: 2017-03-27 11:31:19.711515Z] Running run-tests step. 04:31:19 INFO - Running pre-action listener: _resource_record_pre_action 04:31:19 INFO - Running main action method: run_tests 04:31:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:31:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:31:19 INFO - Python 2.7.3 04:31:19 INFO - Return code: 0 04:31:19 INFO - grabbing minidump binary from tooltool 04:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:19 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 0x25c2290>, '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 0x25c2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c3040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:31:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:31:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:31:19 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:31:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:31:19 INFO - Return code: 0 04:31:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:31:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:31:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:31:19 INFO - ENV: RUST_BACKTRACE is now 1 04:31:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:31:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:31:19 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/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 04:31:19 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/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 04:31:19 INFO - Using env: {'DISPLAY': ':0', 04:31:19 INFO - 'HOME': '/home/cltbld', 04:31:19 INFO - 'LANG': 'en_US.UTF-8', 04:31:19 INFO - 'LANGUAGE': 'en_US:en', 04:31:19 INFO - 'LOGNAME': 'cltbld', 04:31:19 INFO - 'MAIL': '/var/mail/cltbld', 04:31:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:31:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:31:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:19 INFO - 'MOZ_NO_REMOTE': '1', 04:31:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:31:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:19 INFO - 'NO_EM_RESTART': '1', 04:31:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:19 INFO - 'PWD': '/builds/slave/test', 04:31:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:31:19 INFO - 'RUST_BACKTRACE': '1', 04:31:19 INFO - 'SHELL': '/bin/bash', 04:31:19 INFO - 'SHLVL': '1', 04:31:19 INFO - 'TERM': 'linux', 04:31:19 INFO - 'TMOUT': '86400', 04:31:19 INFO - 'USER': 'cltbld', 04:31:19 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501', 04:31:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:19 INFO - '_': '/tools/buildbot/bin/python'} 04:31:19 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/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 04:31:19 INFO - mozversion application_buildid: 20170327105736 04:31:19 INFO - mozversion application_changeset: 9577ddeaafd85554c2a855f385a87472a089d5c0 04:31:19 INFO - mozversion application_display_name: Nightly 04:31:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:31:19 INFO - mozversion application_name: Firefox 04:31:19 INFO - mozversion application_remotingname: firefox 04:31:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:31:19 INFO - mozversion application_vendor: Mozilla 04:31:19 INFO - mozversion application_version: 55.0a1 04:31:19 INFO - mozversion platform_buildid: 20170327105736 04:31:19 INFO - mozversion platform_changeset: 9577ddeaafd85554c2a855f385a87472a089d5c0 04:31:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:31:19 INFO - mozversion platform_version: 55.0a1 04:31:19 INFO - using testdate: 1490614279 04:31:19 INFO - actual date: 1490614279 04:31:19 INFO - starting webserver on 'localhost:52492' 04:31:19 INFO - SUITE-START | Running 2 tests 04:31:19 INFO - TEST-START | dromaeo_css 04:31:19 INFO - operating with platform_type : linux_ 04:31:19 INFO - Initialising browser for dromaeo_css test... 04:31:20 INFO - TEST-INFO | started process 20671 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpktJV5G/profile http://localhost:52492/getInfo.html) 04:31:24 INFO - PID 20671 | __metrics Screen width/height:1600/1200 04:31:24 INFO - PID 20671 | colorDepth:24 04:31:24 INFO - PID 20671 | Browser inner width/height: 1024/697 04:31:24 INFO - PID 20671 | __metrics 04:31:25 ERROR - PID 20671 | 1490614285031 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 04:31:25 INFO - PID 20671 | 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" 04:31:25 INFO - PID 20671 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:31:26 INFO - TEST-INFO | 20671: exit 0 04:31:26 INFO - Browser initialized. 04:31:26 INFO - Running cycle 1/1 for dromaeo_css test... 04:31:26 INFO - TEST-INFO | started process 20765 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpktJV5G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:31:38 INFO - PID 20765 | RSS: Main: 150081536 04:31:38 INFO - PID 20765 | 04:34:44 INFO - PID 20765 | Cycle 1(1): loaded http://localhost:52492/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52492/tests/dromaeo/cssquery-ext.html) 04:34:46 INFO - PID 20765 | RSS: Main: 298319872 04:34:46 INFO - PID 20765 | 04:36:28 INFO - PID 20765 | ************************* 04:36:28 INFO - PID 20765 | A coding exception was thrown and uncaught in a Task. 04:36:28 INFO - PID 20765 | 04:36:28 ERROR - PID 20765 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:36:28 INFO - PID 20765 | Full stack: 04:36:28 INFO - PID 20765 | ************************* 04:36:28 INFO - PID 20765 | ************************* 04:36:28 INFO - PID 20765 | A coding exception was thrown and uncaught in a Task. 04:36:28 INFO - PID 20765 | 04:36:28 ERROR - PID 20765 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:36:28 INFO - PID 20765 | Full stack: 04:36:28 INFO - PID 20765 | ************************* 04:36:28 INFO - PID 20765 | ************************* 04:36:28 INFO - PID 20765 | A coding exception was thrown and uncaught in a Task. 04:36:28 INFO - PID 20765 | 04:36:28 ERROR - PID 20765 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:36:28 INFO - PID 20765 | Full stack: 04:36:28 INFO - PID 20765 | ************************* 04:36:28 INFO - PID 20765 | ************************* 04:36:28 INFO - PID 20765 | A coding exception was thrown and uncaught in a Task. 04:36:28 INFO - PID 20765 | 04:36:28 ERROR - PID 20765 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:36:28 INFO - PID 20765 | Full stack: 04:36:28 INFO - PID 20765 | ************************* 04:37:49 INFO - PID 20765 | Cycle 1(1): loaded http://localhost:52492/tests/dromaeo/cssquery-ext.html (next: http://localhost:52492/tests/dromaeo/cssquery-jquery.html) 04:37:49 INFO - PID 20765 | RSS: Main: 244948992 04:37:49 INFO - PID 20765 | 04:40:51 INFO - PID 20765 | Cycle 1(1): loaded http://localhost:52492/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52492/tests/dromaeo/cssquery-mootools.html) 04:40:52 INFO - PID 20765 | RSS: Main: 217624576 04:40:52 INFO - PID 20765 | 04:43:54 INFO - PID 20765 | Cycle 1(1): loaded http://localhost:52492/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52492/tests/dromaeo/cssquery-prototype.html) 04:43:55 INFO - PID 20765 | RSS: Main: 212320256 04:43:55 INFO - PID 20765 | 04:46:58 INFO - PID 20765 | Cycle 1(1): loaded http://localhost:52492/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52492/tests/dromaeo/cssquery-yui.html) 04:46:59 INFO - PID 20765 | RSS: Main: 180703232 04:46:59 INFO - PID 20765 | 04:50:02 INFO - PID 20765 | Cycle 1(1): loaded http://localhost:52492/tests/dromaeo/cssquery-yui.html (next: http://localhost:52492/tests/dromaeo/cssquery-dojo.html) 04:50:02 INFO - PID 20765 | RSS: Main: 269856768 04:50:02 INFO - PID 20765 | 04:50:02 INFO - PID 20765 | __start_tp_report 04:50:02 INFO - PID 20765 | _x_x_mozilla_page_load 04:50:02 INFO - PID 20765 | _x_x_mozilla_page_load_details 04:50:02 INFO - PID 20765 | |i|pagename|runs| 04:50:02 INFO - PID 20765 | |0;dojo.html;2692.8653567321635;2705.5535836586964;2714.6335244741954;2723.10137654574;2725.509408306505;5121.5390614844655;5192.454792246816;5260.132078207092;5295.655782374148;5300.363956325242;5285.471452854713;5296.417394086648;5298.23175639533;5335.093034184189;5336.519713225809;4748.477667456577;4793.137235297645;4817.710937343753;4899.069176856404;4935.185694360444;4841.854744357693;4875.853724388274;4897.951020489803;4915.041566894457;4919.7914079960265;4657.813687452498;4664.883377915579;4697.084068606623;4702.858914232578;4710.552497512731;4753.025629745928;4753.096911586787;4756.643251756098;4758.452777930548;4762.714237145782;4695.131400690849;4713.151632706112;4714.528547145258;4716.834910778106;4727.929081063787;5098.719570423626;5143.434222235551;5152.995165942642;5156.948430515685;5158.432572417031;5614.9719251403485;5615.887682246333;5648.576356773258;5663;5676.0066988276885;5635;5641.407652196502;5648.943510564883;5660.405657405954;5669.603127781057;5082.390113186368;5188.948110518922;5250.1337279349245;5256.92114618281;5300.628955973045;5776.595638305278;5810.477057064884;5812.59311848175;5813.3895940925595;5815.709214539341;5529.529989950899;5600.607957443021;5645.576581756384;5658.434156584309;5661.122526008476;5605.495505404533;5618.410066942912;5657.8019769307875;5675.006873797069;5689.6586204827845;5581.162825576196;5606.775728970877;5607.831765047055;5632.127020311858;5651.547876169897;5515.448455154533;5540.889182216414;5550.500454959073;5557.083081291623;5557.555395568425;4575.771211439482;4579.839705610288;4581.358609794632;4647.047355292157;4673.556012178838;3954.7429417087797;3962.7622342659533;3985.4221137934837;3986.541547722049;4017.196560687874;4798.160321943646;4804.015176888729;4807.134715751128;4850.1269771440775;4852.296417019513;5546.667199968015;5589.441055894378;5592.049351610236;5643.661380317194;5645.858853528694;4799.3760811095035;4855.247436647325;4872.4153101628035;4899.387576552931;4900.852974410774;5027.84916452507;5053.570446512014;5071.137906555894;5078.517540833689;5106.055379754757;5114.514121158484;5283.8414847555405;5292.7353632319;5345.973270133624;5347.171188465794;5675.57433192504;5691.715414229355;5696.943030569641;5751.654900705971;5784.82645520635;5305.416404195458;5307.124324486416;5348.331458567679;5348.384935732285;5357.892842143057;5610.775568977195;5610.915836262541;5613.887722245614;5615.634983726045;5623.409541998031;5524.116141417354;5596;5702.60081794287;5708.400617935057;5711.7429715662065;5374.596905232045;5383.703896285742;5480.3971563128825;5511.614187006871;5529.419410961791;5342.786288548415;5388.46115388458;5401.108817045144;5405.837824865261;5472.50747432733;5269.1832765921345;5320.627556071193;5327.547158491571;5330.331078320984;5394.649347792381;5452.618316717951;5484.533814625802;5494.862628434321;5522.696251706034;5525.198846167203;5430.728463576885;5436.592255580927;5446.673199608036;5477.123660214346;5481.985832620978 04:50:02 INFO - PID 20765 | |1;ext.html;650.9414152726257;722.7976166673332;740.4705635470638;1054.752133248686;1072.4101744040775;25534.61698074528;31164.68835311649;31324.530132048036;31393.215169620744;31404.84297578509;32609.347813043725;32900.67099329006;32979.34041319172;32990.50514242288;32999;5695.430456954292;7301.08736407949;7477.663505142282;7477.887831682529;7482.289182527651;5780.1907732917425;5867.941320586782;5868.3838196989345;5871.530277577805;7290.927090729105;7511.887321690179;7561.054868141482;7561.432892533055;7563.054618172729;7563.243675632448;7473.4021278297605;7526.661300241502;7530.623468826537;7535.208803075708;7536.321731044178;7337.0828646419195;7449.664765085584;7449.739259125959;7450.478466507347;7608.087029556434;34429.13927151841;34544.48183277253;34660.48009279863;34672;34698.47952280718;2590.745772496085;2595.8053146014126;2601.1416232643182;2617.450335429562;2650.1519513755607;21448.678269825967;21473.46316342088;21613.67579486309;21629.783702162935;21929.342119736433;2457.4716435966175;2476.5913624251975;2477.1330034487964;2500.624906264057;2503.5118151960373;141157;141944;142033;142204;142501;41006.58993410088;41007;41012;41039.58960410417;41073.58926410758;43107.35338969918;43202.56797432048;43214;43285.783571082575;43382;13476.39356228972;13816.37826297819;13834.93082534581;13840.653983650489;13850.861491384958;11077.501512431798;11082.113430925507;11086.113110951104;11090.112790976702;11099.72250693739;10953.83569246462;11138.832917506083;12734.68163295925;13280.335983200801;13628.114172578751;5391.924109217901;5415.0523658359625;5469.8085567005755;5473.890522189534;5534.529564987021;850.7107583421666;889.3863234368265;896.7847716548112;908.318760929303;921.1157289002632;21069.157233710786;21801.454963626034;21946.341609751733;21961.973545078967;22123.668144977837;961.1061712607342;968.8159249742527;972.2853702528777;975.4050029482011;1000.7448100734412;11469.54121835134;11469.713257168638;11501.252418592765;11506.597269095542;11543.711407214887;240339;242299;242633;242736;243022;42953.78523107427;43470.34794478086;43522.56477435248;43534.564654353686;43542;1207.8912897839236;1255.3723138430967;1257.8867901888873;1268.898488120948;1270.371166272701;20104.89947550253;20153.193872244945;21050.68423973672;21212.151513939887;21364.893175534024;31805.5229171558;31857;31873.68126318707;31909.840450797597;31934;214188;214396;215038;215214;215430;29604.170304043615;30033;30037.24906877258;30080.3983920316;30091.548626770178;25849.870750646125;26160.738392616593;31471.52792708157;31475.213119672193;36008.459873102445;23719.40701482408;23950.401239969142;23962.76037239675;24875.751242487342;25695;25668.87165564235;25697;25871.482570348864;25981.845960276987;27016.189514314603;25693;25804.612930805677;25910.35224119412;25910.87044564765;26012.8699356502;25361.365965851;25544.74455255498;25584.23247302584;26197.083102091336;26619.7338026625;21123.894380528;22189.55620887541;22344.77655223427;22395.664065039364;22474.775252247924 04:50:02 INFO - PID 20765 | |2;jquery.html;406.9552349241583;410.3577900585585;426.4860842684565;439.97140185887935;441.77469490559815;16923;17684.381046663355;18855.151518181665;18942.24231030757;19094.23623055076;16325.428609998653;16345.18274086294;16406.753898691528;18234.532230746227;18474.81525184751;5591.2731344925105;5615.7472913718775;5680.801171958982;5762.135679648044;5805.709714514279;5599.076152434844;5660.462256085665;5661.065924122515;5671.347795003566;5696.344920334173;5545.667259964395;5546.639468434539;5630.40880707526;5649.830505084834;5678.34699009613;5605.5515558755205;5680.261565996415;5680.573956953245;5686.175504551817;5689.203511508392;4984.22744474607;5032.04391165681;5067.797288108508;5076.213186956028;5076.5177308156035;22025.66961495579;22056.33830985073;22083.33749987503;22087.116515339527;22505.549889002294;1599.928003239857;1599.9760003599838;1607.2204980584406;1639.5819066138058;1656.2546853915665;13075.738485230337;13150.671233219246;13583.320833958263;14217.21805300708;14248.501302454468;1711.3496871188868;1734.0289437914682;1737.66984272989;1746.2482946793998;1764.7176451767784;87162;91512.54243728738;91755;92910;93300;10825.512851921525;10828.187885908588;10971.475938836878;11079.446027698583;11320.433978301053;15739.921300393653;15748.68502629941;15751.763723544156;15751.842481575037;15755.606109847116;7743.070831500256;7965.243301886311;8096.51420914747;8108.5945702714625;8187.672493100328;7392.667329970164;7399.778006659809;7404.703811847466;7572.621368931532;7622.58075805836;6941.7223311068;6955.330720627115;7031.7890463286185;7095.82260443493;7097.787066388017;1904.628597423489;1916.3867562379905;1922.7500424944667;1951.5363477391957;2155.5150091229348;752.5371896283856;767.9232076792276;772.9690812367555;787.9559583551817;794.9125596184415;15454.845451545341;15530.844691553166;15605.68788624221;15816.920915395349;16308.673826523403;788.7673136424769;793.4763056382875;794.9721759738381;799.1209669363653;812.4353574265829;8444.57777111142;8466.576671166416;8712;8746.475211487332;8878.067802880605;426014;426499;431110;433921;434506;81557.59221203857;82403.58798206091;82428.58785706153;83366.58316708378;86669.13330866737;1033.5194134727387;1058.3015209961543;1072.1958531101673;1072.9302595331278;1073.4149888310733;13312.866871331164;13384.330783460593;13740.381682824496;14027.088239264414;14028.78956815669;36164.63835361613;37668;38634.227315454096;40468.39297410482;41048.384274235315;51568.48431515637;51581.74209128931;54587.727061364436;55430.614234642846;55891.16163257473;10042.246831487522;10615.787684246117;10619.30974486656;10645.308054976402;11078.446077696244;11406.543738250377;11421.37182454973;11500.194986350874;11647.767044658889;11679.124065695276;9532.714018579454;9736.367136136128;9845;9889.406635601887;10100.54547545377;9180.724578262663;9241.260699143917;9372.437653740797;9398.483083430478;9537;9793.265505087005;10052;10064.345817521838;10143.949280253551;10543.367397956146;10473.528691208761;10608.151347892304;10660.25378223517;10765.461726913467;10888.836667449836;8667.306615470874;9495.715128546155;9910.950445247727;9939.055789699967;10183.643572474928 04:50:02 INFO - PID 20765 | |3;mootools.html;1122.0686829931158;1258.2576279994803;1271.9936400318002;1296.9481220751165;1302.7068909495363;8179.631916563754;9526.85709714354;9729.610815567377;9773.657921972732;9779.951100244489;9576.664816731416;9657.372270802392;9667.903320966805;9672.177864881494;9672.419654820716;1835.1191428114514;2090.770015298316;2138.4546940530145;2141.0579345088113;2141.9357419277367;1905.9714104288446;1928.8553358498098;1929.951751206217;1930.3243864647402;2074.917003319873;2086.926957556486;2089.153892673462;2091.9581608367826;2093.037202886674;2094.183268525276;1983.771866235387;1996.510854840566;2010.4672261850621;2010.9497262568407;2010.9497262568552;2012.5471768852037;2016.1733689187508;2016.3648450738117;2018.9293374731815;2019.2528764357135;9777.168940640055;9980.600775968953;9987.350822196606;9997.15024222942;10012.399256044588;5169.53474187325;5306.867328316823;5316.255724198615;5319.042572336978;5334.413214546396;2970.2277407873894;3078.291992841659;3212.052444528846;3234.0621219846216;3240.740740740735;1038.8649475568127;1055.5935964653663;1059.1156384419019;1066.328213225663;1072.8658917635296;13759.518416855362;14168.85831141696;14172.291385430688;14213;14898.180600066991;4681.806398599154;4696.412948381452;4783.856484305476;4852.757362131879;4874.390701162355;10842.891571084347;10856.131509479223;10884.020438160604;10906.291091079054;10908;5564.638298510584;5578.553715702734;5581.302337207849;5584.636998595079;5603.971980140073;4916.385451818523;5034.395872495324;5035.0685123252315;5065.11360511909;5103.234514822806;3338.082027442424;3413.675700808419;3663.7618554793853;3724.1248306647917;3796.335641262768;1068.4550879051585;1070.1224995503612;1083.5286650307141;1097.846301517788;1100.147385776014;680;694.0422217340039;698.2982102986466;705.2453874354392;718.5939943931662;5464.9453505465235;5566.860828479321;5568.610197286151;5611.579131565068;5822.359540450631;812.3129542539514;814.1980149552686;838.3209600223838;839.0686338164754;853.4836423963537;3407.8924349585986;3611.963880361215;3657.122290650225;3818.0836599215986;3864.381698928158;12709.745805083847;13317.933410332886;13328.600141995756;13358.532451364155;13368.465261389436;12781.424835882408;13216.074874758868;13250.536231231861;13251.867481325256;13256.801147982787;9154.725358239264;9439.150476457151;9454.480003599869;9458.85811712825;9482.194013508792;5665.518430933252;5667.121596152603;5694.658320500783;5694.772209111589;5868.354481007171;11409.486573104065;11759.588414405454;11855.466504007169;11948.940255298668;11988.700282492659;11776.764464710486;11834.82247766267;11902.107341949215;11990.220635658654;11997.340146292037;7636.656350464132;7682.577458239851;7744.1481437043;7762.029746281715;7837.13791482925;7790.5325680459355;7997.560134192442;8896.199342059246;9308.674196403364;9491;7476.289752473506;7560.8487830244185;7628.656710448154;7631.732889348847;7776.455648104578;7658.655360508679;7726.806829829299;7772.572508512086;7778.49439786412;7862.2923936845955;7365.558066516026;7380.557166570023;7430.554166750012;7437.8140546486775;7440.255974402517;4822.662413631012;4850.1997170466475;4910.189818679878;4955.554000140005;4998.6750861193905;5064.569511591409;5124.769385377742;5157.948420515897;5384.353877534721;5389.83830485086 04:50:02 INFO - PID 20765 | |4;prototype.html;375.5524287044926;390.20982510416405;395.19183270212415;395.64589692225456;399.54052839234896;5085.79656813727;5258.421573626898;5269.946010797837;5385.061377903951;5404.243405923174;5055.620828437864;5166.664166829163;5206.895862082756;5226.7909283628605;5271.314729085223;4246.723962942414;4257;4258.55285195054;4275.957240427587;4280.186764514748;4140.8136633851545;4248.34150706641;4271.188474189909;4286.164197981395;4305.225059489307;4030.8186131624;4139.19285739281;4170.77060761658;4225.070484493406;4267.701260911737;4244.575542445747;4252.681048921343;4252.87241382759;4254.7021708480415;4259.808308626135;3865.768053916774;3890.2414029264305;3899.941500877489;3900.553369159161;3903.941440878389;5051.898962020776;5180.8963820723375;5193.740312984373;5196.480351964811;5199.584033277329;4907.067657145131;4908.484609116027;4932.80268789248;4942.777575009133;4949.653524253304;5610.915836262459;5618.297712785902;5620.522255608278;5635.464630860061;5658.755073883739;4109.260333140033;4257.892947833586;4272.081502476951;4288.849890253858;4297.183535128315;5832.825015249549;5872.618279811799;5879.970600147015;5903.7048147593305;5904.97047514764;4379.430674012422;4379.824807007684;4390.62679672225;4418.116376724668;4429.49060857999;4316.740995540277;4470.530594287553;4471.128130014681;4493.281075028045;4500.099980004013;4902.754862256873;4912.189488734319;4915.21356582945;4918.508149185124;4936.827211047668;5618.887622247532;5623.887522249532;5624.312706188127;5624.775008999594;5646.124850648156;1365.7336819320335;1424.0031977615504;1445.284584130862;1523.3906437424896;1544.088987497382;946.8011717539393;950.6625148072335;979.8334283171878;988.0415996483399;993.145894530703;4831.227003679394;4837.685550439211;4848.618143828991;4886.2409532568245;4899.828506002273;5726.541876649858;5730.570207234474;5738.8278351649515;5762.423757624204;5766.538676905838;4654.37165982588;4750.714957102516;4810.158222311082;4866.853994380174;4918.040982008474;3018.501947178691;3038.2404398900276;3051.4965030769677;3052.603161588979;3058.7247147756807;5180.637355385087;5374.6506477078865;5391.272178255964;5410.404855465896;5411.269478620415;5885.087811389241;5890.293164820163;5895.528357731371;5926.8814623707285;5936.436038576328;5358;5364.988129451455;5371.435999220103;5378.838634840961;5402.35171779389;5498.175273708815;5723.599348045597;5723.8855222896145;5759.712014399347;5770.336411312753;5626.859328516656;5651.886962260814;5659.462351076641;5663.233949423588;5670.603057785916;5163.302954101148;5383.650062745909;5384.219288203267;5388.326459192601;5406.621536492407;3992.5608183099257;4012;4059.2693315203546;4064.4512990747053;4074.959250407458;5741.5119714824705;5781.005553084179;5782.508486778671;5785.710714464344;5794.478496935296;5396;5524.972375138259;5542.8337149885565;5556.361018482926;5581.888362232651;5505.421930697219;5530.55755539564;5541.861453463695;5551.417101204315;5554.50009499147;5402.540784033401;5418.07892658257;5450.427705090909;5453.363990802823;5459.727013649381;5323.973380133075;5582.720863956867;5617.5505959522325;5618.803341883015;5693.0148895773955;5522.144067669517;5522.751476183662;5525.889482210253;5537.5569954402745;5550.5282051026115 04:50:02 INFO - PID 20765 | |5;yui.html;678.8642271545692;688.1466980943629;696.6168607266003;697.8360085379935;700.9579425234487;12053.939730301347;12470.189437686568;12487.43806528706;12564.120511564182;12573.685657858558;12446.128770986035;12572.434240459179;12600.243985360885;12632.68418289541;12646.747065058717;811.8051667599763;831.9875201871977;842.7893026743315;843.2284459719349;843.5529169540123;845.7378212754035;852.2713080316333;852.8550146475114;853.6798700487317;853.871919212117;883.2139395937621;892.638481415028;893.7318804358699;893.7854914820429;895.0288936503869;874.868769684546;889.5907882374115;890.3411475508077;890.768400215942;891.1266958380824;651.8859199640092;653.7058323754329;654.4110300729334;655.2235600813052;655.8163714160042;11997.64007079789;12144.149909506337;12145.210561313575;12160.027197824242;12459.813102803466;10563.313384629975;10733.677989660322;10847.349159050482;11029.724256893642;11160.609378671708;9440.905590944072;9513.33406661534;9581.137697607179;9735.853962190573;9783.36408133469;2634.670666166729;2650.483155784623;2655.614935834293;2704.013035242142;2732.8633568321507;56725.43274567243;58252;58284.70857645685;59021.704891475696;59024.40975590232;7983.600819958979;7992.080910695345;8062.596870156469;8097.554634495159;8107.55408452529;16203.594910127342;16229.59426014359;16240.187990600423;16243.918780406259;16255.105969171573;6437.774677886345;6538.215414150237;6591.143151390384;6744;6805.727770889208;3321.8671253149605;3322.4185767490594;3365.747568932291;3393.7794043387594;3404.676555727202;3497.8076205808925;3542.4590303218183;3575.6245594212755;3587.3722098632634;3593.9640603594153;615.4983688294026;620.1101419463085;625.252822876658;625.7309356976543;637.964911929839;528.4847273907909;538.8383484954498;548.4570275427299;551.302602208207;551.6056019945757;8257.876131858027;8358.665653373797;8533.530655813865;8592.613332400057;8935.285177185939;523.6884053987872;530.6709839899287;544.1592739217917;556.4741319453078;558.9608727389044;4011.478507793968;4035.515738111387;4043.0903046814233;4118.238125946709;4178.916421671611;61724.69137654373;62706.372936270964;63903.680481598225;65493.672531637036;65688.34311656917;53516.73241633845;53622;54096.72951635216;54415.45584544183;54513.1823022655;30857.382852343275;39352;39861;39929.60070399317;41371;8660.696875609323;8939.284857211278;9122.498262595622;9183;9232.21526170283;22526.887365563067;22822.543549128593;23055.077796887937;23436.765632343457;23438;26718.465630687668;27445;30540.08379748611;30956.22609434782;31749.20626984344;11076.944615276872;11603.88396116028;11617;11635.650930472098;11689.766204676029;11992.880071199177;12159.392030398622;12167.087468439726;12429.689257768629;12878;10645.361278323326;10682.359058456517;11120.555177793121;11235.887641123483;11605.129615279056;11680.357580333164;11943.223690460092;11966.820497692715;12178.73977298772;12368.930011484837;11088.724796648488;11535.653930382103;11543.36511491876;11956.403161663497;12079.154459187772;7719.996400468128;7789.298963093349;7799.454038217497;7925.128235894163;8078.757637270891;9343.392679475812;9847.359921605359;9904.158146557624;9984.450855202744;10015.549300281651 04:50:02 INFO - PID 20765 | __end_tp_report 04:50:02 INFO - PID 20765 | __start_cc_report 04:50:02 INFO - PID 20765 | _x_x_mozilla_cycle_collect,1613 04:50:02 INFO - PID 20765 | __end_cc_report 04:50:02 INFO - PID 20765 | __startTimestamp1490615402744__endTimestamp 04:50:02 INFO - PID 20765 | 04:50:02 INFO - PID 20765 | ------- Summary: start ------- 04:50:02 INFO - PID 20765 | Number of tests: 6 04:50:02 INFO - PID 20765 | 04:50:02 INFO - PID 20765 | [#0] dojo.html Cycles:165 Average:5173.09 Median:5335.09 stddev:599.88 (11.2%) stddev-sans-first:569.29 04:50:02 INFO - PID 20765 | Values: 2692.9 2705.6 2714.6 2723.1 2725.5 5121.5 5192.5 5260.1 5295.7 5300.4 5285.5 5296.4 5298.2 5335.1 5336.5 4748.5 4793.1 4817.7 4899.1 4935.2 4841.9 4875.9 4898.0 4915.0 4919.8 4657.8 4664.9 4697.1 4702.9 4710.6 4753.0 4753.1 4756.6 4758.5 4762.7 4695.1 4713.2 4714.5 4716.8 4727.9 5098.7 5143.4 5153.0 5156.9 5158.4 5615.0 5615.9 5648.6 5663.0 5676.0 5635.0 5641.4 5648.9 5660.4 5669.6 5082.4 5188.9 5250.1 5256.9 5300.6 5776.6 5810.5 5812.6 5813.4 5815.7 5529.5 5600.6 5645.6 5658.4 5661.1 5605.5 5618.4 5657.8 5675.0 5689.7 5581.2 5606.8 5607.8 5632.1 5651.5 5515.4 5540.9 5550.5 5557.1 5557.6 4575.8 4579.8 4581.4 4647.0 4673.6 3954.7 3962.8 3985.4 3986.5 4017.2 4798.2 4804.0 4807.1 4850.1 4852.3 5546.7 5589.4 5592.0 5643.7 5645.9 4799.4 4855.2 4872.4 4899.4 4900.9 5027.8 5053.6 5071.1 5078.5 5106.1 5114.5 5283.8 5292.7 5346.0 5347.2 5675.6 5691.7 5696.9 5751.7 5784.8 5305.4 5307.1 5348.3 5348.4 5357.9 5610.8 5610.9 5613.9 5615.6 5623.4 5524.1 5596.0 5702.6 5708.4 5711.7 5374.6 5383.7 5480.4 5511.6 5529.4 5342.8 5388.5 5401.1 5405.8 5472.5 5269.2 5320.6 5327.5 5330.3 5394.6 5452.6 5484.5 5494.9 5522.7 5525.2 5430.7 5436.6 5446.7 5477.1 5482.0 04:50:02 INFO - PID 20765 | 04:50:02 INFO - PID 20765 | [#1] ext.html Cycles:180 Average:33440.72 Median:14389.09 stddev:53266.49 (370.2%) stddev-sans-first:53359.02 04:50:02 INFO - PID 20765 | Values: 650.9 722.8 740.5 1054.8 1072.4 25534.6 31164.7 31324.5 31393.2 31404.8 32609.3 32900.7 32979.3 32990.5 32999.0 5695.4 7301.1 7477.7 7477.9 7482.3 5780.2 5867.9 5868.4 5871.5 7290.9 7511.9 7561.1 7561.4 7563.1 7563.2 7473.4 7526.7 7530.6 7535.2 7536.3 7337.1 7449.7 7449.7 7450.5 7608.1 34429.1 34544.5 34660.5 34672.0 34698.5 2590.7 2595.8 2601.1 2617.5 2650.2 21448.7 21473.5 21613.7 21629.8 21929.3 2457.5 2476.6 2477.1 2500.6 2503.5 141157.0 141944.0 142033.0 142204.0 142501.0 41006.6 41007.0 41012.0 41039.6 41073.6 43107.4 43202.6 43214.0 43285.8 43382.0 13476.4 13816.4 13834.9 13840.7 13850.9 11077.5 11082.1 11086.1 11090.1 11099.7 10953.8 11138.8 12734.7 13280.3 13628.1 5391.9 5415.1 5469.8 5473.9 5534.5 850.7 889.4 896.8 908.3 921.1 21069.2 21801.5 21946.3 21962.0 22123.7 961.1 968.8 972.3 975.4 1000.7 11469.5 11469.7 11501.3 11506.6 11543.7 240339.0 242299.0 242633.0 242736.0 243022.0 42953.8 43470.3 43522.6 43534.6 43542.0 1207.9 1255.4 1257.9 1268.9 1270.4 20104.9 20153.2 21050.7 21212.2 21364.9 31805.5 31857.0 31873.7 31909.8 31934.0 214188.0 214396.0 215038.0 215214.0 215430.0 29604.2 30033.0 30037.2 30080.4 30091.5 25849.9 26160.7 31471.5 31475.2 36008.5 23719.4 23950.4 23962.8 24875.8 25695.0 25668.9 25697.0 25871.5 25981.8 27016.2 25693.0 25804.6 25910.4 25910.9 26012.9 25361.4 25544.7 25584.2 26197.1 26619.7 21123.9 22189.6 22344.8 22395.7 22474.8 04:50:02 INFO - PID 20765 | 04:50:02 INFO - PID 20765 | [#2] jquery.html Cycles:180 Average:26779.59 Median:428804.50 stddev:71379.76 (16.6%) stddev-sans-first:71552.53 04:50:02 INFO - PID 20765 | Values: 407.0 410.4 426.5 440.0 441.8 16923.0 17684.4 18855.2 18942.2 19094.2 16325.4 16345.2 16406.8 18234.5 18474.8 5591.3 5615.7 5680.8 5762.1 5805.7 5599.1 5660.5 5661.1 5671.3 5696.3 5545.7 5546.6 5630.4 5649.8 5678.3 5605.6 5680.3 5680.6 5686.2 5689.2 4984.2 5032.0 5067.8 5076.2 5076.5 22025.7 22056.3 22083.3 22087.1 22505.5 1599.9 1600.0 1607.2 1639.6 1656.3 13075.7 13150.7 13583.3 14217.2 14248.5 1711.3 1734.0 1737.7 1746.2 1764.7 87162.0 91512.5 91755.0 92910.0 93300.0 10825.5 10828.2 10971.5 11079.4 11320.4 15739.9 15748.7 15751.8 15751.8 15755.6 7743.1 7965.2 8096.5 8108.6 8187.7 7392.7 7399.8 7404.7 7572.6 7622.6 6941.7 6955.3 7031.8 7095.8 7097.8 1904.6 1916.4 1922.8 1951.5 2155.5 752.5 767.9 773.0 788.0 794.9 15454.8 15530.8 15605.7 15816.9 16308.7 788.8 793.5 795.0 799.1 812.4 8444.6 8466.6 8712.0 8746.5 8878.1 426014.0 426499.0 431110.0 433921.0 434506.0 81557.6 82403.6 82428.6 83366.6 86669.1 1033.5 1058.3 1072.2 1072.9 1073.4 13312.9 13384.3 13740.4 14027.1 14028.8 36164.6 37668.0 38634.2 40468.4 41048.4 51568.5 51581.7 54587.7 55430.6 55891.2 10042.2 10615.8 10619.3 10645.3 11078.4 11406.5 11421.4 11500.2 11647.8 11679.1 9532.7 9736.4 9845.0 9889.4 10100.5 9180.7 9241.3 9372.4 9398.5 9537.0 9793.3 10052.0 10064.3 10143.9 10543.4 10473.5 10608.2 10660.3 10765.5 10888.8 8667.3 9495.7 9911.0 9939.1 10183.6 04:50:02 INFO - PID 20765 | 04:50:02 INFO - PID 20765 | [#3] mootools.html Cycles:180 Average:6122.06 Median:4851.48 stddev:3967.53 (81.8%) stddev-sans-first:3960.87 04:50:02 INFO - PID 20765 | Values: 1122.1 1258.3 1272.0 1296.9 1302.7 8179.6 9526.9 9729.6 9773.7 9780.0 9576.7 9657.4 9667.9 9672.2 9672.4 1835.1 2090.8 2138.5 2141.1 2141.9 1906.0 1928.9 1930.0 1930.3 2074.9 2086.9 2089.2 2092.0 2093.0 2094.2 1983.8 1996.5 2010.5 2010.9 2010.9 2012.5 2016.2 2016.4 2018.9 2019.3 9777.2 9980.6 9987.4 9997.2 10012.4 5169.5 5306.9 5316.3 5319.0 5334.4 2970.2 3078.3 3212.1 3234.1 3240.7 1038.9 1055.6 1059.1 1066.3 1072.9 13759.5 14168.9 14172.3 14213.0 14898.2 4681.8 4696.4 4783.9 4852.8 4874.4 10842.9 10856.1 10884.0 10906.3 10908.0 5564.6 5578.6 5581.3 5584.6 5604.0 4916.4 5034.4 5035.1 5065.1 5103.2 3338.1 3413.7 3663.8 3724.1 3796.3 1068.5 1070.1 1083.5 1097.8 1100.1 680.0 694.0 698.3 705.2 718.6 5464.9 5566.9 5568.6 5611.6 5822.4 812.3 814.2 838.3 839.1 853.5 3407.9 3612.0 3657.1 3818.1 3864.4 12709.7 13317.9 13328.6 13358.5 13368.5 12781.4 13216.1 13250.5 13251.9 13256.8 9154.7 9439.2 9454.5 9458.9 9482.2 5665.5 5667.1 5694.7 5694.8 5868.4 11409.5 11759.6 11855.5 11948.9 11988.7 11776.8 11834.8 11902.1 11990.2 11997.3 7636.7 7682.6 7744.1 7762.0 7837.1 7790.5 7997.6 8896.2 9308.7 9491.0 7476.3 7560.8 7628.7 7631.7 7776.5 7658.7 7726.8 7772.6 7778.5 7862.3 7365.6 7380.6 7430.6 7437.8 7440.3 4822.7 4850.2 4910.2 4955.6 4998.7 5064.6 5124.8 5157.9 5384.4 5389.8 04:50:02 INFO - PID 20765 | 04:50:02 INFO - PID 20765 | [#4] prototype.html Cycles:180 Average:4681.83 Median:5216.84 stddev:1320.52 (25.3%) stddev-sans-first:1284.06 04:50:02 INFO - PID 20765 | Values: 375.6 390.2 395.2 395.6 399.5 5085.8 5258.4 5269.9 5385.1 5404.2 5055.6 5166.7 5206.9 5226.8 5271.3 4246.7 4257.0 4258.6 4276.0 4280.2 4140.8 4248.3 4271.2 4286.2 4305.2 4030.8 4139.2 4170.8 4225.1 4267.7 4244.6 4252.7 4252.9 4254.7 4259.8 3865.8 3890.2 3899.9 3900.6 3903.9 5051.9 5180.9 5193.7 5196.5 5199.6 4907.1 4908.5 4932.8 4942.8 4949.7 5610.9 5618.3 5620.5 5635.5 5658.8 4109.3 4257.9 4272.1 4288.8 4297.2 5832.8 5872.6 5880.0 5903.7 5905.0 4379.4 4379.8 4390.6 4418.1 4429.5 4316.7 4470.5 4471.1 4493.3 4500.1 4902.8 4912.2 4915.2 4918.5 4936.8 5618.9 5623.9 5624.3 5624.8 5646.1 1365.7 1424.0 1445.3 1523.4 1544.1 946.8 950.7 979.8 988.0 993.1 4831.2 4837.7 4848.6 4886.2 4899.8 5726.5 5730.6 5738.8 5762.4 5766.5 4654.4 4750.7 4810.2 4866.9 4918.0 3018.5 3038.2 3051.5 3052.6 3058.7 5180.6 5374.7 5391.3 5410.4 5411.3 5885.1 5890.3 5895.5 5926.9 5936.4 5358.0 5365.0 5371.4 5378.8 5402.4 5498.2 5723.6 5723.9 5759.7 5770.3 5626.9 5651.9 5659.5 5663.2 5670.6 5163.3 5383.7 5384.2 5388.3 5406.6 3992.6 4012.0 4059.3 4064.5 4075.0 5741.5 5781.0 5782.5 5785.7 5794.5 5396.0 5525.0 5542.8 5556.4 5581.9 5505.4 5530.6 5541.9 5551.4 5554.5 5402.5 5418.1 5450.4 5453.4 5459.7 5324.0 5582.7 5617.6 5618.8 5693.0 5522.1 5522.8 5525.9 5537.6 5550.5 04:50:02 INFO - PID 20765 | 04:50:02 INFO - PID 20765 | [#5] yui.html Cycles:180 Average:13044.54 Median:27080.42 stddev:16079.52 (59.4%) stddev-sans-first:16097.81 04:50:02 INFO - PID 20765 | Values: 678.9 688.1 696.6 697.8 701.0 12053.9 12470.2 12487.4 12564.1 12573.7 12446.1 12572.4 12600.2 12632.7 12646.7 811.8 832.0 842.8 843.2 843.6 845.7 852.3 852.9 853.7 853.9 883.2 892.6 893.7 893.8 895.0 874.9 889.6 890.3 890.8 891.1 651.9 653.7 654.4 655.2 655.8 11997.6 12144.1 12145.2 12160.0 12459.8 10563.3 10733.7 10847.3 11029.7 11160.6 9440.9 9513.3 9581.1 9735.9 9783.4 2634.7 2650.5 2655.6 2704.0 2732.9 56725.4 58252.0 58284.7 59021.7 59024.4 7983.6 7992.1 8062.6 8097.6 8107.6 16203.6 16229.6 16240.2 16243.9 16255.1 6437.8 6538.2 6591.1 6744.0 6805.7 3321.9 3322.4 3365.7 3393.8 3404.7 3497.8 3542.5 3575.6 3587.4 3594.0 615.5 620.1 625.3 625.7 638.0 528.5 538.8 548.5 551.3 551.6 8257.9 8358.7 8533.5 8592.6 8935.3 523.7 530.7 544.2 556.5 559.0 4011.5 4035.5 4043.1 4118.2 4178.9 61724.7 62706.4 63903.7 65493.7 65688.3 53516.7 53622.0 54096.7 54415.5 54513.2 30857.4 39352.0 39861.0 39929.6 41371.0 8660.7 8939.3 9122.5 9183.0 9232.2 22526.9 22822.5 23055.1 23436.8 23438.0 26718.5 27445.0 30540.1 30956.2 31749.2 11076.9 11603.9 11617.0 11635.7 11689.8 11992.9 12159.4 12167.1 12429.7 12878.0 10645.4 10682.4 11120.6 11235.9 11605.1 11680.4 11943.2 11966.8 12178.7 12368.9 11088.7 11535.7 11543.4 11956.4 12079.2 7720.0 7789.3 7799.5 7925.1 8078.8 9343.4 9847.4 9904.2 9984.5 10015.5 04:50:02 INFO - PID 20765 | -------- Summary: end -------- 04:50:02 INFO - PID 20765 | 04:50:03 INFO - TEST-INFO | 20765: exit 0 04:50:03 INFO - TEST-OK | dromaeo_css | took 1123616ms 04:50:03 INFO - TEST-START | kraken 04:50:03 INFO - operating with platform_type : linux_ 04:50:03 INFO - Initialising browser for kraken test... 04:50:03 INFO - TEST-INFO | started process 21089 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG3gR_q/profile http://localhost:52492/getInfo.html) 04:50:07 INFO - PID 21089 | __metrics Screen width/height:1600/1200 04:50:07 INFO - PID 21089 | colorDepth:24 04:50:07 INFO - PID 21089 | Browser inner width/height: 1024/697 04:50:07 INFO - PID 21089 | __metrics 04:50:08 ERROR - PID 21089 | 1490615408591 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 04:50:08 INFO - PID 21089 | 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" 04:50:08 INFO - PID 21089 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:50:09 INFO - TEST-INFO | 21089: exit 0 04:50:09 INFO - Browser initialized. 04:50:09 INFO - Running cycle 1/1 for kraken test... 04:50:09 INFO - TEST-INFO | started process 21183 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG3gR_q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:21 INFO - PID 21183 | RSS: Main: 149950464 04:50:21 INFO - PID 21183 | 04:50:24 INFO - PID 21183 | Cycle 1(1): loaded http://localhost:52492/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52492/tests/kraken/driver.html?testName=audio-beat-detection) 04:50:25 INFO - PID 21183 | RSS: Main: 205504512 04:50:25 INFO - PID 21183 | 04:50:28 INFO - PID 21183 | Cycle 1(1): loaded http://localhost:52492/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52492/tests/kraken/driver.html?testName=audio-dft) 04:50:28 INFO - PID 21183 | RSS: Main: 183676928 04:50:28 INFO - PID 21183 | 04:50:32 INFO - PID 21183 | Cycle 1(1): loaded http://localhost:52492/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52492/tests/kraken/driver.html?testName=audio-fft) 04:50:32 INFO - PID 21183 | RSS: Main: 266919936 04:50:32 INFO - PID 21183 | 04:50:34 INFO - PID 21183 | Cycle 1(1): loaded http://localhost:52492/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52492/tests/kraken/driver.html?testName=audio-oscillator) 04:50:35 INFO - PID 21183 | RSS: Main: 177119232 04:50:35 INFO - PID 21183 | 04:50:37 INFO - PID 21183 | Cycle 1(1): loaded http://localhost:52492/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52492/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:50:38 INFO - PID 21183 | RSS: Main: 180436992 04:50:38 INFO - PID 21183 | 04:50:41 INFO - PID 21183 | Cycle 1(1): loaded http://localhost:52492/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52492/tests/kraken/driver.html?testName=imaging-darkroom) 04:50:42 INFO - PID 21183 | RSS: Main: 220192768 04:50:42 INFO - PID 21183 | 04:50:45 INFO - PID 21183 | Cycle 1(1): loaded http://localhost:52492/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52492/tests/kraken/driver.html?testName=imaging-desaturate) 04:50:46 INFO - PID 21183 | RSS: Main: 215310336 04:50:46 INFO - PID 21183 | 04:50:49 INFO - PID 21183 | Cycle 1(1): loaded http://localhost:52492/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52492/tests/kraken/driver.html?testName=json-parse-financial) 04:50:50 INFO - PID 21183 | RSS: Main: 216805376 04:50:50 INFO - PID 21183 | 04:50:51 INFO - PID 21183 | Cycle 1(1): loaded http://localhost:52492/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52492/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:50:52 INFO - PID 21183 | RSS: Main: 180883456 04:50:52 INFO - PID 21183 | 04:50:54 INFO - PID 21183 | Cycle 1(1): loaded http://localhost:52492/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52492/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:50:54 INFO - PID 21183 | RSS: Main: 187523072 04:50:54 INFO - PID 21183 | 04:50:57 INFO - PID 21183 | Cycle 1(1): loaded http://localhost:52492/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52492/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:50:57 INFO - PID 21183 | RSS: Main: 196874240 04:50:57 INFO - PID 21183 | 04:51:00 INFO - PID 21183 | Cycle 1(1): loaded http://localhost:52492/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52492/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:51:01 INFO - PID 21183 | RSS: Main: 205721600 04:51:01 INFO - PID 21183 | 04:51:04 INFO - PID 21183 | Cycle 1(1): loaded http://localhost:52492/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52492/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:51:05 INFO - PID 21183 | RSS: Main: 202678272 04:51:05 INFO - PID 21183 | 04:51:06 INFO - PID 21183 | Cycle 1(1): loaded http://localhost:52492/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52492/tests/kraken/driver.html?testName=ai-astar) 04:51:07 INFO - PID 21183 | RSS: Main: 270692352 04:51:07 INFO - PID 21183 | 04:51:07 INFO - PID 21183 | __start_tp_report 04:51:07 INFO - PID 21183 | _x_x_mozilla_page_load 04:51:07 INFO - PID 21183 | _x_x_mozilla_page_load_details 04:51:07 INFO - PID 21183 | |i|pagename|runs| 04:51:07 INFO - PID 21183 | |0;ai-astar;103;114;110;112;110;110;114;113;111;111 04:51:07 INFO - PID 21183 | |1;audio-beat-detection;150;122;122;166;123;134;128;122;152;125 04:51:07 INFO - PID 21183 | |2;audio-dft;161;162;162;164;164;163;162;163;162;163 04:51:07 INFO - PID 21183 | |3;audio-fft;74;74;76;115;76;75;75;75;91;84 04:51:07 INFO - PID 21183 | |4;audio-oscillator;83;84;110;84;84;83;103;83;85;104 04:51:07 INFO - PID 21183 | |5;imaging-gaussian-blur;113;114;114;113;113;113;114;113;113;114 04:51:07 INFO - PID 21183 | |6;imaging-darkroom;149;149;149;149;149;149;149;149;148;148 04:51:07 INFO - PID 21183 | |7;imaging-desaturate;95;94;94;94;94;94;94;95;94;94 04:51:07 INFO - PID 21183 | |8;json-parse-financial;65;65;65;65;67;66;67;66;67;65 04:51:07 INFO - PID 21183 | |9;json-stringify-tinderbox;56;55;56;56;56;56;56;57;56;55 04:51:07 INFO - PID 21183 | |10;stanford-crypto-aes;91;85;83;81;84;85;84;85;83;83 04:51:07 INFO - PID 21183 | |11;stanford-crypto-ccm;147;140;134;131;140;135;133;142;183;136 04:51:07 INFO - PID 21183 | |12;stanford-crypto-pbkdf2;184;190;191;195;210;194;194;198;193;191 04:51:07 INFO - PID 21183 | |13;stanford-crypto-sha256-iterative;71;71;70;70;72;71;74;71;71;74 04:51:07 INFO - PID 21183 | __end_tp_report 04:51:07 INFO - PID 21183 | __start_cc_report 04:51:07 INFO - PID 21183 | _x_x_mozilla_cycle_collect,2017 04:51:07 INFO - PID 21183 | __end_cc_report 04:51:07 INFO - PID 21183 | __startTimestamp1490615467189__endTimestamp 04:51:07 INFO - PID 21183 | 04:51:07 INFO - PID 21183 | ------- Summary: start ------- 04:51:07 INFO - PID 21183 | Number of tests: 14 04:51:07 INFO - PID 21183 | 04:51:07 INFO - PID 21183 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:3.16 (2.8%) stddev-sans-first:1.66 04:51:07 INFO - PID 21183 | Values: 103.0 114.0 110.0 112.0 110.0 110.0 114.0 113.0 111.0 111.0 04:51:07 INFO - PID 21183 | 04:51:07 INFO - PID 21183 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:131.00 stddev:15.89 (12.1%) stddev-sans-first:15.82 04:51:07 INFO - PID 21183 | Values: 150.0 122.0 122.0 166.0 123.0 134.0 128.0 122.0 152.0 125.0 04:51:07 INFO - PID 21183 | 04:51:07 INFO - PID 21183 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:0.97 (0.6%) stddev-sans-first:0.83 04:51:07 INFO - PID 21183 | Values: 161.0 162.0 162.0 164.0 164.0 163.0 162.0 163.0 162.0 163.0 04:51:07 INFO - PID 21183 | 04:51:07 INFO - PID 21183 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.50 stddev:12.99 (17.2%) stddev-sans-first:13.49 04:51:07 INFO - PID 21183 | Values: 74.0 74.0 76.0 115.0 76.0 75.0 75.0 75.0 91.0 84.0 04:51:07 INFO - PID 21183 | 04:51:07 INFO - PID 21183 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:83.50 stddev:10.77 (12.9%) stddev-sans-first:11.10 04:51:07 INFO - PID 21183 | Values: 83.0 84.0 110.0 84.0 84.0 83.0 103.0 83.0 85.0 104.0 04:51:07 INFO - PID 21183 | 04:51:07 INFO - PID 21183 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:113.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:51:07 INFO - PID 21183 | Values: 113.0 114.0 114.0 113.0 113.0 113.0 114.0 113.0 113.0 114.0 04:51:07 INFO - PID 21183 | 04:51:07 INFO - PID 21183 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 04:51:07 INFO - PID 21183 | Values: 149.0 149.0 149.0 149.0 149.0 149.0 149.0 149.0 148.0 148.0 04:51:07 INFO - PID 21183 | 04:51:07 INFO - PID 21183 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 04:51:07 INFO - PID 21183 | Values: 95.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 04:51:07 INFO - PID 21183 | 04:51:07 INFO - PID 21183 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 04:51:07 INFO - PID 21183 | Values: 65.0 65.0 65.0 65.0 67.0 66.0 67.0 66.0 67.0 65.0 04:51:07 INFO - PID 21183 | 04:51:07 INFO - PID 21183 | [#9] json-stringify-tinderbox Cycles:10 Average:55.90 Median:56.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 04:51:07 INFO - PID 21183 | Values: 56.0 55.0 56.0 56.0 56.0 56.0 56.0 57.0 56.0 55.0 04:51:07 INFO - PID 21183 | 04:51:07 INFO - PID 21183 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.50 stddev:2.63 (3.1%) stddev-sans-first:1.32 04:51:07 INFO - PID 21183 | Values: 91.0 85.0 83.0 81.0 84.0 85.0 84.0 85.0 83.0 83.0 04:51:07 INFO - PID 21183 | 04:51:07 INFO - PID 21183 | [#11] stanford-crypto-ccm Cycles:10 Average:142.10 Median:140.00 stddev:15.15 (10.8%) stddev-sans-first:15.96 04:51:07 INFO - PID 21183 | Values: 147.0 140.0 134.0 131.0 140.0 135.0 133.0 142.0 183.0 136.0 04:51:07 INFO - PID 21183 | 04:51:07 INFO - PID 21183 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.00 Median:194.00 stddev:6.73 (3.5%) stddev-sans-first:6.09 04:51:07 INFO - PID 21183 | Values: 184.0 190.0 191.0 195.0 210.0 194.0 194.0 198.0 193.0 191.0 04:51:07 INFO - PID 21183 | 04:51:07 INFO - PID 21183 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:71.00 stddev:1.43 (2.0%) stddev-sans-first:1.51 04:51:07 INFO - PID 21183 | Values: 71.0 71.0 70.0 70.0 72.0 71.0 74.0 71.0 71.0 74.0 04:51:07 INFO - PID 21183 | -------- Summary: end -------- 04:51:07 INFO - PID 21183 | 04:51:08 INFO - TEST-INFO | 21183: exit 0 04:51:08 INFO - TEST-OK | kraken | took 64932ms 04:51:08 INFO - SUITE-END | took 1188s 04:51:08 INFO - Completed test suite (00:19:48) 04:51:08 INFO - javascript benchmark 04:51:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6508.850024224651, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2692.8653567321635, 2705.5535836586964, 2714.6335244741954, 2723.10137654574, 2725.509408306505, 5121.5390614844655, 5192.454792246816, 5260.132078207092, 5295.655782374148, 5300.363956325242, 5285.471452854713, 5296.417394086648, 5298.23175639533, 5335.093034184189, 5336.519713225809, 4748.477667456577, 4793.137235297645, 4817.710937343753, 4899.069176856404, 4935.185694360444, 4841.854744357693, 4875.853724388274, 4897.951020489803, 4915.041566894457, 4919.7914079960265, 4657.813687452498, 4664.883377915579, 4697.084068606623, 4702.858914232578, 4710.552497512731, 4753.025629745928, 4753.096911586787, 4756.643251756098, 4758.452777930548, 4762.714237145782, 4695.131400690849, 4713.151632706112, 4714.528547145258, 4716.834910778106, 4727.929081063787, 5098.719570423626, 5143.434222235551, 5152.995165942642, 5156.948430515685, 5158.432572417031, 5614.9719251403485, 5615.887682246333, 5648.576356773258, 5663.0, 5676.0066988276885, 5635.0, 5641.407652196502, 5648.943510564883, 5660.405657405954, 5669.603127781057, 5082.390113186368, 5188.948110518922, 5250.1337279349245, 5256.92114618281, 5300.628955973045, 5776.595638305278, 5810.477057064884, 5812.59311848175, 5813.3895940925595, 5815.709214539341, 5529.529989950899, 5600.607957443021, 5645.576581756384, 5658.434156584309, 5661.122526008476, 5605.495505404533, 5618.410066942912, 5657.8019769307875, 5675.006873797069, 5689.6586204827845, 5581.162825576196, 5606.775728970877, 5607.831765047055, 5632.127020311858, 5651.547876169897, 5515.448455154533, 5540.889182216414, 5550.500454959073, 5557.083081291623, 5557.555395568425, 4575.771211439482, 4579.839705610288, 4581.358609794632, 4647.047355292157, 4673.556012178838, 3954.7429417087797, 3962.7622342659533, 3985.4221137934837, 3986.541547722049, 4017.196560687874, 4798.160321943646, 4804.015176888729, 4807.134715751128, 4850.1269771440775, 4852.296417019513, 5546.667199968015, 5589.441055894378, 5592.049351610236, 5643.661380317194, 5645.858853528694, 4799.3760811095035, 4855.247436647325, 4872.4153101628035, 4899.387576552931, 4900.852974410774, 5027.84916452507, 5053.570446512014, 5071.137906555894, 5078.517540833689, 5106.055379754757, 5114.514121158484, 5283.8414847555405, 5292.7353632319, 5345.973270133624, 5347.171188465794, 5675.57433192504, 5691.715414229355, 5696.943030569641, 5751.654900705971, 5784.82645520635, 5305.416404195458, 5307.124324486416, 5348.331458567679, 5348.384935732285, 5357.892842143057, 5610.775568977195, 5610.915836262541, 5613.887722245614, 5615.634983726045, 5623.409541998031, 5524.116141417354, 5596.0, 5702.60081794287, 5708.400617935057, 5711.7429715662065, 5374.596905232045, 5383.703896285742, 5480.3971563128825, 5511.614187006871, 5529.419410961791, 5342.786288548415, 5388.46115388458, 5401.108817045144, 5405.837824865261, 5472.50747432733, 5269.1832765921345, 5320.627556071193, 5327.547158491571, 5330.331078320984, 5394.649347792381, 5452.618316717951, 5484.533814625802, 5494.862628434321, 5522.696251706034, 5525.198846167203, 5430.728463576885, 5436.592255580927, 5446.673199608036, 5477.123660214346, 5481.985832620978], "value": 5129.422328671185, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.9414152726257, 722.7976166673332, 740.4705635470638, 1054.752133248686, 1072.4101744040775, 25534.61698074528, 31164.68835311649, 31324.530132048036, 31393.215169620744, 31404.84297578509, 32609.347813043725, 32900.67099329006, 32979.34041319172, 32990.50514242288, 32999.0, 5695.430456954292, 7301.08736407949, 7477.663505142282, 7477.887831682529, 7482.289182527651, 5780.1907732917425, 5867.941320586782, 5868.3838196989345, 5871.530277577805, 7290.927090729105, 7511.887321690179, 7561.054868141482, 7561.432892533055, 7563.054618172729, 7563.243675632448, 7473.4021278297605, 7526.661300241502, 7530.623468826537, 7535.208803075708, 7536.321731044178, 7337.0828646419195, 7449.664765085584, 7449.739259125959, 7450.478466507347, 7608.087029556434, 34429.13927151841, 34544.48183277253, 34660.48009279863, 34672.0, 34698.47952280718, 2590.745772496085, 2595.8053146014126, 2601.1416232643182, 2617.450335429562, 2650.1519513755607, 21448.678269825967, 21473.46316342088, 21613.67579486309, 21629.783702162935, 21929.342119736433, 2457.4716435966175, 2476.5913624251975, 2477.1330034487964, 2500.624906264057, 2503.5118151960373, 141157.0, 141944.0, 142033.0, 142204.0, 142501.0, 41006.58993410088, 41007.0, 41012.0, 41039.58960410417, 41073.58926410758, 43107.35338969918, 43202.56797432048, 43214.0, 43285.783571082575, 43382.0, 13476.39356228972, 13816.37826297819, 13834.93082534581, 13840.653983650489, 13850.861491384958, 11077.501512431798, 11082.113430925507, 11086.113110951104, 11090.112790976702, 11099.72250693739, 10953.83569246462, 11138.832917506083, 12734.68163295925, 13280.335983200801, 13628.114172578751, 5391.924109217901, 5415.0523658359625, 5469.8085567005755, 5473.890522189534, 5534.529564987021, 850.7107583421666, 889.3863234368265, 896.7847716548112, 908.318760929303, 921.1157289002632, 21069.157233710786, 21801.454963626034, 21946.341609751733, 21961.973545078967, 22123.668144977837, 961.1061712607342, 968.8159249742527, 972.2853702528777, 975.4050029482011, 1000.7448100734412, 11469.54121835134, 11469.713257168638, 11501.252418592765, 11506.597269095542, 11543.711407214887, 240339.0, 242299.0, 242633.0, 242736.0, 243022.0, 42953.78523107427, 43470.34794478086, 43522.56477435248, 43534.564654353686, 43542.0, 1207.8912897839236, 1255.3723138430967, 1257.8867901888873, 1268.898488120948, 1270.371166272701, 20104.89947550253, 20153.193872244945, 21050.68423973672, 21212.151513939887, 21364.893175534024, 31805.5229171558, 31857.0, 31873.68126318707, 31909.840450797597, 31934.0, 214188.0, 214396.0, 215038.0, 215214.0, 215430.0, 29604.170304043615, 30033.0, 30037.24906877258, 30080.3983920316, 30091.548626770178, 25849.870750646125, 26160.738392616593, 31471.52792708157, 31475.213119672193, 36008.459873102445, 23719.40701482408, 23950.401239969142, 23962.76037239675, 24875.751242487342, 25695.0, 25668.87165564235, 25697.0, 25871.482570348864, 25981.845960276987, 27016.189514314603, 25693.0, 25804.612930805677, 25910.35224119412, 25910.87044564765, 26012.8699356502, 25361.365965851, 25544.74455255498, 25584.23247302584, 26197.083102091336, 26619.7338026625, 21123.894380528, 22189.55620887541, 22344.77655223427, 22395.664065039364, 22474.775252247924], "value": 14522.197749895813, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.9552349241583, 410.3577900585585, 426.4860842684565, 439.97140185887935, 441.77469490559815, 16923.0, 17684.381046663355, 18855.151518181665, 18942.24231030757, 19094.23623055076, 16325.428609998653, 16345.18274086294, 16406.753898691528, 18234.532230746227, 18474.81525184751, 5591.2731344925105, 5615.7472913718775, 5680.801171958982, 5762.135679648044, 5805.709714514279, 5599.076152434844, 5660.462256085665, 5661.065924122515, 5671.347795003566, 5696.344920334173, 5545.667259964395, 5546.639468434539, 5630.40880707526, 5649.830505084834, 5678.34699009613, 5605.5515558755205, 5680.261565996415, 5680.573956953245, 5686.175504551817, 5689.203511508392, 4984.22744474607, 5032.04391165681, 5067.797288108508, 5076.213186956028, 5076.5177308156035, 22025.66961495579, 22056.33830985073, 22083.33749987503, 22087.116515339527, 22505.549889002294, 1599.928003239857, 1599.9760003599838, 1607.2204980584406, 1639.5819066138058, 1656.2546853915665, 13075.738485230337, 13150.671233219246, 13583.320833958263, 14217.21805300708, 14248.501302454468, 1711.3496871188868, 1734.0289437914682, 1737.66984272989, 1746.2482946793998, 1764.7176451767784, 87162.0, 91512.54243728738, 91755.0, 92910.0, 93300.0, 10825.512851921525, 10828.187885908588, 10971.475938836878, 11079.446027698583, 11320.433978301053, 15739.921300393653, 15748.68502629941, 15751.763723544156, 15751.842481575037, 15755.606109847116, 7743.070831500256, 7965.243301886311, 8096.51420914747, 8108.5945702714625, 8187.672493100328, 7392.667329970164, 7399.778006659809, 7404.703811847466, 7572.621368931532, 7622.58075805836, 6941.7223311068, 6955.330720627115, 7031.7890463286185, 7095.82260443493, 7097.787066388017, 1904.628597423489, 1916.3867562379905, 1922.7500424944667, 1951.5363477391957, 2155.5150091229348, 752.5371896283856, 767.9232076792276, 772.9690812367555, 787.9559583551817, 794.9125596184415, 15454.845451545341, 15530.844691553166, 15605.68788624221, 15816.920915395349, 16308.673826523403, 788.7673136424769, 793.4763056382875, 794.9721759738381, 799.1209669363653, 812.4353574265829, 8444.57777111142, 8466.576671166416, 8712.0, 8746.475211487332, 8878.067802880605, 426014.0, 426499.0, 431110.0, 433921.0, 434506.0, 81557.59221203857, 82403.58798206091, 82428.58785706153, 83366.58316708378, 86669.13330866737, 1033.5194134727387, 1058.3015209961543, 1072.1958531101673, 1072.9302595331278, 1073.4149888310733, 13312.866871331164, 13384.330783460593, 13740.381682824496, 14027.088239264414, 14028.78956815669, 36164.63835361613, 37668.0, 38634.227315454096, 40468.39297410482, 41048.384274235315, 51568.48431515637, 51581.74209128931, 54587.727061364436, 55430.614234642846, 55891.16163257473, 10042.246831487522, 10615.787684246117, 10619.30974486656, 10645.308054976402, 11078.446077696244, 11406.543738250377, 11421.37182454973, 11500.194986350874, 11647.767044658889, 11679.124065695276, 9532.714018579454, 9736.367136136128, 9845.0, 9889.406635601887, 10100.54547545377, 9180.724578262663, 9241.260699143917, 9372.437653740797, 9398.483083430478, 9537.0, 9793.265505087005, 10052.0, 10064.345817521838, 10143.949280253551, 10543.367397956146, 10473.528691208761, 10608.151347892304, 10660.25378223517, 10765.461726913467, 10888.836667449836, 8667.306615470874, 9495.715128546155, 9910.950445247727, 9939.055789699967, 10183.643572474928], "value": 8754.680176300966, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1122.0686829931158, 1258.2576279994803, 1271.9936400318002, 1296.9481220751165, 1302.7068909495363, 8179.631916563754, 9526.85709714354, 9729.610815567377, 9773.657921972732, 9779.951100244489, 9576.664816731416, 9657.372270802392, 9667.903320966805, 9672.177864881494, 9672.419654820716, 1835.1191428114514, 2090.770015298316, 2138.4546940530145, 2141.0579345088113, 2141.9357419277367, 1905.9714104288446, 1928.8553358498098, 1929.951751206217, 1930.3243864647402, 2074.917003319873, 2086.926957556486, 2089.153892673462, 2091.9581608367826, 2093.037202886674, 2094.183268525276, 1983.771866235387, 1996.510854840566, 2010.4672261850621, 2010.9497262568407, 2010.9497262568552, 2012.5471768852037, 2016.1733689187508, 2016.3648450738117, 2018.9293374731815, 2019.2528764357135, 9777.168940640055, 9980.600775968953, 9987.350822196606, 9997.15024222942, 10012.399256044588, 5169.53474187325, 5306.867328316823, 5316.255724198615, 5319.042572336978, 5334.413214546396, 2970.2277407873894, 3078.291992841659, 3212.052444528846, 3234.0621219846216, 3240.740740740735, 1038.8649475568127, 1055.5935964653663, 1059.1156384419019, 1066.328213225663, 1072.8658917635296, 13759.518416855362, 14168.85831141696, 14172.291385430688, 14213.0, 14898.180600066991, 4681.806398599154, 4696.412948381452, 4783.856484305476, 4852.757362131879, 4874.390701162355, 10842.891571084347, 10856.131509479223, 10884.020438160604, 10906.291091079054, 10908.0, 5564.638298510584, 5578.553715702734, 5581.302337207849, 5584.636998595079, 5603.971980140073, 4916.385451818523, 5034.395872495324, 5035.0685123252315, 5065.11360511909, 5103.234514822806, 3338.082027442424, 3413.675700808419, 3663.7618554793853, 3724.1248306647917, 3796.335641262768, 1068.4550879051585, 1070.1224995503612, 1083.5286650307141, 1097.846301517788, 1100.147385776014, 680.0, 694.0422217340039, 698.2982102986466, 705.2453874354392, 718.5939943931662, 5464.9453505465235, 5566.860828479321, 5568.610197286151, 5611.579131565068, 5822.359540450631, 812.3129542539514, 814.1980149552686, 838.3209600223838, 839.0686338164754, 853.4836423963537, 3407.8924349585986, 3611.963880361215, 3657.122290650225, 3818.0836599215986, 3864.381698928158, 12709.745805083847, 13317.933410332886, 13328.600141995756, 13358.532451364155, 13368.465261389436, 12781.424835882408, 13216.074874758868, 13250.536231231861, 13251.867481325256, 13256.801147982787, 9154.725358239264, 9439.150476457151, 9454.480003599869, 9458.85811712825, 9482.194013508792, 5665.518430933252, 5667.121596152603, 5694.658320500783, 5694.772209111589, 5868.354481007171, 11409.486573104065, 11759.588414405454, 11855.466504007169, 11948.940255298668, 11988.700282492659, 11776.764464710486, 11834.82247766267, 11902.107341949215, 11990.220635658654, 11997.340146292037, 7636.656350464132, 7682.577458239851, 7744.1481437043, 7762.029746281715, 7837.13791482925, 7790.5325680459355, 7997.560134192442, 8896.199342059246, 9308.674196403364, 9491.0, 7476.289752473506, 7560.8487830244185, 7628.656710448154, 7631.732889348847, 7776.455648104578, 7658.655360508679, 7726.806829829299, 7772.572508512086, 7778.49439786412, 7862.2923936845955, 7365.558066516026, 7380.557166570023, 7430.554166750012, 7437.8140546486775, 7440.255974402517, 4822.662413631012, 4850.1997170466475, 4910.189818679878, 4955.554000140005, 4998.6750861193905, 5064.569511591409, 5124.769385377742, 5157.948420515897, 5384.353877534721, 5389.83830485086], "value": 4586.912344463834, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.5524287044926, 390.20982510416405, 395.19183270212415, 395.64589692225456, 399.54052839234896, 5085.79656813727, 5258.421573626898, 5269.946010797837, 5385.061377903951, 5404.243405923174, 5055.620828437864, 5166.664166829163, 5206.895862082756, 5226.7909283628605, 5271.314729085223, 4246.723962942414, 4257.0, 4258.55285195054, 4275.957240427587, 4280.186764514748, 4140.8136633851545, 4248.34150706641, 4271.188474189909, 4286.164197981395, 4305.225059489307, 4030.8186131624, 4139.19285739281, 4170.77060761658, 4225.070484493406, 4267.701260911737, 4244.575542445747, 4252.681048921343, 4252.87241382759, 4254.7021708480415, 4259.808308626135, 3865.768053916774, 3890.2414029264305, 3899.941500877489, 3900.553369159161, 3903.941440878389, 5051.898962020776, 5180.8963820723375, 5193.740312984373, 5196.480351964811, 5199.584033277329, 4907.067657145131, 4908.484609116027, 4932.80268789248, 4942.777575009133, 4949.653524253304, 5610.915836262459, 5618.297712785902, 5620.522255608278, 5635.464630860061, 5658.755073883739, 4109.260333140033, 4257.892947833586, 4272.081502476951, 4288.849890253858, 4297.183535128315, 5832.825015249549, 5872.618279811799, 5879.970600147015, 5903.7048147593305, 5904.97047514764, 4379.430674012422, 4379.824807007684, 4390.62679672225, 4418.116376724668, 4429.49060857999, 4316.740995540277, 4470.530594287553, 4471.128130014681, 4493.281075028045, 4500.099980004013, 4902.754862256873, 4912.189488734319, 4915.21356582945, 4918.508149185124, 4936.827211047668, 5618.887622247532, 5623.887522249532, 5624.312706188127, 5624.775008999594, 5646.124850648156, 1365.7336819320335, 1424.0031977615504, 1445.284584130862, 1523.3906437424896, 1544.088987497382, 946.8011717539393, 950.6625148072335, 979.8334283171878, 988.0415996483399, 993.145894530703, 4831.227003679394, 4837.685550439211, 4848.618143828991, 4886.2409532568245, 4899.828506002273, 5726.541876649858, 5730.570207234474, 5738.8278351649515, 5762.423757624204, 5766.538676905838, 4654.37165982588, 4750.714957102516, 4810.158222311082, 4866.853994380174, 4918.040982008474, 3018.501947178691, 3038.2404398900276, 3051.4965030769677, 3052.603161588979, 3058.7247147756807, 5180.637355385087, 5374.6506477078865, 5391.272178255964, 5410.404855465896, 5411.269478620415, 5885.087811389241, 5890.293164820163, 5895.528357731371, 5926.8814623707285, 5936.436038576328, 5358.0, 5364.988129451455, 5371.435999220103, 5378.838634840961, 5402.35171779389, 5498.175273708815, 5723.599348045597, 5723.8855222896145, 5759.712014399347, 5770.336411312753, 5626.859328516656, 5651.886962260814, 5659.462351076641, 5663.233949423588, 5670.603057785916, 5163.302954101148, 5383.650062745909, 5384.219288203267, 5388.326459192601, 5406.621536492407, 3992.5608183099257, 4012.0, 4059.2693315203546, 4064.4512990747053, 4074.959250407458, 5741.5119714824705, 5781.005553084179, 5782.508486778671, 5785.710714464344, 5794.478496935296, 5396.0, 5524.972375138259, 5542.8337149885565, 5556.361018482926, 5581.888362232651, 5505.421930697219, 5530.55755539564, 5541.861453463695, 5551.417101204315, 5554.50009499147, 5402.540784033401, 5418.07892658257, 5450.427705090909, 5453.363990802823, 5459.727013649381, 5323.973380133075, 5582.720863956867, 5617.5505959522325, 5618.803341883015, 5693.0148895773955, 5522.144067669517, 5522.751476183662, 5525.889482210253, 5537.5569954402745, 5550.5282051026115], "value": 4277.054132707435, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.8642271545692, 688.1466980943629, 696.6168607266003, 697.8360085379935, 700.9579425234487, 12053.939730301347, 12470.189437686568, 12487.43806528706, 12564.120511564182, 12573.685657858558, 12446.128770986035, 12572.434240459179, 12600.243985360885, 12632.68418289541, 12646.747065058717, 811.8051667599763, 831.9875201871977, 842.7893026743315, 843.2284459719349, 843.5529169540123, 845.7378212754035, 852.2713080316333, 852.8550146475114, 853.6798700487317, 853.871919212117, 883.2139395937621, 892.638481415028, 893.7318804358699, 893.7854914820429, 895.0288936503869, 874.868769684546, 889.5907882374115, 890.3411475508077, 890.768400215942, 891.1266958380824, 651.8859199640092, 653.7058323754329, 654.4110300729334, 655.2235600813052, 655.8163714160042, 11997.64007079789, 12144.149909506337, 12145.210561313575, 12160.027197824242, 12459.813102803466, 10563.313384629975, 10733.677989660322, 10847.349159050482, 11029.724256893642, 11160.609378671708, 9440.905590944072, 9513.33406661534, 9581.137697607179, 9735.853962190573, 9783.36408133469, 2634.670666166729, 2650.483155784623, 2655.614935834293, 2704.013035242142, 2732.8633568321507, 56725.43274567243, 58252.0, 58284.70857645685, 59021.704891475696, 59024.40975590232, 7983.600819958979, 7992.080910695345, 8062.596870156469, 8097.554634495159, 8107.55408452529, 16203.594910127342, 16229.59426014359, 16240.187990600423, 16243.918780406259, 16255.105969171573, 6437.774677886345, 6538.215414150237, 6591.143151390384, 6744.0, 6805.727770889208, 3321.8671253149605, 3322.4185767490594, 3365.747568932291, 3393.7794043387594, 3404.676555727202, 3497.8076205808925, 3542.4590303218183, 3575.6245594212755, 3587.3722098632634, 3593.9640603594153, 615.4983688294026, 620.1101419463085, 625.252822876658, 625.7309356976543, 637.964911929839, 528.4847273907909, 538.8383484954498, 548.4570275427299, 551.302602208207, 551.6056019945757, 8257.876131858027, 8358.665653373797, 8533.530655813865, 8592.613332400057, 8935.285177185939, 523.6884053987872, 530.6709839899287, 544.1592739217917, 556.4741319453078, 558.9608727389044, 4011.478507793968, 4035.515738111387, 4043.0903046814233, 4118.238125946709, 4178.916421671611, 61724.69137654373, 62706.372936270964, 63903.680481598225, 65493.672531637036, 65688.34311656917, 53516.73241633845, 53622.0, 54096.72951635216, 54415.45584544183, 54513.1823022655, 30857.382852343275, 39352.0, 39861.0, 39929.60070399317, 41371.0, 8660.696875609323, 8939.284857211278, 9122.498262595622, 9183.0, 9232.21526170283, 22526.887365563067, 22822.543549128593, 23055.077796887937, 23436.765632343457, 23438.0, 26718.465630687668, 27445.0, 30540.08379748611, 30956.22609434782, 31749.20626984344, 11076.944615276872, 11603.88396116028, 11617.0, 11635.650930472098, 11689.766204676029, 11992.880071199177, 12159.392030398622, 12167.087468439726, 12429.689257768629, 12878.0, 10645.361278323326, 10682.359058456517, 11120.555177793121, 11235.887641123483, 11605.129615279056, 11680.357580333164, 11943.223690460092, 11966.820497692715, 12178.73977298772, 12368.930011484837, 11088.724796648488, 11535.653930382103, 11543.36511491876, 11956.403161663497, 12079.154459187772, 7719.996400468128, 7789.298963093349, 7799.454038217497, 7925.128235894163, 8078.757637270891, 9343.392679475812, 9847.359921605359, 9904.158146557624, 9984.450855202744, 10015.549300281651], "value": 5942.7324908858445, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1549.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 110.0, 112.0, 110.0, 110.0, 114.0, 113.0, 111.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 122.0, 122.0, 166.0, 123.0, 134.0, 128.0, 122.0, 152.0, 125.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 164.0, 164.0, 163.0, 162.0, 163.0, 162.0, 163.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 115.0, 76.0, 75.0, 75.0, 75.0, 91.0, 84.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 110.0, 84.0, 84.0, 83.0, 103.0, 83.0, 85.0, 104.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 149.0, 149.0, 149.0, 149.0, 149.0, 148.0, 148.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 67.0, 66.0, 67.0, 66.0, 67.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 56.0, 56.0, 56.0, 56.0, 57.0, 56.0, 55.0], "value": 55.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 85.0, 83.0, 81.0, 84.0, 85.0, 84.0, 85.0, 83.0, 83.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 140.0, 134.0, 131.0, 140.0, 135.0, 133.0, 142.0, 183.0, 136.0], "value": 142.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 190.0, 191.0, 195.0, 210.0, 194.0, 194.0, 198.0, 193.0, 191.0], "value": 194.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 70.0, 70.0, 72.0, 71.0, 74.0, 71.0, 71.0, 74.0], "value": 71.5, "unit": "score"}]}]} 04:51:08 INFO - Return code: 0 04:51:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:51:09 ERROR - # TBPL SUCCESS # 04:51:09 INFO - Running post-action listener: _resource_record_post_action 04:51:09 INFO - [mozharness: 2017-03-27 11:51:09.015541Z] Finished run-tests step (success) 04:51:09 INFO - Running post-run listener: _resource_record_post_run 04:51:09 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 0; Write bytes: 273334272; Read time: 0; Write time: 120704 04:51:09 INFO - TinderboxPrint: CPU usage
12.9% 04:51:09 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:51:09 INFO - TinderboxPrint: I/O write bytes / time
273,334,272 / 120,704 04:51:09 INFO - TinderboxPrint: CPU idle
8,372.9 (87.0%) 04:51:09 INFO - TinderboxPrint: CPU user
1,201.0 (12.5%) 04:51:09 INFO - TinderboxPrint: Swap in / out
0 / 0 04:51:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 14696448; Read time: 0; Write time: 2856 04:51:09 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 258637824; Read time: 0; Write time: 117848 04:51:09 INFO - Running post-run listener: _upload_blobber_files 04:51:09 INFO - Blob upload gear active. 04:51:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:51:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:51:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:51:10 INFO - (blobuploader) - INFO - Open directory for files ... 04:51:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:51:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:51:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:11 INFO - (blobuploader) - INFO - Done attempting. 04:51:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:51:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:51:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:11 INFO - (blobuploader) - INFO - Done attempting. 04:51:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:51:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:51:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:12 INFO - (blobuploader) - INFO - Done attempting. 04:51:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:51:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:51:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:16 INFO - (blobuploader) - INFO - Done attempting. 04:51:16 INFO - (blobuploader) - INFO - Iteration through files over. 04:51:16 INFO - Return code: 0 04:51:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:51:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:51:16 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fff01d8f6babd45f1a165a15ef6da508330c9d1e39327a338b89c21e224d77279927cd35a4d0e74642ea8ce8a6f916d79ca7fbdedc8297332b5b9ba4cb8e9d83", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2fe0ebb45201b494bf85f43bf3ea082b483f40a3421ae78b2fb55592f0c32285a2964c8d9f2ebb16f6e55e8acc906791b6f61fdc12c0099c6e78bd4b63dd2c58", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dcd7bccf76bb1923e5cc217d93789093d64297ca6c56cbb0d7af8c76e3c143de814837004a6ee0d6300cbeb7ce4820291048ca9ff22fbbc3b6aad290ea42154c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db974b0164e54c7fcd7a45839ccadfaac19ea145e048dc98774d67a4cfa2f00708ff9629627fc5065ad8c7db9006e8ea9896ada486cdb3470e601b261b67c990"} 04:51:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:51:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:51:16 INFO - Contents: 04:51:16 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fff01d8f6babd45f1a165a15ef6da508330c9d1e39327a338b89c21e224d77279927cd35a4d0e74642ea8ce8a6f916d79ca7fbdedc8297332b5b9ba4cb8e9d83", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2fe0ebb45201b494bf85f43bf3ea082b483f40a3421ae78b2fb55592f0c32285a2964c8d9f2ebb16f6e55e8acc906791b6f61fdc12c0099c6e78bd4b63dd2c58", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dcd7bccf76bb1923e5cc217d93789093d64297ca6c56cbb0d7af8c76e3c143de814837004a6ee0d6300cbeb7ce4820291048ca9ff22fbbc3b6aad290ea42154c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db974b0164e54c7fcd7a45839ccadfaac19ea145e048dc98774d67a4cfa2f00708ff9629627fc5065ad8c7db9006e8ea9896ada486cdb3470e601b261b67c990"} 04:51:16 INFO - Running post-run listener: copy_logs_to_upload_dir 04:51:16 INFO - Copying logs to upload dir... 04:51:16 INFO - mkdir: /builds/slave/test/build/upload/logs 04:51:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.965624 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-03-27 04:51:16.055783) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 04:51:16.059711) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501 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/fff01d8f6babd45f1a165a15ef6da508330c9d1e39327a338b89c21e224d77279927cd35a4d0e74642ea8ce8a6f916d79ca7fbdedc8297332b5b9ba4cb8e9d83", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2fe0ebb45201b494bf85f43bf3ea082b483f40a3421ae78b2fb55592f0c32285a2964c8d9f2ebb16f6e55e8acc906791b6f61fdc12c0099c6e78bd4b63dd2c58", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dcd7bccf76bb1923e5cc217d93789093d64297ca6c56cbb0d7af8c76e3c143de814837004a6ee0d6300cbeb7ce4820291048ca9ff22fbbc3b6aad290ea42154c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db974b0164e54c7fcd7a45839ccadfaac19ea145e048dc98774d67a4cfa2f00708ff9629627fc5065ad8c7db9006e8ea9896ada486cdb3470e601b261b67c990"} build_url:https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011306 build_url: 'https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fff01d8f6babd45f1a165a15ef6da508330c9d1e39327a338b89c21e224d77279927cd35a4d0e74642ea8ce8a6f916d79ca7fbdedc8297332b5b9ba4cb8e9d83", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2fe0ebb45201b494bf85f43bf3ea082b483f40a3421ae78b2fb55592f0c32285a2964c8d9f2ebb16f6e55e8acc906791b6f61fdc12c0099c6e78bd4b63dd2c58", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dcd7bccf76bb1923e5cc217d93789093d64297ca6c56cbb0d7af8c76e3c143de814837004a6ee0d6300cbeb7ce4820291048ca9ff22fbbc3b6aad290ea42154c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db974b0164e54c7fcd7a45839ccadfaac19ea145e048dc98774d67a4cfa2f00708ff9629627fc5065ad8c7db9006e8ea9896ada486cdb3470e601b261b67c990"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 04:51:16.088082) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 04:51:16.088667) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1490614196.252505-616753501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 04:51:16.172458) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 04:51:16.172769) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 04:51:16.173094) ========= ========= Total master_lag: 0.26 =========