builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-063 starttime: 1483205221.12 results: success (0) revision: 6d7fe8c8fb5867512d3332b8aa8109a0d8a3d841 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-31 09:27:01.117833) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-31 09:27:01.118815) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-31 09:27:01.119122) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-31 09:27:01.133689) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 09:27:01.134040) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-31 09:27:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-12-31 09:27:03 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118283 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 09:27:01.266428) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 09:27:01.266751) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017277 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 09:27:01.318070) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 09:27:01.318406) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6d7fe8c8fb5867512d3332b8aa8109a0d8a3d841 --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 6d7fe8c8fb5867512d3332b8aa8109a0d8a3d841 --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=769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-31 09:27:03,249 truncating revision to first 12 chars 2016-12-31 09:27:03,250 Setting DEBUG logging. 2016-12-31 09:27:03,250 attempt 1/10 2016-12-31 09:27:03,250 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6d7fe8c8fb58?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-31 09:27:03,615 unpacking tar archive at: mozilla-central-6d7fe8c8fb58/testing/mozharness/ program finished with exit code 0 elapsedTime=0.684190 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 09:27:02.018116) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-31 09:27:02.018622) ========= script_repo_revision: 6d7fe8c8fb5867512d3332b8aa8109a0d8a3d841 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-31 09:27:02.019253) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-31 09:27:02.019711) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-31 09:27:02.031045) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-12-31 09:27:02.031641) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:27:04 INFO - MultiFileLogger online at 20161231 09:27:04 in /builds/slave/test 09:27:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:27:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:27:04 INFO - {'append_to_log': False, 09:27:04 INFO - 'base_work_dir': '/builds/slave/test', 09:27:04 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:27:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:27:04 INFO - 'branch': 'Firefox-Non-PGO', 09:27:04 INFO - 'buildbot_json_path': 'buildprops.json', 09:27:04 INFO - 'config_files': ('talos/linux_config.py',), 09:27:04 INFO - 'default_actions': ('clobber', 09:27:04 INFO - 'read-buildbot-config', 09:27:04 INFO - 'download-and-extract', 09:27:04 INFO - 'populate-webroot', 09:27:04 INFO - 'create-virtualenv', 09:27:04 INFO - 'install', 09:27:04 INFO - 'run-tests'), 09:27:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:27:04 INFO - 'download_minidump_stackwalk': True, 09:27:04 INFO - 'download_symbols': 'ondemand', 09:27:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:27:04 INFO - 'tooltool.py': '/tools/tooltool.py', 09:27:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:27:04 INFO - '/tools/misc-python/virtualenv.py')}, 09:27:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:27:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:27:04 INFO - 'installer_path': 'installer.exe', 09:27:04 INFO - 'log_level': 'info', 09:27:04 INFO - 'log_name': 'talos', 09:27:04 INFO - 'log_to_console': True, 09:27:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:27:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:27:04 INFO - 'opt_config_files': (), 09:27:04 INFO - 'pip_index': False, 09:27:04 INFO - 'sps_profile': False, 09:27:04 INFO - 'sps_profile_interval': 0, 09:27:04 INFO - 'suite': 'dromaeojs-e10s', 09:27:04 INFO - 'system_bits': '32', 09:27:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:27:04 INFO - 'title': 'talos-linux64-ix-063', 09:27:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:27:04 INFO - 'use_talos_json': True, 09:27:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:27:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:27:04 INFO - 'work_dir': 'build'} 09:27:04 INFO - [mozharness: 2016-12-31 17:27:04.068433Z] Running clobber step. 09:27:04 INFO - Running pre-action listener: _resource_record_pre_action 09:27:04 INFO - Running main action method: clobber 09:27:04 INFO - rmtree: /builds/slave/test/build 09:27:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:27:04 INFO - Running post-action listener: _resource_record_post_action 09:27:04 INFO - [mozharness: 2016-12-31 17:27:04.534251Z] Finished clobber step (success) 09:27:04 INFO - [mozharness: 2016-12-31 17:27:04.534352Z] Running read-buildbot-config step. 09:27:04 INFO - Running pre-action listener: _resource_record_pre_action 09:27:04 INFO - Running main action method: read_buildbot_config 09:27:04 INFO - Using buildbot properties: 09:27:04 INFO - { 09:27:04 INFO - "project": "", 09:27:04 INFO - "product": "firefox", 09:27:04 INFO - "who": "philringnalda@gmail.com", 09:27:04 INFO - "installer_path": "public/build/target.tar.bz2", 09:27:04 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:27:04 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:27:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:27:04 INFO - "stage_platform": "linux64", 09:27:04 INFO - "basedir": "/builds/slave/test", 09:27:04 INFO - "buildnumber": 338, 09:27:04 INFO - "platform": "ubuntu64_hw", 09:27:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:27:04 INFO - "slavebuilddir": "test", 09:27:04 INFO - "taskId": "RDd0Ad-1Qbea2JPzYbv-Vg", 09:27:04 INFO - "branch": "mozilla-central", 09:27:04 INFO - "script_repo_revision": "production", 09:27:04 INFO - "revision": "6d7fe8c8fb5867512d3332b8aa8109a0d8a3d841", 09:27:04 INFO - "slavename": "talos-linux64-ix-063", 09:27:04 INFO - "repo_path": "mozilla-central" 09:27:04 INFO - } 09:27:04 INFO - Finding installer, test and symbols from parent task. 09:27:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RDd0Ad-1Qbea2JPzYbv-Vg'}, attempt #1 09:27:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RDd0Ad-1Qbea2JPzYbv-Vg'}, attempt #1 09:27:05 INFO - Task dependencies: Mz5ZWQo9RC6WqJSlpeMcXA 09:27:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mz5ZWQo9RC6WqJSlpeMcXA'}, attempt #1 09:27:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Mz5ZWQo9RC6WqJSlpeMcXA/artifacts/public/build/target.tar.bz2 09:27:05 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Mz5ZWQo9RC6WqJSlpeMcXA/artifacts/public/build/test_packages.json 09:27:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Mz5ZWQo9RC6WqJSlpeMcXA/artifacts/public/build/target.crashreporter-symbols.zip 09:27:05 INFO - Running post-action listener: _resource_record_post_action 09:27:05 INFO - [mozharness: 2016-12-31 17:27:05.926294Z] Finished read-buildbot-config step (success) 09:27:05 INFO - [mozharness: 2016-12-31 17:27:05.926511Z] Running download-and-extract step. 09:27:05 INFO - Running pre-action listener: _resource_record_pre_action 09:27:05 INFO - Running main action method: download_and_extract 09:27:05 INFO - mkdir: /builds/slave/test/build/tests 09:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:05 INFO - trying https://queue.taskcluster.net/v1/task/Mz5ZWQo9RC6WqJSlpeMcXA/artifacts/public/build/target.test_packages.json 09:27:05 INFO - Downloading https://queue.taskcluster.net/v1/task/Mz5ZWQo9RC6WqJSlpeMcXA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:27:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mz5ZWQo9RC6WqJSlpeMcXA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:27:06 INFO - Downloaded 896 bytes. 09:27:06 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:27:06 INFO - Using the following test package requirements: 09:27:06 INFO - {u'common': [u'target.common.tests.zip'], 09:27:06 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:27:06 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:27:06 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:27:06 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:27:06 INFO - u'mozbase': [u'target.common.tests.zip'], 09:27:06 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:27:06 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:27:06 INFO - u'web-platform': [u'target.common.tests.zip', 09:27:06 INFO - u'target.web-platform.tests.zip'], 09:27:06 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:27:06 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:27:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mz5ZWQo9RC6WqJSlpeMcXA/artifacts/public/build/target.common.tests.zip 09:27:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mz5ZWQo9RC6WqJSlpeMcXA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:27:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Mz5ZWQo9RC6WqJSlpeMcXA/artifacts/public/build/target.common.tests.zip into memory 09:27:07 INFO - Expected file size: 20246344 09:27:07 INFO - Obtained file size: 20246344 09:27:11 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:27:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mz5ZWQo9RC6WqJSlpeMcXA/artifacts/public/build/target.common.tests.zip 09:27:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mz5ZWQo9RC6WqJSlpeMcXA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:27:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Mz5ZWQo9RC6WqJSlpeMcXA/artifacts/public/build/target.common.tests.zip into memory 09:27:12 INFO - Expected file size: 20246344 09:27:12 INFO - Obtained file size: 20246344 09:27:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mz5ZWQo9RC6WqJSlpeMcXA/artifacts/public/build/target.talos.tests.zip 09:27:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mz5ZWQo9RC6WqJSlpeMcXA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:27:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Mz5ZWQo9RC6WqJSlpeMcXA/artifacts/public/build/target.talos.tests.zip into memory 09:27:17 INFO - Expected file size: 14409776 09:27:17 INFO - Obtained file size: 14409776 09:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:17 INFO - trying https://queue.taskcluster.net/v1/task/Mz5ZWQo9RC6WqJSlpeMcXA/artifacts/public/build/target.tar.bz2 09:27:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Mz5ZWQo9RC6WqJSlpeMcXA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:27:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mz5ZWQo9RC6WqJSlpeMcXA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:27:18 INFO - Downloaded 55825975 bytes. 09:27:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Mz5ZWQo9RC6WqJSlpeMcXA/artifacts/public/build/target.tar.bz2 09:27:18 INFO - mkdir: /builds/slave/test/properties 09:27:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:27:18 INFO - Writing to file /builds/slave/test/properties/build_url 09:27:18 INFO - Contents: 09:27:18 INFO - build_url:https://queue.taskcluster.net/v1/task/Mz5ZWQo9RC6WqJSlpeMcXA/artifacts/public/build/target.tar.bz2 09:27:18 INFO - Running post-action listener: _resource_record_post_action 09:27:18 INFO - Running post-action listener: set_extra_try_arguments 09:27:18 INFO - [mozharness: 2016-12-31 17:27:18.632242Z] Finished download-and-extract step (success) 09:27:18 INFO - [mozharness: 2016-12-31 17:27:18.632360Z] Running populate-webroot step. 09:27:18 INFO - Running pre-action listener: _resource_record_pre_action 09:27:18 INFO - Running main action method: populate_webroot 09:27:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:27:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:27:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:27:18 INFO - '--tppagecycles', 09:27:18 INFO - '7'], 09:27:18 INFO - 'tests': ['tsvgm']}}, 09:27:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:27:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:27:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:27:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:27:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:27:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:27:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:27:18 INFO - 'talos_options': ['--disable-e10s'], 09:27:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:27:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:27:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:27:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:27:18 INFO - 'talos_options': ['--disable-e10s'], 09:27:18 INFO - 'tests': ['damp', 'tps']}, 09:27:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:27:18 INFO - 'tests': ['damp', 'tps']}, 09:27:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:27:18 INFO - 'tests': ['dromaeo_dom']}, 09:27:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:27:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:27:18 INFO - 'tests': ['basic_compositor_video']}, 09:27:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:27:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:27:18 INFO - 'tests': ['a11yr', 09:27:18 INFO - 'ts_paint', 09:27:18 INFO - 'tpaint', 09:27:18 INFO - 'sessionrestore', 09:27:18 INFO - 'sessionrestore_no_auto_restore', 09:27:18 INFO - 'tabpaint']}, 09:27:18 INFO - 'other-e10s': {'tests': ['a11yr', 09:27:18 INFO - 'ts_paint', 09:27:18 INFO - 'tpaint', 09:27:18 INFO - 'sessionrestore', 09:27:18 INFO - 'sessionrestore_no_auto_restore', 09:27:18 INFO - 'tabpaint']}, 09:27:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:27:18 INFO - 'ts_paint', 09:27:18 INFO - 'tpaint', 09:27:18 INFO - 'sessionrestore', 09:27:18 INFO - 'sessionrestore_no_auto_restore', 09:27:18 INFO - 'tabpaint']}, 09:27:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:27:18 INFO - 'ts_paint', 09:27:18 INFO - 'tpaint', 09:27:18 INFO - 'sessionrestore', 09:27:18 INFO - 'sessionrestore_no_auto_restore', 09:27:18 INFO - 'tabpaint']}, 09:27:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:27:18 INFO - 'tests': ['a11yr', 09:27:18 INFO - 'ts_paint', 09:27:18 INFO - 'tpaint', 09:27:18 INFO - 'sessionrestore', 09:27:18 INFO - 'sessionrestore_no_auto_restore', 09:27:18 INFO - 'tabpaint']}, 09:27:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:27:18 INFO - 'tests': ['a11yr', 09:27:18 INFO - 'ts_paint', 09:27:18 INFO - 'tpaint', 09:27:18 INFO - 'sessionrestore', 09:27:18 INFO - 'sessionrestore_no_auto_restore', 09:27:18 INFO - 'tabpaint']}, 09:27:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:27:18 INFO - 'tests': ['tsvgx', 09:27:18 INFO - 'tsvgr_opacity', 09:27:18 INFO - 'tart', 09:27:18 INFO - 'tscrollx', 09:27:18 INFO - 'cart', 09:27:18 INFO - 'tsvg_static']}, 09:27:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:27:18 INFO - 'tsvgr_opacity', 09:27:18 INFO - 'tart', 09:27:18 INFO - 'tscrollx', 09:27:18 INFO - 'cart', 09:27:18 INFO - 'tsvg_static']}, 09:27:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:27:18 INFO - 'talos_options': ['--disable-e10s'], 09:27:18 INFO - 'tests': ['tp5o']}, 09:27:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:27:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:27:18 INFO - 'talos_options': ['--disable-e10s', 09:27:18 INFO - '--xperf_path', 09:27:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:27:18 INFO - 'tests': ['tp5n']}, 09:27:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:27:18 INFO - 'talos_options': ['--xperf_path', 09:27:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:27:18 INFO - 'tests': ['tp5n']}}, 09:27:18 INFO - 'talos.zip': {'path': '', 09:27:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:27:18 INFO - Running post-action listener: _resource_record_post_action 09:27:18 INFO - [mozharness: 2016-12-31 17:27:18.645447Z] Finished populate-webroot step (success) 09:27:18 INFO - [mozharness: 2016-12-31 17:27:18.645536Z] Running create-virtualenv step. 09:27:18 INFO - Running pre-action listener: _resource_record_pre_action 09:27:18 INFO - Running main action method: create_virtualenv 09:27:18 INFO - Creating virtualenv /builds/slave/test/build/venv 09:27:18 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 09:27:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:27:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:27:18 INFO - Using real prefix '/usr' 09:27:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:27:19 INFO - Installing distribute.............................................................................................................................................................................................done. 09:27:21 INFO - Installing pip.................done. 09:27:21 INFO - Return code: 0 09:27:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:27:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:27:21 INFO - Reading from file tmpfile_stdout 09:27:21 INFO - Output received: 09:27:21 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) 09:27:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:27:21 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')]} 09:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:21 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')]} 09:27:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:21 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 0x27c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b39480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b36820>, '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 0x2b37520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b379b0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595', '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 09:27:21 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 09:27:21 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 09:27:21 INFO - Using env: {'DISPLAY': ':0', 09:27:21 INFO - 'HOME': '/home/cltbld', 09:27:21 INFO - 'LANG': 'en_US.UTF-8', 09:27:21 INFO - 'LANGUAGE': 'en_US:en', 09:27:21 INFO - 'LOGNAME': 'cltbld', 09:27:21 INFO - 'MAIL': '/var/mail/cltbld', 09:27:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:21 INFO - 'MOZ_NO_REMOTE': '1', 09:27:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:27:21 INFO - 'NO_EM_RESTART': '1', 09:27:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:27:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:21 INFO - 'PWD': '/builds/slave/test', 09:27:21 INFO - 'SHELL': '/bin/bash', 09:27:21 INFO - 'SHLVL': '1', 09:27:21 INFO - 'TERM': 'linux', 09:27:21 INFO - 'TMOUT': '86400', 09:27:21 INFO - 'USER': 'cltbld', 09:27:21 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595', 09:27:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:21 INFO - '_': '/tools/buildbot/bin/python'} 09:27:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:21 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 09:27:21 INFO - Cleaning up... 09:27:21 INFO - Return code: 0 09:27:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:27:21 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')]} 09:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:21 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')]} 09:27:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:21 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 0x27c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b39480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b36820>, '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 0x2b37520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b379b0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595', '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 09:27:21 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 09:27:21 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 09:27:21 INFO - Using env: {'DISPLAY': ':0', 09:27:21 INFO - 'HOME': '/home/cltbld', 09:27:21 INFO - 'LANG': 'en_US.UTF-8', 09:27:21 INFO - 'LANGUAGE': 'en_US:en', 09:27:21 INFO - 'LOGNAME': 'cltbld', 09:27:21 INFO - 'MAIL': '/var/mail/cltbld', 09:27:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:21 INFO - 'MOZ_NO_REMOTE': '1', 09:27:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:27:21 INFO - 'NO_EM_RESTART': '1', 09:27:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:27:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:21 INFO - 'PWD': '/builds/slave/test', 09:27:21 INFO - 'SHELL': '/bin/bash', 09:27:21 INFO - 'SHLVL': '1', 09:27:21 INFO - 'TERM': 'linux', 09:27:21 INFO - 'TMOUT': '86400', 09:27:21 INFO - 'USER': 'cltbld', 09:27:21 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595', 09:27:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:21 INFO - '_': '/tools/buildbot/bin/python'} 09:27:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:21 INFO - Downloading/unpacking psutil>=3.1.1 09:27:21 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 09:27:21 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 09:27:21 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 09:27:21 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 09:27:21 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 09:27:21 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 09:27:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:27:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:27:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:27:23 INFO - Installing collected packages: psutil 09:27:23 INFO - Running setup.py install for psutil 09:27:24 INFO - building 'psutil._psutil_linux' extension 09:27:24 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 09:27:24 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 09:27:24 INFO - building 'psutil._psutil_posix' extension 09:27:24 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 09:27:24 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 09:27:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:27:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:27:24 INFO - Successfully installed psutil 09:27:24 INFO - Cleaning up... 09:27:24 INFO - Return code: 0 09:27:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:27:24 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')]} 09:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:24 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')]} 09:27:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:24 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 0x27c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b39480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b36820>, '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 0x2b37520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b379b0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595', '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 09:27:24 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 09:27:24 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 09:27:24 INFO - Using env: {'DISPLAY': ':0', 09:27:24 INFO - 'HOME': '/home/cltbld', 09:27:24 INFO - 'LANG': 'en_US.UTF-8', 09:27:24 INFO - 'LANGUAGE': 'en_US:en', 09:27:24 INFO - 'LOGNAME': 'cltbld', 09:27:24 INFO - 'MAIL': '/var/mail/cltbld', 09:27:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:24 INFO - 'MOZ_NO_REMOTE': '1', 09:27:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:27:24 INFO - 'NO_EM_RESTART': '1', 09:27:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:27:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:24 INFO - 'PWD': '/builds/slave/test', 09:27:24 INFO - 'SHELL': '/bin/bash', 09:27:24 INFO - 'SHLVL': '1', 09:27:24 INFO - 'TERM': 'linux', 09:27:24 INFO - 'TMOUT': '86400', 09:27:24 INFO - 'USER': 'cltbld', 09:27:24 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595', 09:27:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:24 INFO - '_': '/tools/buildbot/bin/python'} 09:27:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:27:24 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 09:27:24 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 09:27:24 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 09:27:24 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 09:27:24 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 09:27:24 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 09:27:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:27:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:27:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:27:26 INFO - Installing collected packages: mozsystemmonitor 09:27:26 INFO - Running setup.py install for mozsystemmonitor 09:27:26 INFO - Successfully installed mozsystemmonitor 09:27:26 INFO - Cleaning up... 09:27:26 INFO - Return code: 0 09:27:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:27:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:26 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 0x27c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b39480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b36820>, '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 0x2b37520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b379b0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595', '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 09:27:26 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 09:27:26 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 09:27:26 INFO - Using env: {'DISPLAY': ':0', 09:27:26 INFO - 'HOME': '/home/cltbld', 09:27:26 INFO - 'LANG': 'en_US.UTF-8', 09:27:26 INFO - 'LANGUAGE': 'en_US:en', 09:27:26 INFO - 'LOGNAME': 'cltbld', 09:27:26 INFO - 'MAIL': '/var/mail/cltbld', 09:27:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:26 INFO - 'MOZ_NO_REMOTE': '1', 09:27:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:27:26 INFO - 'NO_EM_RESTART': '1', 09:27:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:27:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:26 INFO - 'PWD': '/builds/slave/test', 09:27:26 INFO - 'SHELL': '/bin/bash', 09:27:26 INFO - 'SHLVL': '1', 09:27:26 INFO - 'TERM': 'linux', 09:27:26 INFO - 'TMOUT': '86400', 09:27:26 INFO - 'USER': 'cltbld', 09:27:26 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595', 09:27:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:26 INFO - '_': '/tools/buildbot/bin/python'} 09:27:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:27 INFO - Downloading/unpacking jsonschema==2.5.1 09:27:27 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 09:27:27 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 09:27:27 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 09:27:27 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 09:27:27 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 09:27:27 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 09:27:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:27:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:27:29 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 09:27:29 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 09:27:29 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 09:27:29 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 09:27:29 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 09:27:29 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 09:27:29 INFO - Downloading functools32-3.2.3-2.tar.gz 09:27:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:27:29 INFO - warning: no files found matching '*.txt' 09:27:29 INFO - no previously-included directories found matching 'build' 09:27:29 INFO - no previously-included directories found matching 'dist' 09:27:29 INFO - no previously-included directories found matching '.git*' 09:27:29 INFO - Installing collected packages: jsonschema, functools32 09:27:29 INFO - Running setup.py install for functools32 09:27:29 INFO - warning: no files found matching '*.txt' 09:27:29 INFO - no previously-included directories found matching 'build' 09:27:29 INFO - no previously-included directories found matching 'dist' 09:27:29 INFO - no previously-included directories found matching '.git*' 09:27:29 INFO - Successfully installed jsonschema functools32 09:27:29 INFO - Cleaning up... 09:27:29 INFO - Return code: 0 09:27:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:29 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 0x27c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b39480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b36820>, '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 0x2b37520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b379b0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595', '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 09:27:29 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 09:27:29 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 09:27:29 INFO - Using env: {'DISPLAY': ':0', 09:27:29 INFO - 'HOME': '/home/cltbld', 09:27:29 INFO - 'LANG': 'en_US.UTF-8', 09:27:29 INFO - 'LANGUAGE': 'en_US:en', 09:27:29 INFO - 'LOGNAME': 'cltbld', 09:27:29 INFO - 'MAIL': '/var/mail/cltbld', 09:27:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:29 INFO - 'MOZ_NO_REMOTE': '1', 09:27:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:27:29 INFO - 'NO_EM_RESTART': '1', 09:27:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:27:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:29 INFO - 'PWD': '/builds/slave/test', 09:27:29 INFO - 'SHELL': '/bin/bash', 09:27:29 INFO - 'SHLVL': '1', 09:27:29 INFO - 'TERM': 'linux', 09:27:29 INFO - 'TMOUT': '86400', 09:27:29 INFO - 'USER': 'cltbld', 09:27:29 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595', 09:27:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:29 INFO - '_': '/tools/buildbot/bin/python'} 09:27:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:27:29 INFO - Cleaning up... 09:27:29 INFO - Return code: 0 09:27:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:29 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 0x27c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b39480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b36820>, '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 0x2b37520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b379b0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595', '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 09:27:29 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 09:27:29 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 09:27:29 INFO - Using env: {'DISPLAY': ':0', 09:27:29 INFO - 'HOME': '/home/cltbld', 09:27:29 INFO - 'LANG': 'en_US.UTF-8', 09:27:29 INFO - 'LANGUAGE': 'en_US:en', 09:27:29 INFO - 'LOGNAME': 'cltbld', 09:27:29 INFO - 'MAIL': '/var/mail/cltbld', 09:27:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:29 INFO - 'MOZ_NO_REMOTE': '1', 09:27:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:27:29 INFO - 'NO_EM_RESTART': '1', 09:27:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:27:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:29 INFO - 'PWD': '/builds/slave/test', 09:27:29 INFO - 'SHELL': '/bin/bash', 09:27:29 INFO - 'SHLVL': '1', 09:27:29 INFO - 'TERM': 'linux', 09:27:29 INFO - 'TMOUT': '86400', 09:27:29 INFO - 'USER': 'cltbld', 09:27:29 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595', 09:27:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:29 INFO - '_': '/tools/buildbot/bin/python'} 09:27:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:30 INFO - Downloading/unpacking blobuploader==1.2.4 09:27:30 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 09:27:30 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 09:27:30 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 09:27:30 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 09:27:30 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 09:27:30 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 09:27:32 INFO - Downloading blobuploader-1.2.4.tar.gz 09:27:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:27:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:27:32 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 09:27:32 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 09:27:32 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 09:27:32 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 09:27:32 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 09:27:32 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 09:27:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:27:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:27:32 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 09:27:32 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 09:27:32 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 09:27:32 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 09:27:32 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 09:27:32 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 09:27:32 INFO - Downloading docopt-0.6.1.tar.gz 09:27:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:27:32 INFO - Installing collected packages: blobuploader, requests, docopt 09:27:32 INFO - Running setup.py install for blobuploader 09:27:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:27:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:27:32 INFO - Running setup.py install for requests 09:27:33 INFO - Running setup.py install for docopt 09:27:33 INFO - Successfully installed blobuploader requests docopt 09:27:33 INFO - Cleaning up... 09:27:33 INFO - Return code: 0 09:27:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:27:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:33 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 0x27c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b39480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b36820>, '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 0x2b37520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b379b0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595', '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 09:27:33 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 09:27:33 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 09:27:33 INFO - Using env: {'DISPLAY': ':0', 09:27:33 INFO - 'HOME': '/home/cltbld', 09:27:33 INFO - 'LANG': 'en_US.UTF-8', 09:27:33 INFO - 'LANGUAGE': 'en_US:en', 09:27:33 INFO - 'LOGNAME': 'cltbld', 09:27:33 INFO - 'MAIL': '/var/mail/cltbld', 09:27:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:33 INFO - 'MOZ_NO_REMOTE': '1', 09:27:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:27:33 INFO - 'NO_EM_RESTART': '1', 09:27:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:27:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:33 INFO - 'PWD': '/builds/slave/test', 09:27:33 INFO - 'SHELL': '/bin/bash', 09:27:33 INFO - 'SHLVL': '1', 09:27:33 INFO - 'TERM': 'linux', 09:27:33 INFO - 'TMOUT': '86400', 09:27:33 INFO - 'USER': 'cltbld', 09:27:33 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595', 09:27:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:33 INFO - '_': '/tools/buildbot/bin/python'} 09:27:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:27:33 INFO - Running setup.py (path:/tmp/pip-YW64to-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:27:33 INFO - Running setup.py (path:/tmp/pip-z7WZQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:27:33 INFO - Running setup.py (path:/tmp/pip-RNXO0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:27:33 INFO - Running setup.py (path:/tmp/pip-s7_Mk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:27:34 INFO - Running setup.py (path:/tmp/pip-CngM9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:27:34 INFO - Running setup.py (path:/tmp/pip-JtOGOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:27:34 INFO - Running setup.py (path:/tmp/pip-Me0RaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:27:34 INFO - Running setup.py (path:/tmp/pip-b1KRvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:27:34 INFO - Running setup.py (path:/tmp/pip-6f7dZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:27:34 INFO - Running setup.py (path:/tmp/pip-19gRoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:27:34 INFO - Running setup.py (path:/tmp/pip-ecrwo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:27:34 INFO - Running setup.py (path:/tmp/pip-AJ2ETP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:27:34 INFO - Running setup.py (path:/tmp/pip-btanmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:27:34 INFO - Running setup.py (path:/tmp/pip-CLZ0tc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:27:34 INFO - Running setup.py (path:/tmp/pip-DCB15J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:27:34 INFO - Running setup.py (path:/tmp/pip-0ihaD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:27:34 INFO - Running setup.py (path:/tmp/pip-3omAOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:27:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:27:34 INFO - Running setup.py install for manifestparser 09:27:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:27:35 INFO - Running setup.py install for mozcrash 09:27:35 INFO - Running setup.py install for mozdebug 09:27:35 INFO - Running setup.py install for mozdevice 09:27:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:27:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:27:35 INFO - Running setup.py install for mozfile 09:27:35 INFO - Running setup.py install for mozhttpd 09:27:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:27:35 INFO - Running setup.py install for mozinfo 09:27:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:27:35 INFO - Running setup.py install for mozInstall 09:27:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:27:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:27:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:27:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:27:35 INFO - Running setup.py install for mozleak 09:27:35 INFO - Running setup.py install for mozlog 09:27:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:27:35 INFO - Running setup.py install for moznetwork 09:27:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:27:36 INFO - Running setup.py install for mozprocess 09:27:36 INFO - Running setup.py install for mozprofile 09:27:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:27:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:27:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:27:36 INFO - Running setup.py install for mozrunner 09:27:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:27:36 INFO - Running setup.py install for mozscreenshot 09:27:36 INFO - Running setup.py install for moztest 09:27:36 INFO - Running setup.py install for mozversion 09:27:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:27:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:27:36 INFO - Cleaning up... 09:27:36 INFO - Return code: 0 09:27:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:27: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')]} 09:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27: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')]} 09:27:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:36 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 0x27c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b39480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b36820>, '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 0x2b37520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b379b0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595', '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 09:27:36 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 09:27:36 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 09:27:36 INFO - Using env: {'DISPLAY': ':0', 09:27:36 INFO - 'HOME': '/home/cltbld', 09:27:36 INFO - 'LANG': 'en_US.UTF-8', 09:27:36 INFO - 'LANGUAGE': 'en_US:en', 09:27:36 INFO - 'LOGNAME': 'cltbld', 09:27:36 INFO - 'MAIL': '/var/mail/cltbld', 09:27:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:36 INFO - 'MOZ_NO_REMOTE': '1', 09:27:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:27:36 INFO - 'NO_EM_RESTART': '1', 09:27:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:27:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:36 INFO - 'PWD': '/builds/slave/test', 09:27:36 INFO - 'SHELL': '/bin/bash', 09:27:36 INFO - 'SHLVL': '1', 09:27:36 INFO - 'TERM': 'linux', 09:27:36 INFO - 'TMOUT': '86400', 09:27:36 INFO - 'USER': 'cltbld', 09:27:36 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595', 09:27:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:36 INFO - '_': '/tools/buildbot/bin/python'} 09:27:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:27:36 INFO - Running setup.py (path:/tmp/pip-F0OsBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:27:37 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)) 09:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:27:37 INFO - Running setup.py (path:/tmp/pip-QypSMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:27:37 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)) 09:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:27:37 INFO - Running setup.py (path:/tmp/pip-C74JhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:27:37 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)) 09:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:27:37 INFO - Running setup.py (path:/tmp/pip-q3aUQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:27:37 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)) 09:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:27:37 INFO - Running setup.py (path:/tmp/pip-n4HxZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:27:37 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)) 09:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:27:37 INFO - Running setup.py (path:/tmp/pip-dSa7tO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:27:37 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)) 09:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:27:37 INFO - Running setup.py (path:/tmp/pip-2QN5qY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:27:37 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)) 09:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:27:37 INFO - Running setup.py (path:/tmp/pip-pxIO2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:27:37 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)) 09:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:27:37 INFO - Running setup.py (path:/tmp/pip-PNdtUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:27:37 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)) 09:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:27:37 INFO - Running setup.py (path:/tmp/pip-69_agK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:27:37 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)) 09:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:27:37 INFO - Running setup.py (path:/tmp/pip-TIEHkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:27:37 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)) 09:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:27:37 INFO - Running setup.py (path:/tmp/pip-Gznw__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:27:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 09:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:27:37 INFO - Running setup.py (path:/tmp/pip-peUsom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:27:37 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)) 09:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:27:37 INFO - Running setup.py (path:/tmp/pip-gqBuyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:27:37 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)) 09:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:27:37 INFO - Running setup.py (path:/tmp/pip-YD60DY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:27:38 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)) 09:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:27:38 INFO - Running setup.py (path:/tmp/pip-A2jVQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:27:38 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)) 09:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:27:38 INFO - Running setup.py (path:/tmp/pip-MH6R9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:27:38 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)) 09:27:38 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)) 09:27:38 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)) 09:27:38 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)) 09:27:38 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)) 09:27:38 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)) 09:27:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:27:38 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 09:27:38 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 09:27:38 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 09:27:38 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 09:27:38 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 09:27:38 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 09:27:40 INFO - Downloading blessings-1.6.tar.gz 09:27:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:27:40 INFO - Installing collected packages: blessings 09:27:40 INFO - Running setup.py install for blessings 09:27:40 INFO - Successfully installed blessings 09:27:40 INFO - Cleaning up... 09:27:40 INFO - Return code: 0 09:27:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:27:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:27:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:27:40 INFO - Reading from file tmpfile_stdout 09:27:40 INFO - Current package versions: 09:27:40 INFO - argparse == 1.2.1 09:27:40 INFO - blessings == 1.6 09:27:40 INFO - blobuploader == 1.2.4 09:27:40 INFO - docopt == 0.6.1 09:27:40 INFO - functools32 == 3.2.3-2 09:27:40 INFO - jsonschema == 2.5.1 09:27:40 INFO - manifestparser == 1.1 09:27:40 INFO - mozInstall == 1.12 09:27:40 INFO - mozcrash == 1.0 09:27:40 INFO - mozdebug == 0.1 09:27:40 INFO - mozdevice == 0.49 09:27:40 INFO - mozfile == 1.2 09:27:40 INFO - mozhttpd == 0.7 09:27:40 INFO - mozinfo == 0.9 09:27:40 INFO - mozleak == 0.1 09:27:40 INFO - mozlog == 3.4 09:27:40 INFO - moznetwork == 0.27 09:27:40 INFO - mozprocess == 0.23 09:27:40 INFO - mozprofile == 0.28 09:27:40 INFO - mozrunner == 6.13 09:27:40 INFO - mozscreenshot == 0.1 09:27:40 INFO - mozsystemmonitor == 0.3 09:27:40 INFO - moztest == 0.8 09:27:40 INFO - mozversion == 1.4 09:27:40 INFO - psutil == 3.1.1 09:27:40 INFO - requests == 1.2.3 09:27:40 INFO - wsgiref == 0.1.2 09:27:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:27:40 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')]} 09:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:40 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')]} 09:27:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:40 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 0x27c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b39480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b36820>, '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 0x2b37520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b379b0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595', '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 09:27:40 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 09:27:40 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 09:27:40 INFO - Using env: {'DISPLAY': ':0', 09:27:40 INFO - 'HOME': '/home/cltbld', 09:27:40 INFO - 'LANG': 'en_US.UTF-8', 09:27:40 INFO - 'LANGUAGE': 'en_US:en', 09:27:40 INFO - 'LOGNAME': 'cltbld', 09:27:40 INFO - 'MAIL': '/var/mail/cltbld', 09:27:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:40 INFO - 'MOZ_NO_REMOTE': '1', 09:27:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:27:40 INFO - 'NO_EM_RESTART': '1', 09:27:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:27:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:40 INFO - 'PWD': '/builds/slave/test', 09:27:40 INFO - 'SHELL': '/bin/bash', 09:27:40 INFO - 'SHLVL': '1', 09:27:40 INFO - 'TERM': 'linux', 09:27:40 INFO - 'TMOUT': '86400', 09:27:40 INFO - 'USER': 'cltbld', 09:27:40 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595', 09:27:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:40 INFO - '_': '/tools/buildbot/bin/python'} 09:27:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:40 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)) 09:27:40 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)) 09:27:40 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)) 09:27:40 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)) 09:27:40 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)) 09:27:40 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)) 09:27:40 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)) 09:27:40 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)) 09:27:40 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)) 09:27:40 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)) 09:27:40 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)) 09:27:40 INFO - Cleaning up... 09:27:40 INFO - Return code: 0 09:27:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:27:40 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')]} 09:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:40 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')]} 09:27:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b39480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b36820>, '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 0x2b37520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b379b0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595', '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 09:27: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', 'jsonschema'] in /builds/slave/test/build 09:27: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 jsonschema 09:27:40 INFO - Using env: {'DISPLAY': ':0', 09:27:40 INFO - 'HOME': '/home/cltbld', 09:27:40 INFO - 'LANG': 'en_US.UTF-8', 09:27:40 INFO - 'LANGUAGE': 'en_US:en', 09:27:40 INFO - 'LOGNAME': 'cltbld', 09:27:40 INFO - 'MAIL': '/var/mail/cltbld', 09:27:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:40 INFO - 'MOZ_NO_REMOTE': '1', 09:27:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:27:40 INFO - 'NO_EM_RESTART': '1', 09:27:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:27:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:40 INFO - 'PWD': '/builds/slave/test', 09:27:40 INFO - 'SHELL': '/bin/bash', 09:27:40 INFO - 'SHLVL': '1', 09:27:40 INFO - 'TERM': 'linux', 09:27:40 INFO - 'TMOUT': '86400', 09:27:40 INFO - 'USER': 'cltbld', 09:27:40 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595', 09:27:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:40 INFO - '_': '/tools/buildbot/bin/python'} 09:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:27:41 INFO - Cleaning up... 09:27:41 INFO - Return code: 0 09:27:41 INFO - Running post-action listener: _resource_record_post_action 09:27:41 INFO - Running post-action listener: _start_resource_monitoring 09:27:41 INFO - Starting resource monitoring. 09:27:41 INFO - [mozharness: 2016-12-31 17:27:41.176840Z] Finished create-virtualenv step (success) 09:27:41 INFO - [mozharness: 2016-12-31 17:27:41.177342Z] Running install step. 09:27:41 INFO - Running pre-action listener: _resource_record_pre_action 09:27:41 INFO - Running main action method: install 09:27:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:27:41 INFO - Reading from file tmpfile_stdout 09:27:41 INFO - Detecting whether we're running mozinstall >=1.0... 09:27:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:27:41 INFO - Reading from file tmpfile_stdout 09:27:41 INFO - Output received: 09:27:41 INFO - Usage: mozinstall [options] installer 09:27:41 INFO - Options: 09:27:41 INFO - -h, --help show this help message and exit 09:27:41 INFO - -d DEST, --destination=DEST 09:27:41 INFO - Directory to install application into. [default: 09:27:41 INFO - "/builds/slave/test"] 09:27:41 INFO - --app=APP Application being installed. [default: firefox] 09:27:41 INFO - mkdir: /builds/slave/test/build/application 09:27:41 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'] 09:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:27:57 INFO - Reading from file tmpfile_stdout 09:27:57 INFO - Output received: 09:27:57 INFO - /builds/slave/test/build/application/firefox/firefox 09:27:57 INFO - Running post-action listener: _resource_record_post_action 09:27:57 INFO - [mozharness: 2016-12-31 17:27:57.567907Z] Finished install step (success) 09:27:57 INFO - [mozharness: 2016-12-31 17:27:57.568184Z] Running run-tests step. 09:27:57 INFO - Running pre-action listener: _resource_record_pre_action 09:27:57 INFO - Running main action method: run_tests 09:27:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:27:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:27:57 INFO - Python 2.7.3 09:27:57 INFO - Return code: 0 09:27:57 INFO - grabbing minidump binary from tooltool 09:27: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')]} 09:27:57 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 0x2b36820>, '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 0x2b37520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b379b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:27:57 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 09:27:57 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 09:27:57 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 09:27:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:27:57 INFO - Return code: 0 09:27:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:27:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:27:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:27:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:27:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:27:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mz5ZWQo9RC6WqJSlpeMcXA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:27:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Mz5ZWQo9RC6WqJSlpeMcXA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:27:57 INFO - Using env: {'DISPLAY': ':0', 09:27:57 INFO - 'HOME': '/home/cltbld', 09:27:57 INFO - 'LANG': 'en_US.UTF-8', 09:27:57 INFO - 'LANGUAGE': 'en_US:en', 09:27:57 INFO - 'LOGNAME': 'cltbld', 09:27:57 INFO - 'MAIL': '/var/mail/cltbld', 09:27:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:27:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:27:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:57 INFO - 'MOZ_NO_REMOTE': '1', 09:27:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:27:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:27:57 INFO - 'NO_EM_RESTART': '1', 09:27:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:27:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:57 INFO - 'PWD': '/builds/slave/test', 09:27:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:27:57 INFO - 'SHELL': '/bin/bash', 09:27:57 INFO - 'SHLVL': '1', 09:27:57 INFO - 'TERM': 'linux', 09:27:57 INFO - 'TMOUT': '86400', 09:27:57 INFO - 'USER': 'cltbld', 09:27:57 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595', 09:27:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:57 INFO - '_': '/tools/buildbot/bin/python'} 09:27:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mz5ZWQo9RC6WqJSlpeMcXA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:27:57 INFO - mozversion application_buildid: 20161231165557 09:27:57 INFO - mozversion application_changeset: 6d7fe8c8fb5867512d3332b8aa8109a0d8a3d841 09:27:57 INFO - mozversion application_display_name: Nightly 09:27:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:27:57 INFO - mozversion application_name: Firefox 09:27:57 INFO - mozversion application_remotingname: firefox 09:27:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:27:57 INFO - mozversion application_vendor: Mozilla 09:27:57 INFO - mozversion application_version: 53.0a1 09:27:57 INFO - mozversion platform_buildid: 20161231165557 09:27:57 INFO - mozversion platform_changeset: 6d7fe8c8fb5867512d3332b8aa8109a0d8a3d841 09:27:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:27:57 INFO - mozversion platform_version: 53.0a1 09:27:57 INFO - using testdate: 1483205277 09:27:57 INFO - actual date: 1483205277 09:27:57 INFO - starting webserver on 'localhost:58655' 09:27:57 INFO - SUITE-START | Running 2 tests 09:27:57 INFO - TEST-START | dromaeo_css 09:27:57 INFO - operating with platform_type : linux_ 09:27:57 INFO - Initialising browser for dromaeo_css test... 09:27:57 INFO - TEST-INFO | started process 14513 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRXHicy/profile http://localhost:58655/getInfo.html) 09:27:58 INFO - PROCESS | 14513 | 1483205278356 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 09:28:02 INFO - PROCESS | 14513 | __metrics Screen width/height:1600/1200 09:28:02 INFO - PROCESS | 14513 | colorDepth:24 09:28:02 INFO - PROCESS | 14513 | Browser inner width/height: 1024/697 09:28:02 INFO - PROCESS | 14513 | __metrics 09:28:02 ERROR - PROCESS | 14513 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 09:28:04 INFO - TEST-INFO | 14513: exit 0 09:28:04 INFO - Browser initialized. 09:28:04 INFO - Running cycle 1/1 for dromaeo_css test... 09:28:04 INFO - TEST-INFO | started process 14632 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRXHicy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:28:16 INFO - PROCESS | 14632 | RSS: Main: 157888512 09:28:16 INFO - PROCESS | 14632 | 09:29:05 INFO - PROCESS | 14632 | 1483205345683 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:31:19 INFO - PROCESS | 14632 | Cycle 1(1): loaded http://localhost:58655/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58655/tests/dromaeo/cssquery-ext.html) 09:31:21 INFO - PROCESS | 14632 | RSS: Main: 166969344 09:31:21 INFO - PROCESS | 14632 | 09:33:04 INFO - PROCESS | 14632 | ************************* 09:33:04 INFO - PROCESS | 14632 | A coding exception was thrown and uncaught in a Task. 09:33:04 INFO - PROCESS | 14632 | 09:33:04 INFO - PROCESS | 14632 | Full message: ReferenceError: fetch is not defined 09:33:04 INFO - PROCESS | 14632 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 09:33:04 INFO - PROCESS | 14632 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 09:33:04 INFO - PROCESS | 14632 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 09:33:04 INFO - PROCESS | 14632 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 09:33:04 INFO - PROCESS | 14632 | TaskImpl@resource://gre/modules/Task.jsm:277:3 09:33:04 INFO - PROCESS | 14632 | asyncFunction@resource://gre/modules/Task.jsm:252:14 09:33:04 INFO - PROCESS | 14632 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 09:33:04 INFO - PROCESS | 14632 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 09:33:04 INFO - PROCESS | 14632 | TaskImpl@resource://gre/modules/Task.jsm:277:3 09:33:04 INFO - PROCESS | 14632 | asyncFunction@resource://gre/modules/Task.jsm:252:14 09:33:04 INFO - PROCESS | 14632 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 09:33:04 INFO - PROCESS | 14632 | 09:33:04 INFO - PROCESS | 14632 | ************************* 09:34:23 INFO - PROCESS | 14632 | Cycle 1(1): loaded http://localhost:58655/tests/dromaeo/cssquery-ext.html (next: http://localhost:58655/tests/dromaeo/cssquery-jquery.html) 09:34:24 INFO - PROCESS | 14632 | RSS: Main: 162410496 09:34:24 INFO - PROCESS | 14632 | 09:37:26 INFO - PROCESS | 14632 | Cycle 1(1): loaded http://localhost:58655/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58655/tests/dromaeo/cssquery-mootools.html) 09:37:26 INFO - PROCESS | 14632 | RSS: Main: 169078784 09:37:26 INFO - PROCESS | 14632 | 09:40:29 INFO - PROCESS | 14632 | Cycle 1(1): loaded http://localhost:58655/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58655/tests/dromaeo/cssquery-prototype.html) 09:40:29 INFO - PROCESS | 14632 | RSS: Main: 161775616 09:40:29 INFO - PROCESS | 14632 | 09:43:32 INFO - PROCESS | 14632 | Cycle 1(1): loaded http://localhost:58655/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58655/tests/dromaeo/cssquery-yui.html) 09:43:33 INFO - PROCESS | 14632 | RSS: Main: 165695488 09:43:33 INFO - PROCESS | 14632 | 09:46:36 INFO - PROCESS | 14632 | Cycle 1(1): loaded http://localhost:58655/tests/dromaeo/cssquery-yui.html (next: http://localhost:58655/tests/dromaeo/cssquery-dojo.html) 09:46:36 INFO - PROCESS | 14632 | RSS: Main: 167530496 09:46:36 INFO - PROCESS | 14632 | 09:46:36 INFO - PROCESS | 14632 | __start_tp_report 09:46:36 INFO - PROCESS | 14632 | _x_x_mozilla_page_load 09:46:36 INFO - PROCESS | 14632 | _x_x_mozilla_page_load_details 09:46:36 INFO - PROCESS | 14632 | |i|pagename|runs| 09:46:36 INFO - PROCESS | 14632 | |0;dojo.html;2591.585346344585;2599.1552745357762;2603.492318997794;2617.5811870100774;2627.868606569671;4750.928736068958;4765.237561990087;4769.403824521934;4811.566958973692;4830.97584512077;4788.90422191556;4808.254720518316;4875.171220892448;4877.097736918672;4941.357623508939;4415.381846541487;4454.910901781978;4480.731156130626;4544.272916333387;4583.175028494887;4144.689148313873;4559.430071241095;4584.587387135157;4594.379758732578;4603.49361570227;4373.978130109329;4441.533638967927;4445.488768791565;4494.303382975644;4561.566651168134;4360.236958532244;4392.78036098197;4396.296592545177;4400.889977750582;4461.776911154429;4359.280718681413;4368.453943257093;4374.19077470669;4381.561843815625;4385.232584297735;4737.2420412734145;4767.42790865095;4779.80880764769;4798.736069516175;4820.108279968217;4893.241547560134;4949.232868905326;4991.301217829507;5012.598992080625;5027.84916452507;5009.44896061433;5064.189729643276;5084.288199652015;5086.287919691246;5115.335006449138;4670.999999999966;4685.109829132454;4709.740964246965;4746.881327966759;4781.282807578891;5156.74216289184;5196.298499702568;5210.921836172461;5218.373795144607;5228.37259528859;5028.84913452597;5044.268581055726;5050.217216331474;5087.135187018216;5093.8726531837;5047.545720885138;5106.565941894981;5134.974325128351;5161.251618515369;5205.193195054697;5034.597232221414;5098.59211263098;5144.768485418165;5157.6647517911215;5235.05768961583;5180.378354597397;5181.1969144782615;5192.402873669501;5195.610329225323;5209;4379.802908869108;4427.180971520214;4429.955700443019;4441.644668426583;4456.598906098467;3714.0900479382185;3746.1758413149064;3781.2248489059675;3797.1836055248255;3832.789196594214;4451.554844515523;4477.059817438374;4481.977590112028;4490.753008584559;4524.932126018112;5151.459096794858;5203.583713302926;5247.895042099137;5254.316938798008;5272.630915835932;4318.352247162888;4340.8697739067875;4353.0423306872435;4400.471943366816;4475.955240447619;4585.908281834345;4590.586847183769;4591.471980722193;4601.28680054592;4606.424196975378;4756.8097276108565;4784.7607619619575;4785.210440277385;4785.808567657255;4813.03739252144;5142.280080788767;5148.897022059613;5150.201718733602;5153.0466863630345;5153.252778347193;4758.2386818108935;4765.5949244314625;4774.665773395829;4807.543283388212;4854.660173787801;5003.649744517848;5034.496550344937;5034.874128146826;5041.697498150123;5083.288339632529;5082.440931497458;5085;5085.415177254663;5086.21163719624;5123.718195499283;5001.974990125026;5003.224500202329;5054.924176137434;5056.317397151338;5128.153854613947;5067.13858644024;5073.467285934924;5081.466446023114;5085.7711402986215;5118.564921981673;4839.879003024953;4884;4887.780049897834;5004.599632029356;5026.623003274696;4997.675151115166;5045.192769156917;5076.593872490266;5091.567216786615;5135.897282054263;4969.801207951641;4977.800887964441;4984.352034235526;4992.775325110451;5029.723365214948 09:46:36 INFO - PROCESS | 14632 | |1;ext.html;507.6421123108209;513.9254808052831;531.2774626507949;533.6691251424118;557.2866730584848;37543;38895.611043889585;38952.41571376432;39322.41016384756;41791.58208417915;39258.21483570334;39559;39604.00989975245;39676;39744.403833942444;7674.616269186547;7828.843423131534;7831.334336581397;7860.882086768703;9339.626414943394;9312.487813170274;9465.763355916122;9544.90455095447;9567.138957493824;9570.521473926276;9522.333436659437;9548.140667339938;9670.806583868318;9672.081152290557;9691.176250018756;9504.239660827152;9575.95212023939;9587.760305992337;9606;9608.567614457366;9538.618455261781;9559.713208603753;9591.760205994837;9597.040295970417;9624.855627165598;33177.17057073592;33466.6653333466;33503.6649633503;33530.664693353;33536.32927341464;3424.298018906118;3556.448750443685;3565.8038807865555;3583.605803361628;3587.1390866192187;25281;25458.236252912444;25712.22863314085;25734.613980790302;25934.35164120893;3223.613166420021;3228.8376184573535;3280.934381312384;3338.4491558892755;3413.8805141819917;228802;229289;230280;230460;231190;43647;43673.563264367585;43856.3421548677;43936;43985.12029759451;47139.05721885543;47169.29246061312;47234;47281.76359118251;47373;10468.790624187473;10635.574577016987;10646;10678.946605266923;10700.30448020876;7750.108737495148;7951.204879512118;7967.28294453502;8059.274665280153;8166.550839703873;15109.168995705342;15121.546353609408;15244.161571113473;15319.846801532065;15543.533693989199;6201.441870231611;6435.356464353527;6438.937575300117;6497.220333560003;6540.9345906541275;788.2157253532657;789.1753117991713;801.0947629178991;812.3825892321878;822.7696245051395;26211.213663590122;27572.034978775646;27597;27740.861295693394;28047;927.7263207353847;928.9210417114485;934.6027938126269;935.6163972771267;1069.342354452022;13294.601161965156;14663.633409164642;14686.118832870063;14851;14878.92560537212;338972;340827;341030;341729;343469;47231.291530627066;47934.28098578524;47948.520514795106;47976.52023479791;48162.51837481651;1127.740619657467;1160.4429873660522;1164.6622479480855;1173.8826117388364;1190.220405634311;24567.631485527374;25499;26542.60186097249;26732;26868.462630746886;39473.80263098666;39699.40450893181;39736;39820;39828.40257396083;289618;291362;293004;293300;293789;21969.890150549145;22966.770332296463;23013.769862301164;24025.159119430737;24225.39436514101;33666.66333336733;33861.49207761935;34299.14252143716;34354.484682730275;34390.484142737376;30756;30980.22549436282;31024.379512410076;31591.368172636878;31887.521687175176;29431.705682943753;33187.17032074121;33897.322053559285;34506.309873802886;34934;30231.69768302377;30946.690533095283;31115.22211944629;31284.374312513166;31325.216869577533;27574.862125689244;28382.290442739097;29010.9846155392;29115.85442072776;29203.41593168082;22795;22857.88571057134;22979.6553051701;23133.884330578912;23191.768082318962 09:46:36 INFO - PROCESS | 14632 | |2;jquery.html;362.6174386022745;367.9227362253927;369.39419352262297;382.4607303701781;385.2622228432552;15415.691686166285;16484.752728709063;17044.23300951457;17150.313987440517;17165.9700417975;15904.125273109974;15943.681126377465;15947;16045.197740112977;16046.59883502913;4826.662133650646;5092.898142037157;5097.209932460474;5105.106606343894;5106.055379754739;3838.9424158637503;4055.3105971984687;5024.773885175176;5719.714014299289;5989.9101513477335;6021.066734656135;6039.607425517327;6067.666278354689;6069.544784141207;6077.179580756586;5798.62308949919;5908.350081491032;5909.2022576951995;5910.527157827363;5917.940820591825;5033.219850923113;5129.666571672829;5151.330327057496;5195.350581177353;5199.766010529535;19693.606127877363;19788.109535070955;19993.700094498596;19999.300024499218;20044.298449554197;2492.8255022148455;2532.9113481028076;2537.8774746038966;2592.4555843272933;2596.9220923372327;12077.094217933602;12582.496700131984;12763.936180319131;12813.551525696555;13383.929285657125;1728.6542691461632;1749.6850566897954;1763.215369160724;1767.2135899524717;1767.8674099442464;64747.67626161839;64848.351516484705;66053;66098.66950665264;66957.66521167364;9643;9796.804063918682;9849.655262065793;9951.154151897024;9978.101970822661;13387.531436399679;13465.124766890316;13476.460941562424;13482.39329230187;13483.932580337036;6155.199824022849;6325.493960483151;6437.130987316652;6508.414242718178;6510.641914694737;5712.086066229466;5791.189233507313;5939.554533410012;5941.524678025748;5954.136650185699;4163.208990291835;4177.56135605757;4245.257080010986;4245.490541135084;4267.978660106742;1523.3297349166332;1605.566497045791;1606.6866960942505;1777.7378061576426;1849.232568484091;928.9163975242261;937.4562753602894;960.0735290444754;960.6349587156835;982.9361091529171;14826.925865370604;15133.54599362021;15368.308426120851;15458.922705386625;15828.525144245461;931.3852857114272;935.9391639543408;936.840737074699;936.9812603748023;943.6980166346704;8584.184502472255;8733.170348816851;8877.245434138042;9100.135487128713;9271.728426535406;312119;313401;314845;314912;324319;48787.756061219465;60024.39975600188;65841.67079164574;67253.32746672569;69079;894.2264940826268;921.9308551858637;933.9112784285481;939.957701903416;943.4480828715141;13673.316334183051;13921.79117313221;13952.441902323793;14129.222892740998;14643.194624295766;31252;32548.186295342806;33044.66955330416;33157.66842331546;33345.83327083349;44493.55506444894;45263.321050183615;45381.09237815159;45428.77285613551;46487.30269045899;6666.799996000128;6707.1616047994;6810.250872404131;6887.7244910203035;6974.442044636316;6997.930020699931;9209.940856801286;10674.46627668629;10980.396078215776;11020.724481887697;7554.622268886424;7830.786228134648;9940.801183976424;10090.899091009289;10279.687070409098;9931.404115753077;10229.181665466596;10238.744031399274;10404.791904162026;10443.321184123311;10227.642032528825;10456.215783816093;10462.895371046496;10647.361158330525;10689.679309620413;6655;6799.456043516606;6856.382925536725;7151.4278857690215;7701.961490192513;7922.643481043252;9922.454265015205;9943.453110078726;10332.328398654063;10475.057244848 09:46:36 INFO - PROCESS | 14632 | |3;mootools.html;1312.4618906248438;1314.6910476038129;1318.2617734068929;1318.7494376068546;1340.2293681133347;6677.465802735782;6916.515843890929;6960.40836528895;7404.148522919859;7406.185319614838;7006.929930700691;7223.349898509133;7230.060092188009;7373.594452305121;7419.035525381706;2136.423165745252;2151.4943988162768;2174.3259589527297;2177.205320058183;2179.095675294751;2085.14509051289;2101.3275751759443;2123.787621237879;2139.3474990128007;2178.901949412272;2167.100653228908;2195.352371050536;2196.615592271346;2197.571473562656;2200.108955872874;2082.1671331467533;2082.302428686392;2083.8853863037525;2093.2568938026934;2099.32821497121;2013.7281467001915;2077.2833372486466;2169.6962425260476;2208.293346129239;2213.557288542298;7407.814804629874;7461.813454663623;7535.434842386788;7546.09446866374;7561.848763024709;4409.647228221735;4552.931706024412;4564.452265728134;4569.314602809572;4578.748168850712;2693.299742067057;2935.8678859451375;2984.4478771427357;3002.264445210937;3004.4742170120144;1120.7142178744368;1168.199783148546;1185.952561897523;1191.9165658403915;1205.2226314027491;9753.609855605768;9860.112589866874;9897.703068907944;9906.653267135616;9922.206223502102;3714.4799728038097;3929.155231625214;3958.584348643351;3964.4053391990856;3986.661133803659;7854.8821767673535;7860.449768516263;7863.803404914923;7869.331106855867;7888.290053895063;4497.955020449819;4507.774611269423;4511.481179664315;4514.119746649372;4520.073384956077;4032.334664780278;4033.4151548025957;4044.939325910114;4110.547839737626;4139.172165566899;3236.821974791409;3244.416005119054;3280.2619410632415;3329.4339962206;3332.3501917125927;999.4303247149055;1002.223276960347;1011.9038691324313;1012.3925644613173;1039.8076355874186;762.2834535536578;784.4900814470526;787.8463699578642;793.2781169136058;797.5812698333422;4670.276107203389;4702.36518070063;4848.0788650156355;4903.877403064952;4958;850.2730165708231;888.2405543260548;889.9332550058772;895.4627223665749;899.321012635456;2990.5813186153955;3000.639923209229;3041.81749095055;3174.968250317467;3332.2002719347183;8232.62953167109;8234.711785087613;8615;8630.482171069756;8758.299336053227;8711.825763484694;8768.298536117096;8776.824463510695;8790.857188565573;8801.207891289814;6708.161479815023;6870.484713646497;6874.415674667609;6891.345322194384;6893.965530172217;4683.78922948475;4793.18515852299;4954.5540901319055;4980.676256043345;5007.749612519432;7956.562389068657;7973.601319934096;8119.431639785158;8178;8183.386246031452;8141.51150930946;8204.097549269694;8209.71266005687;8352.123027082069;8358.205970432798;6303.401176888188;6512.283648798723;6520.543561950808;6524.869502609827;6531.608103513804;6805.421539169226;6834;6849.5205335628025;6894.13823272091;6897.241303456716;6149.292831324455;6213.03697926822;6249.8750024998335;6272.4982001440685;6298.779542715983;6024.668643224665;6076.088586712029;6101.38986101404;6112.633242005494;6177.795329910624;5535.280413546213;5559.694216818114;5610.551155907599;5619.100943849128;5619.606627536196;4199.265128602544;4215.515215750228;4224.239636865394;4246.256905041543;4329.350597410414;4222.59885310895;4247.808848601759;4262;4279.97860010698;4329.783510824509 09:46:36 INFO - PROCESS | 14632 | |4;prototype.html;349.2351749668226;357.46558894452795;358.587624232133;358.8995081377212;363.96542328478785;4975.6019518438525;5010.323606313146;5023.372078490189;5040.420351659564;5040.722760248185;4947.406311242656;4955.529224723655;4961.553460188582;4962.851114466563;4969.155243608586;3779.924401511975;3844.3478695239496;3878.534575850902;3906.6560063961538;3954.6638535724496;3912.2957867583823;3921.8823435296986;3925.9803700981456;3926;3932.469116669256;3906.1485115865294;3922.4900762900784;3923.136909879822;3925.3523168677134;3930.85768256301;3813.6186381361917;3885.7668539887695;3911.902202444933;3950.6246906543834;3951.3601855230045;3521.383757842393;3522.4364101743854;3529.2412131391875;3531.876384326536;3541.821779605524;4727.881802954919;4811.158047341736;4814.855554333376;4825.227963525819;4880.877978050542;4399.039639374798;4449.599536041739;4497.7526236057;4500.077484115748;4515.7516336601475;5026.84919452417;5099.6685215460875;5113.667611605234;5141.717205553693;5143.254228136937;3811.065479580735;3816.866409675648;3821.9235615287816;3850.268448994682;3856.402257650069;5425.810096646598;5445.237666726622;5450.31871016123;5462.552423607747;5485.6982865942355;3853.4797802296894;3927.548331941863;3946.7631942083567;3952.3676211806546;3987.1626958338493;3987.444896490371;4004.939925901114;4019.698522610757;4025.1345960618023;4043.3934909763184;4439.334099884978;4466.9106617867465;4467.530909254481;4490.348899409632;4505.61702255312;4932.679375840559;5118.181091025418;5165.251038599382;5194.3766747990485;5195.532402083831;1357.2331632627731;1366.050594836599;1368.1449094316054;1370.4381203706432;1377.1736957825224;931.7996630724426;955.7515046088067;975.5024937282037;983.3362480325751;989.3322007644811;4343.587359200871;4410.434295825;4493.168763778712;4561.657875659273;4569.451665800058;5255.817441075727;5285.814996475105;5298.337707786527;5313.628046036741;5314.7608357624;4530.954690453119;4537.931931021038;4551.681382303207;4554.294084416854;4557.339185818038;2575.6522869412765;2705.4724328755706;2730.440259746787;2738.3017330580974;2739.4384151248946;4806.831760888422;4812.205986012339;4814.831480898222;4835.661503694778;4849.787553111722;5029;5232.816851410183;5257.263983042377;5276.287701160371;5279.868003299872;4779.498152693986;4786.7367294799815;4800.463851567535;4801.279808028824;4846.321514987904;5121.2870668764845;5137.409197942135;5148.58811295088;5166.870828229325;5187.014467251211;4974.975125124496;5024.176790281224;5092.243176104238;5109.9744501277255;5118.590512758896;4722.48052714208;4760.595349395202;4793.034855709143;4795.616350692006;4804;3811.8856434307013;3814.275287695329;3824.158685089276;3841.2125514270065;3881.223755249018;4924.901501970012;5168.767405466839;5170.250313704567;5183.974080129726;5194.4805519447755;4890;4942.481039490802;4987.625928055338;4992.403949945935;4993.925091123563;4927.482614325444;4986.6010719143105;4989.054268835084;4996.3504744383;5002.324686167466;4723.598494128038;4942.061008408391;4942.20924652054;4944.752762361795;4984.302197692398;4979.975100124621;5010.599152067899;5019.3976722793495;5189.662671926313;5206.817761378334;5076.568491678248;5085.211792172071;5089.287499749964;5089.592832573459;5116.462771408948 09:46:36 INFO - PROCESS | 14632 | |5;yui.html;618.2550027217204;625.284049763021;708.7554793596207;738.3650060947585;769.9884501732475;13023.479060837566;14356.641083972905;14377.712445751078;14392.568222953301;14401;13532.120412173203;13579;13579.932100339509;13589.864101358984;13644.38600262988;656.2420404432887;679.4428568573771;775.7401270574364;795.3200013988059;810.7081450677751;802.5906787538339;813.4549851599443;816.4570560577239;817.0562999735286;817.480899628734;862.4221771413169;865.4634126841368;865.8354912566624;867.4361664917823;868.8566386546212;863.7149740585654;864.3992425264476;864.7838040489878;864.8702694595861;866.4714524140269;629.9842503937439;631.5137344244906;632.5319263744796;633.5660072850112;633.9270983836872;13648.931755341258;13756.724865502734;14075.718485630332;14115.717685646332;14122.082064665763;13537.1200871943;14240.145591264558;14317.808735499862;14328.856711432856;14491.565253042425;10589.84115238272;10624.521896514676;10730.678079657622;10777.407242601654;10788.622398216103;3253.9749978756618;3265.6081270247487;3274.5251938468787;3362.2939182771647;3420.811855347955;66509;66672.66609672073;68248.6587567064;68467.65766171187;69314.65342673304;10650;10670.772861120915;10682.359058456517;10807.297525660806;10850.131989440826;20621;20721.68917466239;20735.27426540064;20780.168793248402;20925.162993480393;6327;6442.130312407859;6528.902066469007;6630.635315057718;6682.532222744361;3568.232829941523;3651.6713495785507;3661.0847288177956;3664.688501477351;3712.832922518493;2804.2568719289407;2848.0886116442953;2864.5273529867754;2881.812682175652;2884.855757212173;466.51482458243726;472.9739864307496;474.0495306909624;475.4366076199714;478.8412042856296;541.5829811045473;541.7995341723508;543.4646872830259;545.3918880448272;555.8804856955774;6939.965300173467;6968.407685346802;7125.501214914906;7537.8115547111765;7563.146452007666;546.3280165396584;552.8230966090812;559.9188117722907;582.6271186440681;583.4602992232168;3598.676119149237;3824.598417166213;3865.2849222893856;3867.41988701697;3983.3029219886403;63415.36584634187;64518;64753;65059.34940650628;67905.3209467899;55885.161722574194;56122.71938640281;57755;59409;59564.70217648884;49163.75418122886;50050.24924626134;50149;52263.47736522662;53738;7147;7403.370713489198;7503.2496750324535;7616.771496855104;8466.365022623204;33383.666163339025;34311.31377372488;34463.310733785685;34590.82704586461;35049.64950350464;44785.776071119435;44913;44949.77525112354;45284.32073518834;45291.54708453005;10840.512176952214;11156.330620162817;11181.72045698864;11475.942620286845;11566.132540059361;12412.441440135035;12822.679433013876;13121.934390327988;13397.626483447844;13559.389827457986;11641.59254426125;11899.345535995604;12138;12578;12758.362081895682;11608.361540115375;11840.881591183977;11990.100742444525;12315.322657253937;12665.113442059335;12308.876911230773;12623.305718185587;12628.558000469939;13263.403146858222;13360.799588005993;9554.426734395958;9598.232141428529;9844.852327214954;9911;10461.320014199053;9140.405873618194;9827.901720982698;10143.391396516232;10703.464826758787;10734.302270352402 09:46:36 INFO - PROCESS | 14632 | __end_tp_report 09:46:36 INFO - PROCESS | 14632 | __start_cc_report 09:46:36 INFO - PROCESS | 14632 | _x_x_mozilla_cycle_collect,351 09:46:36 INFO - PROCESS | 14632 | __end_cc_report 09:46:36 INFO - PROCESS | 14632 | __startTimestamp1483206396834__endTimestamp 09:46:36 INFO - PROCESS | 14632 | 09:46:36 INFO - PROCESS | 14632 | ------- Summary: start ------- 09:46:36 INFO - PROCESS | 14632 | Number of tests: 6 09:46:36 INFO - PROCESS | 14632 | 09:46:36 INFO - PROCESS | 14632 | [#0] dojo.html Cycles:165 Average:4746.00 Median:4854.66 stddev:505.21 (10.4%) stddev-sans-first:477.65 09:46:36 INFO - PROCESS | 14632 | Values: 2591.6 2599.2 2603.5 2617.6 2627.9 4750.9 4765.2 4769.4 4811.6 4831.0 4788.9 4808.3 4875.2 4877.1 4941.4 4415.4 4454.9 4480.7 4544.3 4583.2 4144.7 4559.4 4584.6 4594.4 4603.5 4374.0 4441.5 4445.5 4494.3 4561.6 4360.2 4392.8 4396.3 4400.9 4461.8 4359.3 4368.5 4374.2 4381.6 4385.2 4737.2 4767.4 4779.8 4798.7 4820.1 4893.2 4949.2 4991.3 5012.6 5027.8 5009.4 5064.2 5084.3 5086.3 5115.3 4671.0 4685.1 4709.7 4746.9 4781.3 5156.7 5196.3 5210.9 5218.4 5228.4 5028.8 5044.3 5050.2 5087.1 5093.9 5047.5 5106.6 5135.0 5161.3 5205.2 5034.6 5098.6 5144.8 5157.7 5235.1 5180.4 5181.2 5192.4 5195.6 5209.0 4379.8 4427.2 4430.0 4441.6 4456.6 3714.1 3746.2 3781.2 3797.2 3832.8 4451.6 4477.1 4482.0 4490.8 4524.9 5151.5 5203.6 5247.9 5254.3 5272.6 4318.4 4340.9 4353.0 4400.5 4476.0 4585.9 4590.6 4591.5 4601.3 4606.4 4756.8 4784.8 4785.2 4785.8 4813.0 5142.3 5148.9 5150.2 5153.0 5153.3 4758.2 4765.6 4774.7 4807.5 4854.7 5003.6 5034.5 5034.9 5041.7 5083.3 5082.4 5085.0 5085.4 5086.2 5123.7 5002.0 5003.2 5054.9 5056.3 5128.2 5067.1 5073.5 5081.5 5085.8 5118.6 4839.9 4884.0 4887.8 5004.6 5026.6 4997.7 5045.2 5076.6 5091.6 5135.9 4969.8 4977.8 4984.4 4992.8 5029.7 09:46:36 INFO - PROCESS | 14632 | 09:46:36 INFO - PROCESS | 14632 | [#1] ext.html Cycles:180 Average:43036.80 Median:18861.72 stddev:76515.28 (405.7%) stddev-sans-first:76663.30 09:46:36 INFO - PROCESS | 14632 | Values: 507.6 513.9 531.3 533.7 557.3 37543.0 38895.6 38952.4 39322.4 41791.6 39258.2 39559.0 39604.0 39676.0 39744.4 7674.6 7828.8 7831.3 7860.9 9339.6 9312.5 9465.8 9544.9 9567.1 9570.5 9522.3 9548.1 9670.8 9672.1 9691.2 9504.2 9576.0 9587.8 9606.0 9608.6 9538.6 9559.7 9591.8 9597.0 9624.9 33177.2 33466.7 33503.7 33530.7 33536.3 3424.3 3556.4 3565.8 3583.6 3587.1 25281.0 25458.2 25712.2 25734.6 25934.4 3223.6 3228.8 3280.9 3338.4 3413.9 228802.0 229289.0 230280.0 230460.0 231190.0 43647.0 43673.6 43856.3 43936.0 43985.1 47139.1 47169.3 47234.0 47281.8 47373.0 10468.8 10635.6 10646.0 10678.9 10700.3 7750.1 7951.2 7967.3 8059.3 8166.6 15109.2 15121.5 15244.2 15319.8 15543.5 6201.4 6435.4 6438.9 6497.2 6540.9 788.2 789.2 801.1 812.4 822.8 26211.2 27572.0 27597.0 27740.9 28047.0 927.7 928.9 934.6 935.6 1069.3 13294.6 14663.6 14686.1 14851.0 14878.9 338972.0 340827.0 341030.0 341729.0 343469.0 47231.3 47934.3 47948.5 47976.5 48162.5 1127.7 1160.4 1164.7 1173.9 1190.2 24567.6 25499.0 26542.6 26732.0 26868.5 39473.8 39699.4 39736.0 39820.0 39828.4 289618.0 291362.0 293004.0 293300.0 293789.0 21969.9 22966.8 23013.8 24025.2 24225.4 33666.7 33861.5 34299.1 34354.5 34390.5 30756.0 30980.2 31024.4 31591.4 31887.5 29431.7 33187.2 33897.3 34506.3 34934.0 30231.7 30946.7 31115.2 31284.4 31325.2 27574.9 28382.3 29011.0 29115.9 29203.4 22795.0 22857.9 22979.7 23133.9 23191.8 09:46:36 INFO - PROCESS | 14632 | 09:46:36 INFO - PROCESS | 14632 | [#2] jquery.html Cycles:180 Average:21242.34 Median:45404.93 stddev:52235.62 (115.0%) stddev-sans-first:52358.62 09:46:36 INFO - PROCESS | 14632 | Values: 362.6 367.9 369.4 382.5 385.3 15415.7 16484.8 17044.2 17150.3 17166.0 15904.1 15943.7 15947.0 16045.2 16046.6 4826.7 5092.9 5097.2 5105.1 5106.1 3838.9 4055.3 5024.8 5719.7 5989.9 6021.1 6039.6 6067.7 6069.5 6077.2 5798.6 5908.4 5909.2 5910.5 5917.9 5033.2 5129.7 5151.3 5195.4 5199.8 19693.6 19788.1 19993.7 19999.3 20044.3 2492.8 2532.9 2537.9 2592.5 2596.9 12077.1 12582.5 12763.9 12813.6 13383.9 1728.7 1749.7 1763.2 1767.2 1767.9 64747.7 64848.4 66053.0 66098.7 66957.7 9643.0 9796.8 9849.7 9951.2 9978.1 13387.5 13465.1 13476.5 13482.4 13483.9 6155.2 6325.5 6437.1 6508.4 6510.6 5712.1 5791.2 5939.6 5941.5 5954.1 4163.2 4177.6 4245.3 4245.5 4268.0 1523.3 1605.6 1606.7 1777.7 1849.2 928.9 937.5 960.1 960.6 982.9 14826.9 15133.5 15368.3 15458.9 15828.5 931.4 935.9 936.8 937.0 943.7 8584.2 8733.2 8877.2 9100.1 9271.7 312119.0 313401.0 314845.0 314912.0 324319.0 48787.8 60024.4 65841.7 67253.3 69079.0 894.2 921.9 933.9 940.0 943.4 13673.3 13921.8 13952.4 14129.2 14643.2 31252.0 32548.2 33044.7 33157.7 33345.8 44493.6 45263.3 45381.1 45428.8 46487.3 6666.8 6707.2 6810.3 6887.7 6974.4 6997.9 9209.9 10674.5 10980.4 11020.7 7554.6 7830.8 9940.8 10090.9 10279.7 9931.4 10229.2 10238.7 10404.8 10443.3 10227.6 10456.2 10462.9 10647.4 10689.7 6655.0 6799.5 6856.4 7151.4 7702.0 7922.6 9922.5 9943.5 10332.3 10475.1 09:46:36 INFO - PROCESS | 14632 | 09:46:36 INFO - PROCESS | 14632 | [#3] mootools.html Cycles:180 Average:4769.65 Median:4956.28 stddev:2582.08 (52.1%) stddev-sans-first:2576.25 09:46:36 INFO - PROCESS | 14632 | Values: 1312.5 1314.7 1318.3 1318.7 1340.2 6677.5 6916.5 6960.4 7404.1 7406.2 7006.9 7223.3 7230.1 7373.6 7419.0 2136.4 2151.5 2174.3 2177.2 2179.1 2085.1 2101.3 2123.8 2139.3 2178.9 2167.1 2195.4 2196.6 2197.6 2200.1 2082.2 2082.3 2083.9 2093.3 2099.3 2013.7 2077.3 2169.7 2208.3 2213.6 7407.8 7461.8 7535.4 7546.1 7561.8 4409.6 4552.9 4564.5 4569.3 4578.7 2693.3 2935.9 2984.4 3002.3 3004.5 1120.7 1168.2 1186.0 1191.9 1205.2 9753.6 9860.1 9897.7 9906.7 9922.2 3714.5 3929.2 3958.6 3964.4 3986.7 7854.9 7860.4 7863.8 7869.3 7888.3 4498.0 4507.8 4511.5 4514.1 4520.1 4032.3 4033.4 4044.9 4110.5 4139.2 3236.8 3244.4 3280.3 3329.4 3332.4 999.4 1002.2 1011.9 1012.4 1039.8 762.3 784.5 787.8 793.3 797.6 4670.3 4702.4 4848.1 4903.9 4958.0 850.3 888.2 889.9 895.5 899.3 2990.6 3000.6 3041.8 3175.0 3332.2 8232.6 8234.7 8615.0 8630.5 8758.3 8711.8 8768.3 8776.8 8790.9 8801.2 6708.2 6870.5 6874.4 6891.3 6894.0 4683.8 4793.2 4954.6 4980.7 5007.7 7956.6 7973.6 8119.4 8178.0 8183.4 8141.5 8204.1 8209.7 8352.1 8358.2 6303.4 6512.3 6520.5 6524.9 6531.6 6805.4 6834.0 6849.5 6894.1 6897.2 6149.3 6213.0 6249.9 6272.5 6298.8 6024.7 6076.1 6101.4 6112.6 6177.8 5535.3 5559.7 5610.6 5619.1 5619.6 4199.3 4215.5 4224.2 4246.3 4329.4 4222.6 4247.8 4262.0 4280.0 4329.8 09:46:36 INFO - PROCESS | 14632 | 09:46:36 INFO - PROCESS | 14632 | [#4] prototype.html Cycles:180 Average:4274.20 Median:4805.42 stddev:1191.73 (24.8%) stddev-sans-first:1158.09 09:46:36 INFO - PROCESS | 14632 | Values: 349.2 357.5 358.6 358.9 364.0 4975.6 5010.3 5023.4 5040.4 5040.7 4947.4 4955.5 4961.6 4962.9 4969.2 3779.9 3844.3 3878.5 3906.7 3954.7 3912.3 3921.9 3926.0 3926.0 3932.5 3906.1 3922.5 3923.1 3925.4 3930.9 3813.6 3885.8 3911.9 3950.6 3951.4 3521.4 3522.4 3529.2 3531.9 3541.8 4727.9 4811.2 4814.9 4825.2 4880.9 4399.0 4449.6 4497.8 4500.1 4515.8 5026.8 5099.7 5113.7 5141.7 5143.3 3811.1 3816.9 3821.9 3850.3 3856.4 5425.8 5445.2 5450.3 5462.6 5485.7 3853.5 3927.5 3946.8 3952.4 3987.2 3987.4 4004.9 4019.7 4025.1 4043.4 4439.3 4466.9 4467.5 4490.3 4505.6 4932.7 5118.2 5165.3 5194.4 5195.5 1357.2 1366.1 1368.1 1370.4 1377.2 931.8 955.8 975.5 983.3 989.3 4343.6 4410.4 4493.2 4561.7 4569.5 5255.8 5285.8 5298.3 5313.6 5314.8 4531.0 4537.9 4551.7 4554.3 4557.3 2575.7 2705.5 2730.4 2738.3 2739.4 4806.8 4812.2 4814.8 4835.7 4849.8 5029.0 5232.8 5257.3 5276.3 5279.9 4779.5 4786.7 4800.5 4801.3 4846.3 5121.3 5137.4 5148.6 5166.9 5187.0 4975.0 5024.2 5092.2 5110.0 5118.6 4722.5 4760.6 4793.0 4795.6 4804.0 3811.9 3814.3 3824.2 3841.2 3881.2 4924.9 5168.8 5170.3 5184.0 5194.5 4890.0 4942.5 4987.6 4992.4 4993.9 4927.5 4986.6 4989.1 4996.4 5002.3 4723.6 4942.1 4942.2 4944.8 4984.3 4980.0 5010.6 5019.4 5189.7 5206.8 5076.6 5085.2 5089.3 5089.6 5116.5 09:46:36 INFO - PROCESS | 14632 | 09:46:36 INFO - PROCESS | 14632 | [#5] yui.html Cycles:180 Average:15051.40 Median:44931.39 stddev:18651.12 (41.5%) stddev-sans-first:18671.95 09:46:36 INFO - PROCESS | 14632 | Values: 618.3 625.3 708.8 738.4 770.0 13023.5 14356.6 14377.7 14392.6 14401.0 13532.1 13579.0 13579.9 13589.9 13644.4 656.2 679.4 775.7 795.3 810.7 802.6 813.5 816.5 817.1 817.5 862.4 865.5 865.8 867.4 868.9 863.7 864.4 864.8 864.9 866.5 630.0 631.5 632.5 633.6 633.9 13648.9 13756.7 14075.7 14115.7 14122.1 13537.1 14240.1 14317.8 14328.9 14491.6 10589.8 10624.5 10730.7 10777.4 10788.6 3254.0 3265.6 3274.5 3362.3 3420.8 66509.0 66672.7 68248.7 68467.7 69314.7 10650.0 10670.8 10682.4 10807.3 10850.1 20621.0 20721.7 20735.3 20780.2 20925.2 6327.0 6442.1 6528.9 6630.6 6682.5 3568.2 3651.7 3661.1 3664.7 3712.8 2804.3 2848.1 2864.5 2881.8 2884.9 466.5 473.0 474.0 475.4 478.8 541.6 541.8 543.5 545.4 555.9 6940.0 6968.4 7125.5 7537.8 7563.1 546.3 552.8 559.9 582.6 583.5 3598.7 3824.6 3865.3 3867.4 3983.3 63415.4 64518.0 64753.0 65059.3 67905.3 55885.2 56122.7 57755.0 59409.0 59564.7 49163.8 50050.2 50149.0 52263.5 53738.0 7147.0 7403.4 7503.2 7616.8 8466.4 33383.7 34311.3 34463.3 34590.8 35049.6 44785.8 44913.0 44949.8 45284.3 45291.5 10840.5 11156.3 11181.7 11475.9 11566.1 12412.4 12822.7 13121.9 13397.6 13559.4 11641.6 11899.3 12138.0 12578.0 12758.4 11608.4 11840.9 11990.1 12315.3 12665.1 12308.9 12623.3 12628.6 13263.4 13360.8 9554.4 9598.2 9844.9 9911.0 10461.3 9140.4 9827.9 10143.4 10703.5 10734.3 09:46:36 INFO - PROCESS | 14632 | -------- Summary: end -------- 09:46:36 INFO - PROCESS | 14632 | 09:46:37 INFO - TEST-INFO | 14632: exit 0 09:46:37 INFO - TEST-OK | dromaeo_css | took 1119826ms 09:46:37 INFO - TEST-START | kraken 09:46:37 INFO - operating with platform_type : linux_ 09:46:37 INFO - Initialising browser for kraken test... 09:46:37 INFO - TEST-INFO | started process 14980 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSm5l5r/profile http://localhost:58655/getInfo.html) 09:46:38 INFO - PROCESS | 14980 | 1483206398198 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 09:46:42 INFO - PROCESS | 14980 | __metrics Screen width/height:1600/1200 09:46:42 INFO - PROCESS | 14980 | colorDepth:24 09:46:42 INFO - PROCESS | 14980 | Browser inner width/height: 1024/697 09:46:42 INFO - PROCESS | 14980 | __metrics 09:46:42 ERROR - PROCESS | 14980 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 09:46:43 INFO - TEST-INFO | 14980: exit 0 09:46:43 INFO - Browser initialized. 09:46:43 INFO - Running cycle 1/1 for kraken test... 09:46:43 INFO - TEST-INFO | started process 15102 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSm5l5r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:46:55 INFO - PROCESS | 15102 | RSS: Main: 158007296 09:46:55 INFO - PROCESS | 15102 | 09:46:58 INFO - PROCESS | 15102 | Cycle 1(1): loaded http://localhost:58655/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58655/tests/kraken/driver.html?testName=audio-beat-detection) 09:46:59 INFO - PROCESS | 15102 | RSS: Main: 164306944 09:46:59 INFO - PROCESS | 15102 | 09:47:02 INFO - PROCESS | 15102 | Cycle 1(1): loaded http://localhost:58655/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58655/tests/kraken/driver.html?testName=audio-dft) 09:47:03 INFO - PROCESS | 15102 | RSS: Main: 163020800 09:47:03 INFO - PROCESS | 15102 | 09:47:06 INFO - PROCESS | 15102 | Cycle 1(1): loaded http://localhost:58655/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58655/tests/kraken/driver.html?testName=audio-fft) 09:47:06 INFO - PROCESS | 15102 | RSS: Main: 159195136 09:47:06 INFO - PROCESS | 15102 | 09:47:08 INFO - PROCESS | 15102 | Cycle 1(1): loaded http://localhost:58655/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58655/tests/kraken/driver.html?testName=audio-oscillator) 09:47:09 INFO - PROCESS | 15102 | RSS: Main: 159956992 09:47:09 INFO - PROCESS | 15102 | 09:47:11 INFO - PROCESS | 15102 | Cycle 1(1): loaded http://localhost:58655/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58655/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:47:12 INFO - PROCESS | 15102 | RSS: Main: 160407552 09:47:12 INFO - PROCESS | 15102 | 09:47:15 INFO - PROCESS | 15102 | Cycle 1(1): loaded http://localhost:58655/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58655/tests/kraken/driver.html?testName=imaging-darkroom) 09:47:16 INFO - PROCESS | 15102 | RSS: Main: 164536320 09:47:16 INFO - PROCESS | 15102 | 09:47:19 INFO - PROCESS | 15102 | Cycle 1(1): loaded http://localhost:58655/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58655/tests/kraken/driver.html?testName=imaging-desaturate) 09:47:20 INFO - PROCESS | 15102 | RSS: Main: 161529856 09:47:20 INFO - PROCESS | 15102 | 09:47:23 INFO - PROCESS | 15102 | Cycle 1(1): loaded http://localhost:58655/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58655/tests/kraken/driver.html?testName=json-parse-financial) 09:47:23 INFO - PROCESS | 15102 | RSS: Main: 162390016 09:47:23 INFO - PROCESS | 15102 | 09:47:25 INFO - PROCESS | 15102 | Cycle 1(1): loaded http://localhost:58655/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58655/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:47:26 INFO - PROCESS | 15102 | RSS: Main: 163254272 09:47:26 INFO - PROCESS | 15102 | 09:47:27 INFO - PROCESS | 15102 | Cycle 1(1): loaded http://localhost:58655/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58655/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:47:28 INFO - PROCESS | 15102 | RSS: Main: 163143680 09:47:28 INFO - PROCESS | 15102 | 09:47:30 INFO - PROCESS | 15102 | Cycle 1(1): loaded http://localhost:58655/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58655/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:47:31 INFO - PROCESS | 15102 | RSS: Main: 163237888 09:47:31 INFO - PROCESS | 15102 | 09:47:34 INFO - PROCESS | 15102 | Cycle 1(1): loaded http://localhost:58655/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58655/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:47:35 INFO - PROCESS | 15102 | RSS: Main: 163315712 09:47:35 INFO - PROCESS | 15102 | 09:47:38 INFO - PROCESS | 15102 | Cycle 1(1): loaded http://localhost:58655/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58655/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:47:38 INFO - PROCESS | 15102 | RSS: Main: 163352576 09:47:38 INFO - PROCESS | 15102 | 09:47:40 INFO - PROCESS | 15102 | Cycle 1(1): loaded http://localhost:58655/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58655/tests/kraken/driver.html?testName=ai-astar) 09:47:40 INFO - PROCESS | 15102 | RSS: Main: 164843520 09:47:40 INFO - PROCESS | 15102 | 09:47:40 INFO - PROCESS | 15102 | __start_tp_report 09:47:40 INFO - PROCESS | 15102 | _x_x_mozilla_page_load 09:47:40 INFO - PROCESS | 15102 | _x_x_mozilla_page_load_details 09:47:40 INFO - PROCESS | 15102 | |i|pagename|runs| 09:47:40 INFO - PROCESS | 15102 | |0;ai-astar;109;118;116;117;117;117;117;120;117;118 09:47:40 INFO - PROCESS | 15102 | |1;audio-beat-detection;162;132;133;175;127;128;132;128;154;129 09:47:40 INFO - PROCESS | 15102 | |2;audio-dft;167;169;172;163;165;165;164;166;164;167 09:47:40 INFO - PROCESS | 15102 | |3;audio-fft;77;77;76;116;79;79;80;79;93;78 09:47:40 INFO - PROCESS | 15102 | |4;audio-oscillator;86;85;104;85;85;85;98;86;85;112 09:47:40 INFO - PROCESS | 15102 | |5;imaging-gaussian-blur;119;118;122;118;119;119;119;119;118;119 09:47:40 INFO - PROCESS | 15102 | |6;imaging-darkroom;151;151;150;151;151;153;152;152;151;151 09:47:40 INFO - PROCESS | 15102 | |7;imaging-desaturate;99;96;96;98;96;97;96;97;96;96 09:47:40 INFO - PROCESS | 15102 | |8;json-parse-financial;63;64;63;64;65;65;65;64;63;64 09:47:40 INFO - PROCESS | 15102 | |9;json-stringify-tinderbox;68;68;68;68;69;68;68;68;68;69 09:47:40 INFO - PROCESS | 15102 | |10;stanford-crypto-aes;87;85;86;87;86;87;86;88;91;85 09:47:40 INFO - PROCESS | 15102 | |11;stanford-crypto-ccm;142;142;143;139;135;145;142;138;192;141 09:47:40 INFO - PROCESS | 15102 | |12;stanford-crypto-pbkdf2;183;182;183;185;186;186;183;189;186;182 09:47:40 INFO - PROCESS | 15102 | |13;stanford-crypto-sha256-iterative;72;73;71;72;71;70;73;71;70;70 09:47:40 INFO - PROCESS | 15102 | __end_tp_report 09:47:40 INFO - PROCESS | 15102 | __start_cc_report 09:47:40 INFO - PROCESS | 15102 | _x_x_mozilla_cycle_collect,777 09:47:40 INFO - PROCESS | 15102 | __end_cc_report 09:47:40 INFO - PROCESS | 15102 | __startTimestamp1483206460790__endTimestamp 09:47:40 INFO - PROCESS | 15102 | 09:47:40 INFO - PROCESS | 15102 | ------- Summary: start ------- 09:47:40 INFO - PROCESS | 15102 | Number of tests: 14 09:47:40 INFO - PROCESS | 15102 | 09:47:40 INFO - PROCESS | 15102 | [#0] ai-astar Cycles:10 Average:116.60 Median:117.00 stddev:2.88 (2.5%) stddev-sans-first:1.13 09:47:40 INFO - PROCESS | 15102 | Values: 109.0 118.0 116.0 117.0 117.0 117.0 117.0 120.0 117.0 118.0 09:47:40 INFO - PROCESS | 15102 | 09:47:40 INFO - PROCESS | 15102 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:132.50 stddev:17.19 (13.0%) stddev-sans-first:16.29 09:47:40 INFO - PROCESS | 15102 | Values: 162.0 132.0 133.0 175.0 127.0 128.0 132.0 128.0 154.0 129.0 09:47:40 INFO - PROCESS | 15102 | 09:47:40 INFO - PROCESS | 15102 | [#2] audio-dft Cycles:10 Average:166.20 Median:166.50 stddev:2.70 (1.6%) stddev-sans-first:2.85 09:47:40 INFO - PROCESS | 15102 | Values: 167.0 169.0 172.0 163.0 165.0 165.0 164.0 166.0 164.0 167.0 09:47:40 INFO - PROCESS | 15102 | 09:47:40 INFO - PROCESS | 15102 | [#3] audio-fft Cycles:10 Average:83.40 Median:79.00 stddev:12.43 (15.7%) stddev-sans-first:12.97 09:47:40 INFO - PROCESS | 15102 | Values: 77.0 77.0 76.0 116.0 79.0 79.0 80.0 79.0 93.0 78.0 09:47:40 INFO - PROCESS | 15102 | 09:47:40 INFO - PROCESS | 15102 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:85.00 stddev:9.94 (11.7%) stddev-sans-first:10.37 09:47:40 INFO - PROCESS | 15102 | Values: 86.0 85.0 104.0 85.0 85.0 85.0 98.0 86.0 85.0 112.0 09:47:40 INFO - PROCESS | 15102 | 09:47:40 INFO - PROCESS | 15102 | [#5] imaging-gaussian-blur Cycles:10 Average:119.00 Median:119.00 stddev:1.15 (1.0%) stddev-sans-first:1.22 09:47:40 INFO - PROCESS | 15102 | Values: 119.0 118.0 122.0 118.0 119.0 119.0 119.0 119.0 118.0 119.0 09:47:40 INFO - PROCESS | 15102 | 09:47:40 INFO - PROCESS | 15102 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:151.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 09:47:40 INFO - PROCESS | 15102 | Values: 151.0 151.0 150.0 151.0 151.0 153.0 152.0 152.0 151.0 151.0 09:47:40 INFO - PROCESS | 15102 | 09:47:40 INFO - PROCESS | 15102 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.50 stddev:1.06 (1.1%) stddev-sans-first:0.73 09:47:40 INFO - PROCESS | 15102 | Values: 99.0 96.0 96.0 98.0 96.0 97.0 96.0 97.0 96.0 96.0 09:47:40 INFO - PROCESS | 15102 | 09:47:40 INFO - PROCESS | 15102 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 09:47:40 INFO - PROCESS | 15102 | Values: 63.0 64.0 63.0 64.0 65.0 65.0 65.0 64.0 63.0 64.0 09:47:40 INFO - PROCESS | 15102 | 09:47:40 INFO - PROCESS | 15102 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 09:47:40 INFO - PROCESS | 15102 | Values: 68.0 68.0 68.0 68.0 69.0 68.0 68.0 68.0 68.0 69.0 09:47:40 INFO - PROCESS | 15102 | 09:47:40 INFO - PROCESS | 15102 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:87.00 stddev:1.75 (2.0%) stddev-sans-first:1.86 09:47:40 INFO - PROCESS | 15102 | Values: 87.0 85.0 86.0 87.0 86.0 87.0 86.0 88.0 91.0 85.0 09:47:40 INFO - PROCESS | 15102 | 09:47:40 INFO - PROCESS | 15102 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:142.00 stddev:16.44 (11.6%) stddev-sans-first:17.38 09:47:40 INFO - PROCESS | 15102 | Values: 142.0 142.0 143.0 139.0 135.0 145.0 142.0 138.0 192.0 141.0 09:47:40 INFO - PROCESS | 15102 | 09:47:40 INFO - PROCESS | 15102 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.50 Median:185.50 stddev:2.27 (1.2%) stddev-sans-first:2.35 09:47:40 INFO - PROCESS | 15102 | Values: 183.0 182.0 183.0 185.0 186.0 186.0 183.0 189.0 186.0 182.0 09:47:40 INFO - PROCESS | 15102 | 09:47:40 INFO - PROCESS | 15102 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:71.50 stddev:1.16 (1.6%) stddev-sans-first:1.20 09:47:40 INFO - PROCESS | 15102 | Values: 72.0 73.0 71.0 72.0 71.0 70.0 73.0 71.0 70.0 70.0 09:47:40 INFO - PROCESS | 15102 | -------- Summary: end -------- 09:47:40 INFO - PROCESS | 15102 | 09:47:41 INFO - TEST-INFO | 15102: exit 0 09:47:41 INFO - TEST-OK | kraken | took 64283ms 09:47:41 INFO - SUITE-END | took 1184s 09:47:42 INFO - Completed test suite (00:19:44) 09:47:42 INFO - javascript benchmark 09:47:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6250.992075264173, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2591.585346344585, 2599.1552745357762, 2603.492318997794, 2617.5811870100774, 2627.868606569671, 4750.928736068958, 4765.237561990087, 4769.403824521934, 4811.566958973692, 4830.97584512077, 4788.90422191556, 4808.254720518316, 4875.171220892448, 4877.097736918672, 4941.357623508939, 4415.381846541487, 4454.910901781978, 4480.731156130626, 4544.272916333387, 4583.175028494887, 4144.689148313873, 4559.430071241095, 4584.587387135157, 4594.379758732578, 4603.49361570227, 4373.978130109329, 4441.533638967927, 4445.488768791565, 4494.303382975644, 4561.566651168134, 4360.236958532244, 4392.78036098197, 4396.296592545177, 4400.889977750582, 4461.776911154429, 4359.280718681413, 4368.453943257093, 4374.19077470669, 4381.561843815625, 4385.232584297735, 4737.2420412734145, 4767.42790865095, 4779.80880764769, 4798.736069516175, 4820.108279968217, 4893.241547560134, 4949.232868905326, 4991.301217829507, 5012.598992080625, 5027.84916452507, 5009.44896061433, 5064.189729643276, 5084.288199652015, 5086.287919691246, 5115.335006449138, 4670.999999999966, 4685.109829132454, 4709.740964246965, 4746.881327966759, 4781.282807578891, 5156.74216289184, 5196.298499702568, 5210.921836172461, 5218.373795144607, 5228.37259528859, 5028.84913452597, 5044.268581055726, 5050.217216331474, 5087.135187018216, 5093.8726531837, 5047.545720885138, 5106.565941894981, 5134.974325128351, 5161.251618515369, 5205.193195054697, 5034.597232221414, 5098.59211263098, 5144.768485418165, 5157.6647517911215, 5235.05768961583, 5180.378354597397, 5181.1969144782615, 5192.402873669501, 5195.610329225323, 5209.0, 4379.802908869108, 4427.180971520214, 4429.955700443019, 4441.644668426583, 4456.598906098467, 3714.0900479382185, 3746.1758413149064, 3781.2248489059675, 3797.1836055248255, 3832.789196594214, 4451.554844515523, 4477.059817438374, 4481.977590112028, 4490.753008584559, 4524.932126018112, 5151.459096794858, 5203.583713302926, 5247.895042099137, 5254.316938798008, 5272.630915835932, 4318.352247162888, 4340.8697739067875, 4353.0423306872435, 4400.471943366816, 4475.955240447619, 4585.908281834345, 4590.586847183769, 4591.471980722193, 4601.28680054592, 4606.424196975378, 4756.8097276108565, 4784.7607619619575, 4785.210440277385, 4785.808567657255, 4813.03739252144, 5142.280080788767, 5148.897022059613, 5150.201718733602, 5153.0466863630345, 5153.252778347193, 4758.2386818108935, 4765.5949244314625, 4774.665773395829, 4807.543283388212, 4854.660173787801, 5003.649744517848, 5034.496550344937, 5034.874128146826, 5041.697498150123, 5083.288339632529, 5082.440931497458, 5085.0, 5085.415177254663, 5086.21163719624, 5123.718195499283, 5001.974990125026, 5003.224500202329, 5054.924176137434, 5056.317397151338, 5128.153854613947, 5067.13858644024, 5073.467285934924, 5081.466446023114, 5085.7711402986215, 5118.564921981673, 4839.879003024953, 4884.0, 4887.780049897834, 5004.599632029356, 5026.623003274696, 4997.675151115166, 5045.192769156917, 5076.593872490266, 5091.567216786615, 5135.897282054263, 4969.801207951641, 4977.800887964441, 4984.352034235526, 4992.775325110451, 5029.723365214948], "value": 4712.633765429059, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.6421123108209, 513.9254808052831, 531.2774626507949, 533.6691251424118, 557.2866730584848, 37543.0, 38895.611043889585, 38952.41571376432, 39322.41016384756, 41791.58208417915, 39258.21483570334, 39559.0, 39604.00989975245, 39676.0, 39744.403833942444, 7674.616269186547, 7828.843423131534, 7831.334336581397, 7860.882086768703, 9339.626414943394, 9312.487813170274, 9465.763355916122, 9544.90455095447, 9567.138957493824, 9570.521473926276, 9522.333436659437, 9548.140667339938, 9670.806583868318, 9672.081152290557, 9691.176250018756, 9504.239660827152, 9575.95212023939, 9587.760305992337, 9606.0, 9608.567614457366, 9538.618455261781, 9559.713208603753, 9591.760205994837, 9597.040295970417, 9624.855627165598, 33177.17057073592, 33466.6653333466, 33503.6649633503, 33530.664693353, 33536.32927341464, 3424.298018906118, 3556.448750443685, 3565.8038807865555, 3583.605803361628, 3587.1390866192187, 25281.0, 25458.236252912444, 25712.22863314085, 25734.613980790302, 25934.35164120893, 3223.613166420021, 3228.8376184573535, 3280.934381312384, 3338.4491558892755, 3413.8805141819917, 228802.0, 229289.0, 230280.0, 230460.0, 231190.0, 43647.0, 43673.563264367585, 43856.3421548677, 43936.0, 43985.12029759451, 47139.05721885543, 47169.29246061312, 47234.0, 47281.76359118251, 47373.0, 10468.790624187473, 10635.574577016987, 10646.0, 10678.946605266923, 10700.30448020876, 7750.108737495148, 7951.204879512118, 7967.28294453502, 8059.274665280153, 8166.550839703873, 15109.168995705342, 15121.546353609408, 15244.161571113473, 15319.846801532065, 15543.533693989199, 6201.441870231611, 6435.356464353527, 6438.937575300117, 6497.220333560003, 6540.9345906541275, 788.2157253532657, 789.1753117991713, 801.0947629178991, 812.3825892321878, 822.7696245051395, 26211.213663590122, 27572.034978775646, 27597.0, 27740.861295693394, 28047.0, 927.7263207353847, 928.9210417114485, 934.6027938126269, 935.6163972771267, 1069.342354452022, 13294.601161965156, 14663.633409164642, 14686.118832870063, 14851.0, 14878.92560537212, 338972.0, 340827.0, 341030.0, 341729.0, 343469.0, 47231.291530627066, 47934.28098578524, 47948.520514795106, 47976.52023479791, 48162.51837481651, 1127.740619657467, 1160.4429873660522, 1164.6622479480855, 1173.8826117388364, 1190.220405634311, 24567.631485527374, 25499.0, 26542.60186097249, 26732.0, 26868.462630746886, 39473.80263098666, 39699.40450893181, 39736.0, 39820.0, 39828.40257396083, 289618.0, 291362.0, 293004.0, 293300.0, 293789.0, 21969.890150549145, 22966.770332296463, 23013.769862301164, 24025.159119430737, 24225.39436514101, 33666.66333336733, 33861.49207761935, 34299.14252143716, 34354.484682730275, 34390.484142737376, 30756.0, 30980.22549436282, 31024.379512410076, 31591.368172636878, 31887.521687175176, 29431.705682943753, 33187.17032074121, 33897.322053559285, 34506.309873802886, 34934.0, 30231.69768302377, 30946.690533095283, 31115.22211944629, 31284.374312513166, 31325.216869577533, 27574.862125689244, 28382.290442739097, 29010.9846155392, 29115.85442072776, 29203.41593168082, 22795.0, 22857.88571057134, 22979.6553051701, 23133.884330578912, 23191.768082318962], "value": 16486.459176317236, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.6174386022745, 367.9227362253927, 369.39419352262297, 382.4607303701781, 385.2622228432552, 15415.691686166285, 16484.752728709063, 17044.23300951457, 17150.313987440517, 17165.9700417975, 15904.125273109974, 15943.681126377465, 15947.0, 16045.197740112977, 16046.59883502913, 4826.662133650646, 5092.898142037157, 5097.209932460474, 5105.106606343894, 5106.055379754739, 3838.9424158637503, 4055.3105971984687, 5024.773885175176, 5719.714014299289, 5989.9101513477335, 6021.066734656135, 6039.607425517327, 6067.666278354689, 6069.544784141207, 6077.179580756586, 5798.62308949919, 5908.350081491032, 5909.2022576951995, 5910.527157827363, 5917.940820591825, 5033.219850923113, 5129.666571672829, 5151.330327057496, 5195.350581177353, 5199.766010529535, 19693.606127877363, 19788.109535070955, 19993.700094498596, 19999.300024499218, 20044.298449554197, 2492.8255022148455, 2532.9113481028076, 2537.8774746038966, 2592.4555843272933, 2596.9220923372327, 12077.094217933602, 12582.496700131984, 12763.936180319131, 12813.551525696555, 13383.929285657125, 1728.6542691461632, 1749.6850566897954, 1763.215369160724, 1767.2135899524717, 1767.8674099442464, 64747.67626161839, 64848.351516484705, 66053.0, 66098.66950665264, 66957.66521167364, 9643.0, 9796.804063918682, 9849.655262065793, 9951.154151897024, 9978.101970822661, 13387.531436399679, 13465.124766890316, 13476.460941562424, 13482.39329230187, 13483.932580337036, 6155.199824022849, 6325.493960483151, 6437.130987316652, 6508.414242718178, 6510.641914694737, 5712.086066229466, 5791.189233507313, 5939.554533410012, 5941.524678025748, 5954.136650185699, 4163.208990291835, 4177.56135605757, 4245.257080010986, 4245.490541135084, 4267.978660106742, 1523.3297349166332, 1605.566497045791, 1606.6866960942505, 1777.7378061576426, 1849.232568484091, 928.9163975242261, 937.4562753602894, 960.0735290444754, 960.6349587156835, 982.9361091529171, 14826.925865370604, 15133.54599362021, 15368.308426120851, 15458.922705386625, 15828.525144245461, 931.3852857114272, 935.9391639543408, 936.840737074699, 936.9812603748023, 943.6980166346704, 8584.184502472255, 8733.170348816851, 8877.245434138042, 9100.135487128713, 9271.728426535406, 312119.0, 313401.0, 314845.0, 314912.0, 324319.0, 48787.756061219465, 60024.39975600188, 65841.67079164574, 67253.32746672569, 69079.0, 894.2264940826268, 921.9308551858637, 933.9112784285481, 939.957701903416, 943.4480828715141, 13673.316334183051, 13921.79117313221, 13952.441902323793, 14129.222892740998, 14643.194624295766, 31252.0, 32548.186295342806, 33044.66955330416, 33157.66842331546, 33345.83327083349, 44493.55506444894, 45263.321050183615, 45381.09237815159, 45428.77285613551, 46487.30269045899, 6666.799996000128, 6707.1616047994, 6810.250872404131, 6887.7244910203035, 6974.442044636316, 6997.930020699931, 9209.940856801286, 10674.46627668629, 10980.396078215776, 11020.724481887697, 7554.622268886424, 7830.786228134648, 9940.801183976424, 10090.899091009289, 10279.687070409098, 9931.404115753077, 10229.181665466596, 10238.744031399274, 10404.791904162026, 10443.321184123311, 10227.642032528825, 10456.215783816093, 10462.895371046496, 10647.361158330525, 10689.679309620413, 6655.0, 6799.456043516606, 6856.382925536725, 7151.4278857690215, 7701.961490192513, 7922.643481043252, 9922.454265015205, 9943.453110078726, 10332.328398654063, 10475.057244848], "value": 7939.557860060988, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1312.4618906248438, 1314.6910476038129, 1318.2617734068929, 1318.7494376068546, 1340.2293681133347, 6677.465802735782, 6916.515843890929, 6960.40836528895, 7404.148522919859, 7406.185319614838, 7006.929930700691, 7223.349898509133, 7230.060092188009, 7373.594452305121, 7419.035525381706, 2136.423165745252, 2151.4943988162768, 2174.3259589527297, 2177.205320058183, 2179.095675294751, 2085.14509051289, 2101.3275751759443, 2123.787621237879, 2139.3474990128007, 2178.901949412272, 2167.100653228908, 2195.352371050536, 2196.615592271346, 2197.571473562656, 2200.108955872874, 2082.1671331467533, 2082.302428686392, 2083.8853863037525, 2093.2568938026934, 2099.32821497121, 2013.7281467001915, 2077.2833372486466, 2169.6962425260476, 2208.293346129239, 2213.557288542298, 7407.814804629874, 7461.813454663623, 7535.434842386788, 7546.09446866374, 7561.848763024709, 4409.647228221735, 4552.931706024412, 4564.452265728134, 4569.314602809572, 4578.748168850712, 2693.299742067057, 2935.8678859451375, 2984.4478771427357, 3002.264445210937, 3004.4742170120144, 1120.7142178744368, 1168.199783148546, 1185.952561897523, 1191.9165658403915, 1205.2226314027491, 9753.609855605768, 9860.112589866874, 9897.703068907944, 9906.653267135616, 9922.206223502102, 3714.4799728038097, 3929.155231625214, 3958.584348643351, 3964.4053391990856, 3986.661133803659, 7854.8821767673535, 7860.449768516263, 7863.803404914923, 7869.331106855867, 7888.290053895063, 4497.955020449819, 4507.774611269423, 4511.481179664315, 4514.119746649372, 4520.073384956077, 4032.334664780278, 4033.4151548025957, 4044.939325910114, 4110.547839737626, 4139.172165566899, 3236.821974791409, 3244.416005119054, 3280.2619410632415, 3329.4339962206, 3332.3501917125927, 999.4303247149055, 1002.223276960347, 1011.9038691324313, 1012.3925644613173, 1039.8076355874186, 762.2834535536578, 784.4900814470526, 787.8463699578642, 793.2781169136058, 797.5812698333422, 4670.276107203389, 4702.36518070063, 4848.0788650156355, 4903.877403064952, 4958.0, 850.2730165708231, 888.2405543260548, 889.9332550058772, 895.4627223665749, 899.321012635456, 2990.5813186153955, 3000.639923209229, 3041.81749095055, 3174.968250317467, 3332.2002719347183, 8232.62953167109, 8234.711785087613, 8615.0, 8630.482171069756, 8758.299336053227, 8711.825763484694, 8768.298536117096, 8776.824463510695, 8790.857188565573, 8801.207891289814, 6708.161479815023, 6870.484713646497, 6874.415674667609, 6891.345322194384, 6893.965530172217, 4683.78922948475, 4793.18515852299, 4954.5540901319055, 4980.676256043345, 5007.749612519432, 7956.562389068657, 7973.601319934096, 8119.431639785158, 8178.0, 8183.386246031452, 8141.51150930946, 8204.097549269694, 8209.71266005687, 8352.123027082069, 8358.205970432798, 6303.401176888188, 6512.283648798723, 6520.543561950808, 6524.869502609827, 6531.608103513804, 6805.421539169226, 6834.0, 6849.5205335628025, 6894.13823272091, 6897.241303456716, 6149.292831324455, 6213.03697926822, 6249.8750024998335, 6272.4982001440685, 6298.779542715983, 6024.668643224665, 6076.088586712029, 6101.38986101404, 6112.633242005494, 6177.795329910624, 5535.280413546213, 5559.694216818114, 5610.551155907599, 5619.100943849128, 5619.606627536196, 4199.265128602544, 4215.515215750228, 4224.239636865394, 4246.256905041543, 4329.350597410414, 4222.59885310895, 4247.808848601759, 4262.0, 4279.97860010698, 4329.783510824509], "value": 3903.3085428543072, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.2351749668226, 357.46558894452795, 358.587624232133, 358.8995081377212, 363.96542328478785, 4975.6019518438525, 5010.323606313146, 5023.372078490189, 5040.420351659564, 5040.722760248185, 4947.406311242656, 4955.529224723655, 4961.553460188582, 4962.851114466563, 4969.155243608586, 3779.924401511975, 3844.3478695239496, 3878.534575850902, 3906.6560063961538, 3954.6638535724496, 3912.2957867583823, 3921.8823435296986, 3925.9803700981456, 3926.0, 3932.469116669256, 3906.1485115865294, 3922.4900762900784, 3923.136909879822, 3925.3523168677134, 3930.85768256301, 3813.6186381361917, 3885.7668539887695, 3911.902202444933, 3950.6246906543834, 3951.3601855230045, 3521.383757842393, 3522.4364101743854, 3529.2412131391875, 3531.876384326536, 3541.821779605524, 4727.881802954919, 4811.158047341736, 4814.855554333376, 4825.227963525819, 4880.877978050542, 4399.039639374798, 4449.599536041739, 4497.7526236057, 4500.077484115748, 4515.7516336601475, 5026.84919452417, 5099.6685215460875, 5113.667611605234, 5141.717205553693, 5143.254228136937, 3811.065479580735, 3816.866409675648, 3821.9235615287816, 3850.268448994682, 3856.402257650069, 5425.810096646598, 5445.237666726622, 5450.31871016123, 5462.552423607747, 5485.6982865942355, 3853.4797802296894, 3927.548331941863, 3946.7631942083567, 3952.3676211806546, 3987.1626958338493, 3987.444896490371, 4004.939925901114, 4019.698522610757, 4025.1345960618023, 4043.3934909763184, 4439.334099884978, 4466.9106617867465, 4467.530909254481, 4490.348899409632, 4505.61702255312, 4932.679375840559, 5118.181091025418, 5165.251038599382, 5194.3766747990485, 5195.532402083831, 1357.2331632627731, 1366.050594836599, 1368.1449094316054, 1370.4381203706432, 1377.1736957825224, 931.7996630724426, 955.7515046088067, 975.5024937282037, 983.3362480325751, 989.3322007644811, 4343.587359200871, 4410.434295825, 4493.168763778712, 4561.657875659273, 4569.451665800058, 5255.817441075727, 5285.814996475105, 5298.337707786527, 5313.628046036741, 5314.7608357624, 4530.954690453119, 4537.931931021038, 4551.681382303207, 4554.294084416854, 4557.339185818038, 2575.6522869412765, 2705.4724328755706, 2730.440259746787, 2738.3017330580974, 2739.4384151248946, 4806.831760888422, 4812.205986012339, 4814.831480898222, 4835.661503694778, 4849.787553111722, 5029.0, 5232.816851410183, 5257.263983042377, 5276.287701160371, 5279.868003299872, 4779.498152693986, 4786.7367294799815, 4800.463851567535, 4801.279808028824, 4846.321514987904, 5121.2870668764845, 5137.409197942135, 5148.58811295088, 5166.870828229325, 5187.014467251211, 4974.975125124496, 5024.176790281224, 5092.243176104238, 5109.9744501277255, 5118.590512758896, 4722.48052714208, 4760.595349395202, 4793.034855709143, 4795.616350692006, 4804.0, 3811.8856434307013, 3814.275287695329, 3824.158685089276, 3841.2125514270065, 3881.223755249018, 4924.901501970012, 5168.767405466839, 5170.250313704567, 5183.974080129726, 5194.4805519447755, 4890.0, 4942.481039490802, 4987.625928055338, 4992.403949945935, 4993.925091123563, 4927.482614325444, 4986.6010719143105, 4989.054268835084, 4996.3504744383, 5002.324686167466, 4723.598494128038, 4942.061008408391, 4942.20924652054, 4944.752762361795, 4984.302197692398, 4979.975100124621, 5010.599152067899, 5019.3976722793495, 5189.662671926313, 5206.817761378334, 5076.568491678248, 5085.211792172071, 5089.287499749964, 5089.592832573459, 5116.462771408948], "value": 3914.6797910183577, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.2550027217204, 625.284049763021, 708.7554793596207, 738.3650060947585, 769.9884501732475, 13023.479060837566, 14356.641083972905, 14377.712445751078, 14392.568222953301, 14401.0, 13532.120412173203, 13579.0, 13579.932100339509, 13589.864101358984, 13644.38600262988, 656.2420404432887, 679.4428568573771, 775.7401270574364, 795.3200013988059, 810.7081450677751, 802.5906787538339, 813.4549851599443, 816.4570560577239, 817.0562999735286, 817.480899628734, 862.4221771413169, 865.4634126841368, 865.8354912566624, 867.4361664917823, 868.8566386546212, 863.7149740585654, 864.3992425264476, 864.7838040489878, 864.8702694595861, 866.4714524140269, 629.9842503937439, 631.5137344244906, 632.5319263744796, 633.5660072850112, 633.9270983836872, 13648.931755341258, 13756.724865502734, 14075.718485630332, 14115.717685646332, 14122.082064665763, 13537.1200871943, 14240.145591264558, 14317.808735499862, 14328.856711432856, 14491.565253042425, 10589.84115238272, 10624.521896514676, 10730.678079657622, 10777.407242601654, 10788.622398216103, 3253.9749978756618, 3265.6081270247487, 3274.5251938468787, 3362.2939182771647, 3420.811855347955, 66509.0, 66672.66609672073, 68248.6587567064, 68467.65766171187, 69314.65342673304, 10650.0, 10670.772861120915, 10682.359058456517, 10807.297525660806, 10850.131989440826, 20621.0, 20721.68917466239, 20735.27426540064, 20780.168793248402, 20925.162993480393, 6327.0, 6442.130312407859, 6528.902066469007, 6630.635315057718, 6682.532222744361, 3568.232829941523, 3651.6713495785507, 3661.0847288177956, 3664.688501477351, 3712.832922518493, 2804.2568719289407, 2848.0886116442953, 2864.5273529867754, 2881.812682175652, 2884.855757212173, 466.51482458243726, 472.9739864307496, 474.0495306909624, 475.4366076199714, 478.8412042856296, 541.5829811045473, 541.7995341723508, 543.4646872830259, 545.3918880448272, 555.8804856955774, 6939.965300173467, 6968.407685346802, 7125.501214914906, 7537.8115547111765, 7563.146452007666, 546.3280165396584, 552.8230966090812, 559.9188117722907, 582.6271186440681, 583.4602992232168, 3598.676119149237, 3824.598417166213, 3865.2849222893856, 3867.41988701697, 3983.3029219886403, 63415.36584634187, 64518.0, 64753.0, 65059.34940650628, 67905.3209467899, 55885.161722574194, 56122.71938640281, 57755.0, 59409.0, 59564.70217648884, 49163.75418122886, 50050.24924626134, 50149.0, 52263.47736522662, 53738.0, 7147.0, 7403.370713489198, 7503.2496750324535, 7616.771496855104, 8466.365022623204, 33383.666163339025, 34311.31377372488, 34463.310733785685, 34590.82704586461, 35049.64950350464, 44785.776071119435, 44913.0, 44949.77525112354, 45284.32073518834, 45291.54708453005, 10840.512176952214, 11156.330620162817, 11181.72045698864, 11475.942620286845, 11566.132540059361, 12412.441440135035, 12822.679433013876, 13121.934390327988, 13397.626483447844, 13559.389827457986, 11641.59254426125, 11899.345535995604, 12138.0, 12578.0, 12758.362081895682, 11608.361540115375, 11840.881591183977, 11990.100742444525, 12315.322657253937, 12665.113442059335, 12308.876911230773, 12623.305718185587, 12628.558000469939, 13263.403146858222, 13360.799588005993, 9554.426734395958, 9598.232141428529, 9844.852327214954, 9911.0, 10461.320014199053, 9140.405873618194, 9827.901720982698, 10143.391396516232, 10703.464826758787, 10734.302270352402], "value": 6328.925933898664, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1585.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 120.0, 117.0, 118.0], "value": 116.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 132.0, 133.0, 175.0, 127.0, 128.0, 132.0, 128.0, 154.0, 129.0], "value": 140.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 169.0, 172.0, 163.0, 165.0, 165.0, 164.0, 166.0, 164.0, 167.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 116.0, 79.0, 79.0, 80.0, 79.0, 93.0, 78.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 104.0, 85.0, 85.0, 85.0, 98.0, 86.0, 85.0, 112.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 122.0, 118.0, 119.0, 119.0, 119.0, 119.0, 118.0, 119.0], "value": 119.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 150.0, 151.0, 151.0, 153.0, 152.0, 152.0, 151.0, 151.0], "value": 151.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 96.0, 96.0, 98.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 64.0, 65.0, 65.0, 65.0, 64.0, 63.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 69.0], "value": 68.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 86.0, 87.0, 86.0, 87.0, 86.0, 88.0, 91.0, 85.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 142.0, 143.0, 139.0, 135.0, 145.0, 142.0, 138.0, 192.0, 141.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 183.0, 185.0, 186.0, 186.0, 183.0, 189.0, 186.0, 182.0], "value": 184.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 71.0, 72.0, 71.0, 70.0, 73.0, 71.0, 70.0, 70.0], "value": 71.3, "unit": "score"}]}]} 09:47:42 INFO - Return code: 0 09:47:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:47:42 ERROR - # TBPL SUCCESS # 09:47:42 INFO - Running post-action listener: _resource_record_post_action 09:47:42 INFO - [mozharness: 2016-12-31 17:47:42.569587Z] Finished run-tests step (success) 09:47:42 INFO - Running post-run listener: _resource_record_post_run 09:47:42 INFO - Total resource usage - Wall time: 1201s; CPU: 14.0%; Read bytes: 12288; Write bytes: 407089152; Read time: 144; Write time: 261236 09:47:42 INFO - TinderboxPrint: CPU usage
13.5% 09:47:42 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 144 09:47:42 INFO - TinderboxPrint: I/O write bytes / time
407,089,152 / 261,236 09:47:42 INFO - TinderboxPrint: CPU idle
8,286.3 (86.5%) 09:47:42 INFO - TinderboxPrint: CPU user
1,236.3 (12.9%) 09:47:42 INFO - TinderboxPrint: Swap in / out
0 / 0 09:47:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 110866432; Read time: 28; Write time: 71588 09:47:42 INFO - run-tests - Wall time: 1185s; CPU: 14.0%; Read bytes: 8192; Write bytes: 295608320; Read time: 116; Write time: 189624 09:47:43 INFO - Running post-run listener: _upload_blobber_files 09:47:43 INFO - Blob upload gear active. 09:47:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:47:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:47:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:47:43 INFO - (blobuploader) - INFO - Open directory for files ... 09:47:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:47:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:47:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:47:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:47:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:47:44 INFO - (blobuploader) - INFO - Done attempting. 09:47:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:47:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:47:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:47:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:47:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:47:45 INFO - (blobuploader) - INFO - Done attempting. 09:47:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:47:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:47:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:47:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:47:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:47:45 INFO - (blobuploader) - INFO - Done attempting. 09:47:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:47:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:47:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:47:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:47:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:47:49 INFO - (blobuploader) - INFO - Done attempting. 09:47:49 INFO - (blobuploader) - INFO - Iteration through files over. 09:47:49 INFO - Return code: 0 09:47:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:47:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:47:49 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62bcd5b570a7955a70660f43535a55950c06d8f0100fe496d947d9c90d9362106d4763119a696df71b8ffce2ebf6c5f96ac99db0aa3163721d47eabf1dd1019f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e889de39f43bcbeca49e802032bed49ce8b0228d744b254115b458072f18fa84ada4ec91876687020374ecaf288be23e2ddd53332b801d3c29b51b574012cbf3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/227607c8cf9c15d93caafee327ab2a45f13c48c4dd8eb41e132587714158a64d78c8a9e653b0cc68db31103682816201f1a2df616dc8916e4b869920c6844c9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/974a811a7beead9c465002e51f249830610826bcebb4e2b56b01a2c77a7196912315c0164df82ff57b561492e9a5e84a371f6443a7aa9f878a369b52403a274f"} 09:47:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:47:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:47:49 INFO - Contents: 09:47:49 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62bcd5b570a7955a70660f43535a55950c06d8f0100fe496d947d9c90d9362106d4763119a696df71b8ffce2ebf6c5f96ac99db0aa3163721d47eabf1dd1019f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e889de39f43bcbeca49e802032bed49ce8b0228d744b254115b458072f18fa84ada4ec91876687020374ecaf288be23e2ddd53332b801d3c29b51b574012cbf3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/227607c8cf9c15d93caafee327ab2a45f13c48c4dd8eb41e132587714158a64d78c8a9e653b0cc68db31103682816201f1a2df616dc8916e4b869920c6844c9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/974a811a7beead9c465002e51f249830610826bcebb4e2b56b01a2c77a7196912315c0164df82ff57b561492e9a5e84a371f6443a7aa9f878a369b52403a274f"} 09:47:49 INFO - Running post-run listener: copy_logs_to_upload_dir 09:47:49 INFO - Copying logs to upload dir... 09:47:49 INFO - mkdir: /builds/slave/test/build/upload/logs 09:47:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.476772 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-12-31 09:47:47.512160) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-31 09:47:47.515460) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595 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/62bcd5b570a7955a70660f43535a55950c06d8f0100fe496d947d9c90d9362106d4763119a696df71b8ffce2ebf6c5f96ac99db0aa3163721d47eabf1dd1019f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e889de39f43bcbeca49e802032bed49ce8b0228d744b254115b458072f18fa84ada4ec91876687020374ecaf288be23e2ddd53332b801d3c29b51b574012cbf3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/227607c8cf9c15d93caafee327ab2a45f13c48c4dd8eb41e132587714158a64d78c8a9e653b0cc68db31103682816201f1a2df616dc8916e4b869920c6844c9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/974a811a7beead9c465002e51f249830610826bcebb4e2b56b01a2c77a7196912315c0164df82ff57b561492e9a5e84a371f6443a7aa9f878a369b52403a274f"} build_url:https://queue.taskcluster.net/v1/task/Mz5ZWQo9RC6WqJSlpeMcXA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011792 build_url: 'https://queue.taskcluster.net/v1/task/Mz5ZWQo9RC6WqJSlpeMcXA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62bcd5b570a7955a70660f43535a55950c06d8f0100fe496d947d9c90d9362106d4763119a696df71b8ffce2ebf6c5f96ac99db0aa3163721d47eabf1dd1019f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e889de39f43bcbeca49e802032bed49ce8b0228d744b254115b458072f18fa84ada4ec91876687020374ecaf288be23e2ddd53332b801d3c29b51b574012cbf3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/227607c8cf9c15d93caafee327ab2a45f13c48c4dd8eb41e132587714158a64d78c8a9e653b0cc68db31103682816201f1a2df616dc8916e4b869920c6844c9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/974a811a7beead9c465002e51f249830610826bcebb4e2b56b01a2c77a7196912315c0164df82ff57b561492e9a5e84a371f6443a7aa9f878a369b52403a274f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-31 09:47:47.540992) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 09:47:47.541340) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1483199307.547553-233714595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 09:47:47.624017) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-31 09:47:47.624327) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-31 09:47:47.624629) ========= ========= Total master_lag: 0.16 =========