builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-034 starttime: 1483499107.2 results: success (0) revision: 9c825a25d288e346b46b1d306cc4d4ba4004ae40 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-03 19:05:07.198609) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-03 19:05:07.198997) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-03 19:05:07.199279) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-03 19:05:07.213735) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 19:05:07.214015) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-03 19:05:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2017-01-03 19:05:08 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087248 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 19:05:07.314729) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 19:05:07.315054) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019458 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 19:05:07.364865) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 19:05:07.365213) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9c825a25d288e346b46b1d306cc4d4ba4004ae40 --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 9c825a25d288e346b46b1d306cc4d4ba4004ae40 --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=d6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-03 19:05:08,259 truncating revision to first 12 chars 2017-01-03 19:05:08,259 Setting DEBUG logging. 2017-01-03 19:05:08,259 attempt 1/10 2017-01-03 19:05:08,259 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9c825a25d288?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-03 19:05:08,688 unpacking tar archive at: mozilla-central-9c825a25d288/testing/mozharness/ program finished with exit code 0 elapsedTime=0.723759 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 19:05:08.102328) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-03 19:05:08.102631) ========= script_repo_revision: 9c825a25d288e346b46b1d306cc4d4ba4004ae40 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-03 19:05:08.103055) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-03 19:05:08.103366) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-03 19:05:08.113245) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-01-03 19:05:08.113592) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:05:09 INFO - MultiFileLogger online at 20170103 19:05:09 in /builds/slave/test 19:05:09 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 19:05:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:05:09 INFO - {'append_to_log': False, 19:05:09 INFO - 'base_work_dir': '/builds/slave/test', 19:05:09 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 19:05:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:05:09 INFO - 'branch': 'Firefox-Non-PGO', 19:05:09 INFO - 'buildbot_json_path': 'buildprops.json', 19:05:09 INFO - 'config_files': ('talos/linux_config.py',), 19:05:09 INFO - 'default_actions': ('clobber', 19:05:09 INFO - 'read-buildbot-config', 19:05:09 INFO - 'download-and-extract', 19:05:09 INFO - 'populate-webroot', 19:05:09 INFO - 'create-virtualenv', 19:05:09 INFO - 'install', 19:05:09 INFO - 'run-tests'), 19:05:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:05:09 INFO - 'download_minidump_stackwalk': True, 19:05:09 INFO - 'download_symbols': 'ondemand', 19:05:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:05:09 INFO - 'tooltool.py': '/tools/tooltool.py', 19:05:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:05:09 INFO - '/tools/misc-python/virtualenv.py')}, 19:05:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:05:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:05:09 INFO - 'installer_path': 'installer.exe', 19:05:09 INFO - 'log_level': 'info', 19:05:09 INFO - 'log_name': 'talos', 19:05:09 INFO - 'log_to_console': True, 19:05:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:05:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:05:09 INFO - 'opt_config_files': (), 19:05:09 INFO - 'pip_index': False, 19:05:09 INFO - 'sps_profile': False, 19:05:09 INFO - 'sps_profile_interval': 0, 19:05:09 INFO - 'suite': 'dromaeojs-e10s', 19:05:09 INFO - 'system_bits': '32', 19:05:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:05:09 INFO - 'title': 'talos-linux64-ix-034', 19:05:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:05:09 INFO - 'use_talos_json': True, 19:05:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:05:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:05:09 INFO - 'work_dir': 'build'} 19:05:09 INFO - [mozharness: 2017-01-04 03:05:09.105969Z] Running clobber step. 19:05:09 INFO - Running pre-action listener: _resource_record_pre_action 19:05:09 INFO - Running main action method: clobber 19:05:09 INFO - rmtree: /builds/slave/test/build 19:05:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:05:10 INFO - Running post-action listener: _resource_record_post_action 19:05:10 INFO - [mozharness: 2017-01-04 03:05:10.096938Z] Finished clobber step (success) 19:05:10 INFO - [mozharness: 2017-01-04 03:05:10.097037Z] Running read-buildbot-config step. 19:05:10 INFO - Running pre-action listener: _resource_record_pre_action 19:05:10 INFO - Running main action method: read_buildbot_config 19:05:10 INFO - Using buildbot properties: 19:05:10 INFO - { 19:05:10 INFO - "project": "", 19:05:10 INFO - "product": "firefox", 19:05:10 INFO - "who": "philringnalda@gmail.com", 19:05:10 INFO - "installer_path": "public/build/target.tar.bz2", 19:05:10 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:05:10 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 19:05:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 19:05:10 INFO - "stage_platform": "linux64", 19:05:10 INFO - "basedir": "/builds/slave/test", 19:05:10 INFO - "buildnumber": 597, 19:05:10 INFO - "platform": "ubuntu64_hw", 19:05:10 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:05:10 INFO - "slavebuilddir": "test", 19:05:10 INFO - "taskId": "ToGNWloiRHOHwyMY9SwzGQ", 19:05:10 INFO - "branch": "mozilla-central", 19:05:10 INFO - "script_repo_revision": "production", 19:05:10 INFO - "revision": "9c825a25d288e346b46b1d306cc4d4ba4004ae40", 19:05:10 INFO - "slavename": "talos-linux64-ix-034", 19:05:10 INFO - "repo_path": "mozilla-central" 19:05:10 INFO - } 19:05:10 INFO - Finding installer, test and symbols from parent task. 19:05:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ToGNWloiRHOHwyMY9SwzGQ'}, attempt #1 19:05:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ToGNWloiRHOHwyMY9SwzGQ'}, attempt #1 19:05:11 INFO - Task dependencies: G6xocfjFQ8upFN4_wB7OlA 19:05:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G6xocfjFQ8upFN4_wB7OlA'}, attempt #1 19:05:11 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/G6xocfjFQ8upFN4_wB7OlA/artifacts/public/build/target.tar.bz2 19:05:11 INFO - Set test_url: https://queue.taskcluster.net/v1/task/G6xocfjFQ8upFN4_wB7OlA/artifacts/public/build/test_packages.json 19:05:11 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/G6xocfjFQ8upFN4_wB7OlA/artifacts/public/build/target.crashreporter-symbols.zip 19:05:11 INFO - Running post-action listener: _resource_record_post_action 19:05:11 INFO - [mozharness: 2017-01-04 03:05:11.485742Z] Finished read-buildbot-config step (success) 19:05:11 INFO - [mozharness: 2017-01-04 03:05:11.485959Z] Running download-and-extract step. 19:05:11 INFO - Running pre-action listener: _resource_record_pre_action 19:05:11 INFO - Running main action method: download_and_extract 19:05:11 INFO - mkdir: /builds/slave/test/build/tests 19:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:11 INFO - trying https://queue.taskcluster.net/v1/task/G6xocfjFQ8upFN4_wB7OlA/artifacts/public/build/target.test_packages.json 19:05:11 INFO - Downloading https://queue.taskcluster.net/v1/task/G6xocfjFQ8upFN4_wB7OlA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:05:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G6xocfjFQ8upFN4_wB7OlA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:05:12 INFO - Downloaded 896 bytes. 19:05:12 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:05:12 INFO - Using the following test package requirements: 19:05:12 INFO - {u'common': [u'target.common.tests.zip'], 19:05:12 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:05:12 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:05:12 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:05:12 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:05:12 INFO - u'mozbase': [u'target.common.tests.zip'], 19:05:12 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:05:12 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:05:12 INFO - u'web-platform': [u'target.common.tests.zip', 19:05:12 INFO - u'target.web-platform.tests.zip'], 19:05:12 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:05:12 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:05:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G6xocfjFQ8upFN4_wB7OlA/artifacts/public/build/target.common.tests.zip 19:05:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G6xocfjFQ8upFN4_wB7OlA/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:05:12 INFO - Fetch https://queue.taskcluster.net/v1/task/G6xocfjFQ8upFN4_wB7OlA/artifacts/public/build/target.common.tests.zip into memory 19:05:12 INFO - Expected file size: 20247084 19:05:12 INFO - Obtained file size: 20247084 19:05:16 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:05:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G6xocfjFQ8upFN4_wB7OlA/artifacts/public/build/target.common.tests.zip 19:05:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G6xocfjFQ8upFN4_wB7OlA/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:05:16 INFO - Fetch https://queue.taskcluster.net/v1/task/G6xocfjFQ8upFN4_wB7OlA/artifacts/public/build/target.common.tests.zip into memory 19:05:17 INFO - Expected file size: 20247084 19:05:17 INFO - Obtained file size: 20247084 19:05:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G6xocfjFQ8upFN4_wB7OlA/artifacts/public/build/target.talos.tests.zip 19:05:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G6xocfjFQ8upFN4_wB7OlA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:05:21 INFO - Fetch https://queue.taskcluster.net/v1/task/G6xocfjFQ8upFN4_wB7OlA/artifacts/public/build/target.talos.tests.zip into memory 19:05:22 INFO - Expected file size: 14409776 19:05:22 INFO - Obtained file size: 14409776 19:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:22 INFO - trying https://queue.taskcluster.net/v1/task/G6xocfjFQ8upFN4_wB7OlA/artifacts/public/build/target.tar.bz2 19:05:22 INFO - Downloading https://queue.taskcluster.net/v1/task/G6xocfjFQ8upFN4_wB7OlA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:05:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G6xocfjFQ8upFN4_wB7OlA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:05:24 INFO - Downloaded 55781945 bytes. 19:05:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G6xocfjFQ8upFN4_wB7OlA/artifacts/public/build/target.tar.bz2 19:05:24 INFO - mkdir: /builds/slave/test/properties 19:05:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:05:24 INFO - Writing to file /builds/slave/test/properties/build_url 19:05:24 INFO - Contents: 19:05:24 INFO - build_url:https://queue.taskcluster.net/v1/task/G6xocfjFQ8upFN4_wB7OlA/artifacts/public/build/target.tar.bz2 19:05:24 INFO - Running post-action listener: _resource_record_post_action 19:05:24 INFO - Running post-action listener: set_extra_try_arguments 19:05:24 INFO - [mozharness: 2017-01-04 03:05:24.132614Z] Finished download-and-extract step (success) 19:05:24 INFO - [mozharness: 2017-01-04 03:05:24.132711Z] Running populate-webroot step. 19:05:24 INFO - Running pre-action listener: _resource_record_pre_action 19:05:24 INFO - Running main action method: populate_webroot 19:05:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:05:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:05:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:05:24 INFO - '--tppagecycles', 19:05:24 INFO - '7'], 19:05:24 INFO - 'tests': ['tsvgm']}}, 19:05:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:05:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:05:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:05:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:05:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:05:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:05:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:05:24 INFO - 'talos_options': ['--disable-e10s'], 19:05:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:05:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:05:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:05:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:05:24 INFO - 'talos_options': ['--disable-e10s'], 19:05:24 INFO - 'tests': ['damp', 'tps']}, 19:05:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:05:24 INFO - 'tests': ['damp', 'tps']}, 19:05:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:05:24 INFO - 'tests': ['dromaeo_dom']}, 19:05:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:05:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:05:24 INFO - 'tests': ['basic_compositor_video']}, 19:05:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:05:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:05:24 INFO - 'tests': ['a11yr', 19:05:24 INFO - 'ts_paint', 19:05:24 INFO - 'tpaint', 19:05:24 INFO - 'sessionrestore', 19:05:24 INFO - 'sessionrestore_no_auto_restore', 19:05:24 INFO - 'tabpaint']}, 19:05:24 INFO - 'other-e10s': {'tests': ['a11yr', 19:05:24 INFO - 'ts_paint', 19:05:24 INFO - 'tpaint', 19:05:24 INFO - 'sessionrestore', 19:05:24 INFO - 'sessionrestore_no_auto_restore', 19:05:24 INFO - 'tabpaint']}, 19:05:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:05:24 INFO - 'ts_paint', 19:05:24 INFO - 'tpaint', 19:05:24 INFO - 'sessionrestore', 19:05:24 INFO - 'sessionrestore_no_auto_restore', 19:05:24 INFO - 'tabpaint']}, 19:05:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:05:24 INFO - 'ts_paint', 19:05:24 INFO - 'tpaint', 19:05:24 INFO - 'sessionrestore', 19:05:24 INFO - 'sessionrestore_no_auto_restore', 19:05:24 INFO - 'tabpaint']}, 19:05:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:05:24 INFO - 'tests': ['a11yr', 19:05:24 INFO - 'ts_paint', 19:05:24 INFO - 'tpaint', 19:05:24 INFO - 'sessionrestore', 19:05:24 INFO - 'sessionrestore_no_auto_restore', 19:05:24 INFO - 'tabpaint']}, 19:05:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:05:24 INFO - 'tests': ['a11yr', 19:05:24 INFO - 'ts_paint', 19:05:24 INFO - 'tpaint', 19:05:24 INFO - 'sessionrestore', 19:05:24 INFO - 'sessionrestore_no_auto_restore', 19:05:24 INFO - 'tabpaint']}, 19:05:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:05:24 INFO - 'tests': ['tsvgx', 19:05:24 INFO - 'tsvgr_opacity', 19:05:24 INFO - 'tart', 19:05:24 INFO - 'tscrollx', 19:05:24 INFO - 'cart', 19:05:24 INFO - 'tsvg_static']}, 19:05:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:05:24 INFO - 'tsvgr_opacity', 19:05:24 INFO - 'tart', 19:05:24 INFO - 'tscrollx', 19:05:24 INFO - 'cart', 19:05:24 INFO - 'tsvg_static']}, 19:05:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:05:24 INFO - 'talos_options': ['--disable-e10s'], 19:05:24 INFO - 'tests': ['tp5o']}, 19:05:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:05:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:05:24 INFO - 'talos_options': ['--disable-e10s', 19:05:24 INFO - '--xperf_path', 19:05:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:05:24 INFO - 'tests': ['tp5n']}, 19:05:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:05:24 INFO - 'talos_options': ['--xperf_path', 19:05:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:05:24 INFO - 'tests': ['tp5n']}}, 19:05:24 INFO - 'talos.zip': {'path': '', 19:05:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:05:24 INFO - Running post-action listener: _resource_record_post_action 19:05:24 INFO - [mozharness: 2017-01-04 03:05:24.145891Z] Finished populate-webroot step (success) 19:05:24 INFO - [mozharness: 2017-01-04 03:05:24.145981Z] Running create-virtualenv step. 19:05:24 INFO - Running pre-action listener: _resource_record_pre_action 19:05:24 INFO - Running main action method: create_virtualenv 19:05:24 INFO - Creating virtualenv /builds/slave/test/build/venv 19:05:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:05:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:05:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:05:24 INFO - Using real prefix '/usr' 19:05:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:05:24 INFO - Installing distribute.............................................................................................................................................................................................done. 19:05:26 INFO - Installing pip.................done. 19:05:26 INFO - Return code: 0 19:05:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:05:26 INFO - Reading from file tmpfile_stdout 19:05:26 INFO - Output received: 19:05:26 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 19:05:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:05: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')]} 19:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05: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')]} 19:05:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af6820>, '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 0x2af7520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af79b0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:05: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', 'pip>=1.5'] in /builds/slave/test/build 19:05: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 pip>=1.5 19:05:26 INFO - Using env: {'DISPLAY': ':0', 19:05:26 INFO - 'HOME': '/home/cltbld', 19:05:26 INFO - 'LANG': 'en_US.UTF-8', 19:05:26 INFO - 'LANGUAGE': 'en_US:en', 19:05:26 INFO - 'LOGNAME': 'cltbld', 19:05:26 INFO - 'MAIL': '/var/mail/cltbld', 19:05:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:26 INFO - 'MOZ_NO_REMOTE': '1', 19:05:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:26 INFO - 'NO_EM_RESTART': '1', 19:05:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:26 INFO - 'PWD': '/builds/slave/test', 19:05:26 INFO - 'SHELL': '/bin/bash', 19:05:26 INFO - 'SHLVL': '1', 19:05:26 INFO - 'TERM': 'linux', 19:05:26 INFO - 'TMOUT': '86400', 19:05:26 INFO - 'USER': 'cltbld', 19:05:26 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698', 19:05:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:26 INFO - '_': '/tools/buildbot/bin/python'} 19:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:05:27 INFO - Cleaning up... 19:05:27 INFO - Return code: 0 19:05:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:27 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 0x27871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af6820>, '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 0x2af7520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af79b0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:05:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:05:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:05:27 INFO - Using env: {'DISPLAY': ':0', 19:05:27 INFO - 'HOME': '/home/cltbld', 19:05:27 INFO - 'LANG': 'en_US.UTF-8', 19:05:27 INFO - 'LANGUAGE': 'en_US:en', 19:05:27 INFO - 'LOGNAME': 'cltbld', 19:05:27 INFO - 'MAIL': '/var/mail/cltbld', 19:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:27 INFO - 'MOZ_NO_REMOTE': '1', 19:05:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:27 INFO - 'NO_EM_RESTART': '1', 19:05:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:27 INFO - 'PWD': '/builds/slave/test', 19:05:27 INFO - 'SHELL': '/bin/bash', 19:05:27 INFO - 'SHLVL': '1', 19:05:27 INFO - 'TERM': 'linux', 19:05:27 INFO - 'TMOUT': '86400', 19:05:27 INFO - 'USER': 'cltbld', 19:05:27 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698', 19:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:27 INFO - '_': '/tools/buildbot/bin/python'} 19:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:27 INFO - Downloading/unpacking psutil>=3.1.1 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:05:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:05:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:05:29 INFO - Installing collected packages: psutil 19:05:29 INFO - Running setup.py install for psutil 19:05:29 INFO - building 'psutil._psutil_linux' extension 19:05:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:05:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:05:29 INFO - building 'psutil._psutil_posix' extension 19:05:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:05:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:05:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:05:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:05:29 INFO - Successfully installed psutil 19:05:29 INFO - Cleaning up... 19:05:30 INFO - Return code: 0 19:05:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:30 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 0x27871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af6820>, '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 0x2af7520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af79b0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:05:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:05:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:05:30 INFO - Using env: {'DISPLAY': ':0', 19:05:30 INFO - 'HOME': '/home/cltbld', 19:05:30 INFO - 'LANG': 'en_US.UTF-8', 19:05:30 INFO - 'LANGUAGE': 'en_US:en', 19:05:30 INFO - 'LOGNAME': 'cltbld', 19:05:30 INFO - 'MAIL': '/var/mail/cltbld', 19:05:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:30 INFO - 'MOZ_NO_REMOTE': '1', 19:05:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:30 INFO - 'NO_EM_RESTART': '1', 19:05:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:30 INFO - 'PWD': '/builds/slave/test', 19:05:30 INFO - 'SHELL': '/bin/bash', 19:05:30 INFO - 'SHLVL': '1', 19:05:30 INFO - 'TERM': 'linux', 19:05:30 INFO - 'TMOUT': '86400', 19:05:30 INFO - 'USER': 'cltbld', 19:05:30 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698', 19:05:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:30 INFO - '_': '/tools/buildbot/bin/python'} 19:05:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:05:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:05:32 INFO - Installing collected packages: mozsystemmonitor 19:05:32 INFO - Running setup.py install for mozsystemmonitor 19:05:32 INFO - Successfully installed mozsystemmonitor 19:05:32 INFO - Cleaning up... 19:05:32 INFO - Return code: 0 19:05:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:32 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 0x27871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af6820>, '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 0x2af7520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af79b0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:05:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:05:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:05:32 INFO - Using env: {'DISPLAY': ':0', 19:05:32 INFO - 'HOME': '/home/cltbld', 19:05:32 INFO - 'LANG': 'en_US.UTF-8', 19:05:32 INFO - 'LANGUAGE': 'en_US:en', 19:05:32 INFO - 'LOGNAME': 'cltbld', 19:05:32 INFO - 'MAIL': '/var/mail/cltbld', 19:05:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:32 INFO - 'MOZ_NO_REMOTE': '1', 19:05:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:32 INFO - 'NO_EM_RESTART': '1', 19:05:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:32 INFO - 'PWD': '/builds/slave/test', 19:05:32 INFO - 'SHELL': '/bin/bash', 19:05:32 INFO - 'SHLVL': '1', 19:05:32 INFO - 'TERM': 'linux', 19:05:32 INFO - 'TMOUT': '86400', 19:05:32 INFO - 'USER': 'cltbld', 19:05:32 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698', 19:05:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:32 INFO - '_': '/tools/buildbot/bin/python'} 19:05:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:32 INFO - Downloading/unpacking jsonschema==2.5.1 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:05:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:34 INFO - Downloading functools32-3.2.3-2.tar.gz 19:05:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:05:34 INFO - warning: no files found matching '*.txt' 19:05:34 INFO - no previously-included directories found matching 'build' 19:05:34 INFO - no previously-included directories found matching 'dist' 19:05:34 INFO - no previously-included directories found matching '.git*' 19:05:34 INFO - Installing collected packages: jsonschema, functools32 19:05:34 INFO - Running setup.py install for functools32 19:05:35 INFO - warning: no files found matching '*.txt' 19:05:35 INFO - no previously-included directories found matching 'build' 19:05:35 INFO - no previously-included directories found matching 'dist' 19:05:35 INFO - no previously-included directories found matching '.git*' 19:05:35 INFO - Successfully installed jsonschema functools32 19:05:35 INFO - Cleaning up... 19:05:35 INFO - Return code: 0 19:05:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:35 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 0x27871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af6820>, '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 0x2af7520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af79b0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:05:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:05:35 INFO - Using env: {'DISPLAY': ':0', 19:05:35 INFO - 'HOME': '/home/cltbld', 19:05:35 INFO - 'LANG': 'en_US.UTF-8', 19:05:35 INFO - 'LANGUAGE': 'en_US:en', 19:05:35 INFO - 'LOGNAME': 'cltbld', 19:05:35 INFO - 'MAIL': '/var/mail/cltbld', 19:05:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:35 INFO - 'MOZ_NO_REMOTE': '1', 19:05:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:35 INFO - 'NO_EM_RESTART': '1', 19:05:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:35 INFO - 'PWD': '/builds/slave/test', 19:05:35 INFO - 'SHELL': '/bin/bash', 19:05:35 INFO - 'SHLVL': '1', 19:05:35 INFO - 'TERM': 'linux', 19:05:35 INFO - 'TMOUT': '86400', 19:05:35 INFO - 'USER': 'cltbld', 19:05:35 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698', 19:05:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:35 INFO - '_': '/tools/buildbot/bin/python'} 19:05:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:05:35 INFO - Cleaning up... 19:05:35 INFO - Return code: 0 19:05:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:35 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 0x27871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af6820>, '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 0x2af7520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af79b0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:05:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:05:35 INFO - Using env: {'DISPLAY': ':0', 19:05:35 INFO - 'HOME': '/home/cltbld', 19:05:35 INFO - 'LANG': 'en_US.UTF-8', 19:05:35 INFO - 'LANGUAGE': 'en_US:en', 19:05:35 INFO - 'LOGNAME': 'cltbld', 19:05:35 INFO - 'MAIL': '/var/mail/cltbld', 19:05:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:35 INFO - 'MOZ_NO_REMOTE': '1', 19:05:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:35 INFO - 'NO_EM_RESTART': '1', 19:05:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:35 INFO - 'PWD': '/builds/slave/test', 19:05:35 INFO - 'SHELL': '/bin/bash', 19:05:35 INFO - 'SHLVL': '1', 19:05:35 INFO - 'TERM': 'linux', 19:05:35 INFO - 'TMOUT': '86400', 19:05:35 INFO - 'USER': 'cltbld', 19:05:35 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698', 19:05:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:35 INFO - '_': '/tools/buildbot/bin/python'} 19:05:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:35 INFO - Downloading/unpacking blobuploader==1.2.4 19:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:37 INFO - Downloading blobuploader-1.2.4.tar.gz 19:05:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:05:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:05:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05:38 INFO - Downloading docopt-0.6.1.tar.gz 19:05:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:05:38 INFO - Installing collected packages: blobuploader, requests, docopt 19:05:38 INFO - Running setup.py install for blobuploader 19:05:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:05:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:05:38 INFO - Running setup.py install for requests 19:05:38 INFO - Running setup.py install for docopt 19:05:38 INFO - Successfully installed blobuploader requests docopt 19:05:38 INFO - Cleaning up... 19:05:38 INFO - Return code: 0 19:05:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:39 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 0x27871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af6820>, '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 0x2af7520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af79b0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:05:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:05:39 INFO - Using env: {'DISPLAY': ':0', 19:05:39 INFO - 'HOME': '/home/cltbld', 19:05:39 INFO - 'LANG': 'en_US.UTF-8', 19:05:39 INFO - 'LANGUAGE': 'en_US:en', 19:05:39 INFO - 'LOGNAME': 'cltbld', 19:05:39 INFO - 'MAIL': '/var/mail/cltbld', 19:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:39 INFO - 'MOZ_NO_REMOTE': '1', 19:05:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:39 INFO - 'NO_EM_RESTART': '1', 19:05:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:39 INFO - 'PWD': '/builds/slave/test', 19:05:39 INFO - 'SHELL': '/bin/bash', 19:05:39 INFO - 'SHLVL': '1', 19:05:39 INFO - 'TERM': 'linux', 19:05:39 INFO - 'TMOUT': '86400', 19:05:39 INFO - 'USER': 'cltbld', 19:05:39 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698', 19:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:39 INFO - '_': '/tools/buildbot/bin/python'} 19:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:05:39 INFO - Running setup.py (path:/tmp/pip-oUf99q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:05:39 INFO - Running setup.py (path:/tmp/pip-g68ldH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:05:39 INFO - Running setup.py (path:/tmp/pip-EeBlUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:05:39 INFO - Running setup.py (path:/tmp/pip-cvRokL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:05:39 INFO - Running setup.py (path:/tmp/pip-U9JDkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:05:39 INFO - Running setup.py (path:/tmp/pip-WAFlLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:05:39 INFO - Running setup.py (path:/tmp/pip-pDdWqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:05:39 INFO - Running setup.py (path:/tmp/pip-ustBlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:05:39 INFO - Running setup.py (path:/tmp/pip-H8Hy5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:05:39 INFO - Running setup.py (path:/tmp/pip-JmRbDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:05:39 INFO - Running setup.py (path:/tmp/pip-B4PSZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:05:40 INFO - Running setup.py (path:/tmp/pip-aYeDwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:05:40 INFO - Running setup.py (path:/tmp/pip-GmN8iy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:05:40 INFO - Running setup.py (path:/tmp/pip-Mstz6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:40 INFO - Running setup.py (path:/tmp/pip-do9IzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:05:40 INFO - Running setup.py (path:/tmp/pip-HnX7aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:05:40 INFO - Running setup.py (path:/tmp/pip-z19sw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:05:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:05:40 INFO - Running setup.py install for manifestparser 19:05:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:05:40 INFO - Running setup.py install for mozcrash 19:05:40 INFO - Running setup.py install for mozdebug 19:05:40 INFO - Running setup.py install for mozdevice 19:05:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:05:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:05:40 INFO - Running setup.py install for mozfile 19:05:40 INFO - Running setup.py install for mozhttpd 19:05:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:05:41 INFO - Running setup.py install for mozinfo 19:05:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:05:41 INFO - Running setup.py install for mozInstall 19:05:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:05:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:05:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:05:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:05:41 INFO - Running setup.py install for mozleak 19:05:41 INFO - Running setup.py install for mozlog 19:05:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:05:41 INFO - Running setup.py install for moznetwork 19:05:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:05:41 INFO - Running setup.py install for mozprocess 19:05:41 INFO - Running setup.py install for mozprofile 19:05:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:05:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:05:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:05:41 INFO - Running setup.py install for mozrunner 19:05:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:05:41 INFO - Running setup.py install for mozscreenshot 19:05:42 INFO - Running setup.py install for moztest 19:05:42 INFO - Running setup.py install for mozversion 19:05:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:05:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:05:42 INFO - Cleaning up... 19:05:42 INFO - Return code: 0 19:05:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:42 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 0x27871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af6820>, '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 0x2af7520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af79b0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:05:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:05:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:05:42 INFO - Using env: {'DISPLAY': ':0', 19:05:42 INFO - 'HOME': '/home/cltbld', 19:05:42 INFO - 'LANG': 'en_US.UTF-8', 19:05:42 INFO - 'LANGUAGE': 'en_US:en', 19:05:42 INFO - 'LOGNAME': 'cltbld', 19:05:42 INFO - 'MAIL': '/var/mail/cltbld', 19:05:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:42 INFO - 'MOZ_NO_REMOTE': '1', 19:05:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:42 INFO - 'NO_EM_RESTART': '1', 19:05:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:42 INFO - 'PWD': '/builds/slave/test', 19:05:42 INFO - 'SHELL': '/bin/bash', 19:05:42 INFO - 'SHLVL': '1', 19:05:42 INFO - 'TERM': 'linux', 19:05:42 INFO - 'TMOUT': '86400', 19:05:42 INFO - 'USER': 'cltbld', 19:05:42 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698', 19:05:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:42 INFO - '_': '/tools/buildbot/bin/python'} 19:05:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:05:42 INFO - Running setup.py (path:/tmp/pip-7ks7vF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:05:42 INFO - Running setup.py (path:/tmp/pip-ja2gW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:05:42 INFO - Running setup.py (path:/tmp/pip-bmUsO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:05:42 INFO - Running setup.py (path:/tmp/pip-AjryRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:05:42 INFO - Running setup.py (path:/tmp/pip-zJjm4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:05:42 INFO - Running setup.py (path:/tmp/pip-H2EH0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:05:42 INFO - Running setup.py (path:/tmp/pip-fSPhSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:05:43 INFO - Running setup.py (path:/tmp/pip-rhYEzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:05:43 INFO - Running setup.py (path:/tmp/pip-ssQS1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:05:43 INFO - Running setup.py (path:/tmp/pip-0ytfHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:05:43 INFO - Running setup.py (path:/tmp/pip-fCUEjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:05:43 INFO - Running setup.py (path:/tmp/pip-NHaGAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:05:43 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)) 19:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:05:43 INFO - Running setup.py (path:/tmp/pip-0utfes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:05:43 INFO - Running setup.py (path:/tmp/pip-Y5GNvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:43 INFO - Running setup.py (path:/tmp/pip-qIW1Bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:05:43 INFO - Running setup.py (path:/tmp/pip-S9sXEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:05:43 INFO - Running setup.py (path:/tmp/pip-LEW13U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:05:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:45 INFO - Downloading blessings-1.6.tar.gz 19:05:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:05:45 INFO - Installing collected packages: blessings 19:05:45 INFO - Running setup.py install for blessings 19:05:45 INFO - Successfully installed blessings 19:05:45 INFO - Cleaning up... 19:05:46 INFO - Return code: 0 19:05:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:05:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:05:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:05:46 INFO - Reading from file tmpfile_stdout 19:05:46 INFO - Current package versions: 19:05:46 INFO - argparse == 1.2.1 19:05:46 INFO - blessings == 1.6 19:05:46 INFO - blobuploader == 1.2.4 19:05:46 INFO - docopt == 0.6.1 19:05:46 INFO - functools32 == 3.2.3-2 19:05:46 INFO - jsonschema == 2.5.1 19:05:46 INFO - manifestparser == 1.1 19:05:46 INFO - mozInstall == 1.12 19:05:46 INFO - mozcrash == 1.0 19:05:46 INFO - mozdebug == 0.1 19:05:46 INFO - mozdevice == 0.49 19:05:46 INFO - mozfile == 1.2 19:05:46 INFO - mozhttpd == 0.7 19:05:46 INFO - mozinfo == 0.9 19:05:46 INFO - mozleak == 0.1 19:05:46 INFO - mozlog == 3.4 19:05:46 INFO - moznetwork == 0.27 19:05:46 INFO - mozprocess == 0.23 19:05:46 INFO - mozprofile == 0.28 19:05:46 INFO - mozrunner == 6.13 19:05:46 INFO - mozscreenshot == 0.1 19:05:46 INFO - mozsystemmonitor == 0.3 19:05:46 INFO - moztest == 0.8 19:05:46 INFO - mozversion == 1.4 19:05:46 INFO - psutil == 3.1.1 19:05:46 INFO - requests == 1.2.3 19:05:46 INFO - wsgiref == 0.1.2 19:05:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:46 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 0x27871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af6820>, '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 0x2af7520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af79b0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:05:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:05:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:05:46 INFO - Using env: {'DISPLAY': ':0', 19:05:46 INFO - 'HOME': '/home/cltbld', 19:05:46 INFO - 'LANG': 'en_US.UTF-8', 19:05:46 INFO - 'LANGUAGE': 'en_US:en', 19:05:46 INFO - 'LOGNAME': 'cltbld', 19:05:46 INFO - 'MAIL': '/var/mail/cltbld', 19:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:46 INFO - 'MOZ_NO_REMOTE': '1', 19:05:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:46 INFO - 'NO_EM_RESTART': '1', 19:05:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:46 INFO - 'PWD': '/builds/slave/test', 19:05:46 INFO - 'SHELL': '/bin/bash', 19:05:46 INFO - 'SHLVL': '1', 19:05:46 INFO - 'TERM': 'linux', 19:05:46 INFO - 'TMOUT': '86400', 19:05:46 INFO - 'USER': 'cltbld', 19:05:46 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698', 19:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:46 INFO - '_': '/tools/buildbot/bin/python'} 19:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:05:46 INFO - Cleaning up... 19:05:46 INFO - Return code: 0 19:05:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:46 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 0x27871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af6820>, '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 0x2af7520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af79b0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:05:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:05:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:05:46 INFO - Using env: {'DISPLAY': ':0', 19:05:46 INFO - 'HOME': '/home/cltbld', 19:05:46 INFO - 'LANG': 'en_US.UTF-8', 19:05:46 INFO - 'LANGUAGE': 'en_US:en', 19:05:46 INFO - 'LOGNAME': 'cltbld', 19:05:46 INFO - 'MAIL': '/var/mail/cltbld', 19:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:46 INFO - 'MOZ_NO_REMOTE': '1', 19:05:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:46 INFO - 'NO_EM_RESTART': '1', 19:05:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:46 INFO - 'PWD': '/builds/slave/test', 19:05:46 INFO - 'SHELL': '/bin/bash', 19:05:46 INFO - 'SHLVL': '1', 19:05:46 INFO - 'TERM': 'linux', 19:05:46 INFO - 'TMOUT': '86400', 19:05:46 INFO - 'USER': 'cltbld', 19:05:46 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698', 19:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:46 INFO - '_': '/tools/buildbot/bin/python'} 19:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:05:46 INFO - Cleaning up... 19:05:46 INFO - Return code: 0 19:05:46 INFO - Running post-action listener: _resource_record_post_action 19:05:46 INFO - Running post-action listener: _start_resource_monitoring 19:05:46 INFO - Starting resource monitoring. 19:05:46 INFO - [mozharness: 2017-01-04 03:05:46.723092Z] Finished create-virtualenv step (success) 19:05:46 INFO - [mozharness: 2017-01-04 03:05:46.723556Z] Running install step. 19:05:46 INFO - Running pre-action listener: _resource_record_pre_action 19:05:46 INFO - Running main action method: install 19:05:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:05:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:05:46 INFO - Reading from file tmpfile_stdout 19:05:46 INFO - Detecting whether we're running mozinstall >=1.0... 19:05:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:05:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:05:47 INFO - Reading from file tmpfile_stdout 19:05:47 INFO - Output received: 19:05:47 INFO - Usage: mozinstall [options] installer 19:05:47 INFO - Options: 19:05:47 INFO - -h, --help show this help message and exit 19:05:47 INFO - -d DEST, --destination=DEST 19:05:47 INFO - Directory to install application into. [default: 19:05:47 INFO - "/builds/slave/test"] 19:05:47 INFO - --app=APP Application being installed. [default: firefox] 19:05:47 INFO - mkdir: /builds/slave/test/build/application 19:05:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:05:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:06:03 INFO - Reading from file tmpfile_stdout 19:06:03 INFO - Output received: 19:06:03 INFO - /builds/slave/test/build/application/firefox/firefox 19:06:03 INFO - Running post-action listener: _resource_record_post_action 19:06:03 INFO - [mozharness: 2017-01-04 03:06:03.611630Z] Finished install step (success) 19:06:03 INFO - [mozharness: 2017-01-04 03:06:03.611878Z] Running run-tests step. 19:06:03 INFO - Running pre-action listener: _resource_record_pre_action 19:06:03 INFO - Running main action method: run_tests 19:06:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:06:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:06:03 INFO - Python 2.7.3 19:06:03 INFO - Return code: 0 19:06:03 INFO - grabbing minidump binary from tooltool 19:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:03 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 0x2af6820>, '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 0x2af7520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af79b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:06:03 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:06:03 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:06:03 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:06:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:06:03 INFO - Return code: 0 19:06:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:06:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:06:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:06:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:06:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:06:03 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/G6xocfjFQ8upFN4_wB7OlA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 19:06:03 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/G6xocfjFQ8upFN4_wB7OlA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 19:06:03 INFO - Using env: {'DISPLAY': ':0', 19:06:03 INFO - 'HOME': '/home/cltbld', 19:06:03 INFO - 'LANG': 'en_US.UTF-8', 19:06:03 INFO - 'LANGUAGE': 'en_US:en', 19:06:03 INFO - 'LOGNAME': 'cltbld', 19:06:03 INFO - 'MAIL': '/var/mail/cltbld', 19:06:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:06:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:03 INFO - 'MOZ_NO_REMOTE': '1', 19:06:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:03 INFO - 'NO_EM_RESTART': '1', 19:06:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:03 INFO - 'PWD': '/builds/slave/test', 19:06:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:06:03 INFO - 'SHELL': '/bin/bash', 19:06:03 INFO - 'SHLVL': '1', 19:06:03 INFO - 'TERM': 'linux', 19:06:03 INFO - 'TMOUT': '86400', 19:06:03 INFO - 'USER': 'cltbld', 19:06:03 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698', 19:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:03 INFO - '_': '/tools/buildbot/bin/python'} 19:06:03 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/G6xocfjFQ8upFN4_wB7OlA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 19:06:03 INFO - mozversion application_buildid: 20170104023247 19:06:03 INFO - mozversion application_changeset: 9c825a25d288e346b46b1d306cc4d4ba4004ae40 19:06:03 INFO - mozversion application_display_name: Nightly 19:06:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:06:03 INFO - mozversion application_name: Firefox 19:06:03 INFO - mozversion application_remotingname: firefox 19:06:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:06:03 INFO - mozversion application_vendor: Mozilla 19:06:03 INFO - mozversion application_version: 53.0a1 19:06:03 INFO - mozversion platform_buildid: 20170104023247 19:06:03 INFO - mozversion platform_changeset: 9c825a25d288e346b46b1d306cc4d4ba4004ae40 19:06:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:06:03 INFO - mozversion platform_version: 53.0a1 19:06:03 INFO - using testdate: 1483499163 19:06:03 INFO - actual date: 1483499163 19:06:03 INFO - starting webserver on 'localhost:53309' 19:06:03 INFO - SUITE-START | Running 2 tests 19:06:03 INFO - TEST-START | dromaeo_css 19:06:03 INFO - operating with platform_type : linux_ 19:06:03 INFO - Initialising browser for dromaeo_css test... 19:06:03 INFO - TEST-INFO | started process 28302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNFbBRH/profile http://localhost:53309/getInfo.html) 19:06:04 INFO - PROCESS | 28302 | 1483499164402 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:4901 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3756 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2789 < callProvider()@resource://gre/modules/AddonManager.jsm:260 < _startProvider()@resource://gre/modules/AddonManager.jsm:755 < startup()@resource://gre/modules/AddonManager.jsm:937 < startup()@resource://gre/modules/AddonManager.jsm:2886 < observe()@resource://gre/components/addonManager.js:65 19:06:08 INFO - PROCESS | 28302 | __metrics Screen width/height:1600/1200 19:06:08 INFO - PROCESS | 28302 | colorDepth:24 19:06:08 INFO - PROCESS | 28302 | Browser inner width/height: 1024/697 19:06:08 INFO - PROCESS | 28302 | __metrics 19:06:08 ERROR - PROCESS | 28302 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 19:06:09 INFO - TEST-INFO | 28302: exit 0 19:06:09 INFO - Browser initialized. 19:06:09 INFO - Running cycle 1/1 for dromaeo_css test... 19:06:09 INFO - TEST-INFO | started process 28424 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNFbBRH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:06:21 INFO - PROCESS | 28424 | RSS: Main: 157851648 19:06:21 INFO - PROCESS | 28424 | 19:07:11 INFO - PROCESS | 28424 | 1483499231525 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] 19:09:25 INFO - PROCESS | 28424 | Cycle 1(1): loaded http://localhost:53309/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53309/tests/dromaeo/cssquery-ext.html) 19:09:26 INFO - PROCESS | 28424 | RSS: Main: 165879808 19:09:26 INFO - PROCESS | 28424 | 19:11:10 INFO - PROCESS | 28424 | ************************* 19:11:10 INFO - PROCESS | 28424 | A coding exception was thrown and uncaught in a Task. 19:11:10 INFO - PROCESS | 28424 | 19:11:10 INFO - PROCESS | 28424 | Full message: ReferenceError: fetch is not defined 19:11:10 INFO - PROCESS | 28424 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 19:11:10 INFO - PROCESS | 28424 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 19:11:10 INFO - PROCESS | 28424 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 19:11:10 INFO - PROCESS | 28424 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 19:11:10 INFO - PROCESS | 28424 | TaskImpl@resource://gre/modules/Task.jsm:277:3 19:11:10 INFO - PROCESS | 28424 | asyncFunction@resource://gre/modules/Task.jsm:252:14 19:11:10 INFO - PROCESS | 28424 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 19:11:10 INFO - PROCESS | 28424 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 19:11:10 INFO - PROCESS | 28424 | TaskImpl@resource://gre/modules/Task.jsm:277:3 19:11:10 INFO - PROCESS | 28424 | asyncFunction@resource://gre/modules/Task.jsm:252:14 19:11:10 INFO - PROCESS | 28424 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 19:11:10 INFO - PROCESS | 28424 | 19:11:10 INFO - PROCESS | 28424 | ************************* 19:12:29 INFO - PROCESS | 28424 | Cycle 1(1): loaded http://localhost:53309/tests/dromaeo/cssquery-ext.html (next: http://localhost:53309/tests/dromaeo/cssquery-jquery.html) 19:12:29 INFO - PROCESS | 28424 | RSS: Main: 162238464 19:12:29 INFO - PROCESS | 28424 | 19:15:32 INFO - PROCESS | 28424 | Cycle 1(1): loaded http://localhost:53309/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53309/tests/dromaeo/cssquery-mootools.html) 19:15:32 INFO - PROCESS | 28424 | RSS: Main: 167497728 19:15:32 INFO - PROCESS | 28424 | 19:18:34 INFO - PROCESS | 28424 | Cycle 1(1): loaded http://localhost:53309/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53309/tests/dromaeo/cssquery-prototype.html) 19:18:35 INFO - PROCESS | 28424 | RSS: Main: 162869248 19:18:35 INFO - PROCESS | 28424 | 19:21:38 INFO - PROCESS | 28424 | Cycle 1(1): loaded http://localhost:53309/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53309/tests/dromaeo/cssquery-yui.html) 19:21:39 INFO - PROCESS | 28424 | RSS: Main: 165728256 19:21:39 INFO - PROCESS | 28424 | 19:24:41 INFO - PROCESS | 28424 | Cycle 1(1): loaded http://localhost:53309/tests/dromaeo/cssquery-yui.html (next: http://localhost:53309/tests/dromaeo/cssquery-dojo.html) 19:24:42 INFO - PROCESS | 28424 | RSS: Main: 166273024 19:24:42 INFO - PROCESS | 28424 | 19:24:42 INFO - PROCESS | 28424 | __start_tp_report 19:24:42 INFO - PROCESS | 28424 | _x_x_mozilla_page_load 19:24:42 INFO - PROCESS | 28424 | _x_x_mozilla_page_load_details 19:24:42 INFO - PROCESS | 28424 | |i|pagename|runs| 19:24:42 INFO - PROCESS | 28424 | |0;dojo.html;2586;2591.119019533359;2591.961120583193;2624.396388830569;2626.277773612256;4786.468330134358;4832.395950506191;4833.589144922686;4862.708237505748;4864.440589332224;4815.398075240595;4825.396825396825;4857.368542089533;4858.36841210643;4952.306677065214;4421.182081314951;4433.911321773563;4468.75421851798;4558;4580.97709511452;4150.564190759972;4590.655700822452;4595.977020114895;4615.930761038587;4616.515265897083;4418.734875907456;4517.435320584927;4527.185106680829;4560.247559152735;4616.792244348995;4425.778711064434;4438.644908407352;4454.621357184611;4496.910061798779;4573.062522182944;4486.1027794440915;4486.573775491323;4491.708038977456;4495.64034877209;4515.571020753023;4822.397200349957;4823.758812059418;4834.734089625069;4878.829240976549;4881.731504767236;5043.092243396187;5100.719460429675;5152.6650767699975;5172.5344718975475;5186.377634683824;5248.265242866002;5253.973730131325;5257.7108259045735;5271.446498117719;5306.946930530684;4864.635152363587;4893.975530122327;4896.265560165933;4907.754612269444;4943.307936888838;5186.118359878829;5220.895582088337;5248.002879452968;5288.735563221823;5373.838784836461;4998.075356059141;5047.318611987408;5076.060928728197;5100;5100.48995100487;5070.594352451795;5170.40540337866;5184.818531351385;5222.112240919053;5226.97386513065;5057.468965758616;5068.087744206078;5153.6907785532985;5206.713630750345;5211.8175863845345;5201.3238279024245;5212.113940630102;5230.137027390514;5236.528712415901;5265.236540701577;4072.144849581621;4098.7950602469755;4112.115895082572;4136.793160341971;4181.581841815855;3628.618995005539;3640.8725694601094;3654.5979942206336;3660.9816950915074;3663.816809159531;4475.4181956345465;4478.753668548261;4489.147062058199;4497.550244975476;4521;5103.770330335144;5149.510796474329;5235.973820130951;5241.449647787003;5267.078261304257;4396.890077748082;4418.2047231498;4420.138073075784;4438.866833994985;4441.955580444219;4608.815647374135;4609.907801843944;4623;4628.467726211529;4656.138614356287;4741.9051618968115;4836.588889944253;4840.185373033426;4845.152098382699;4893.584045356185;5132.358455193101;5132.769025393792;5153.433122356612;5176.534111929945;5234.7906083756225;4824.155772739827;4835.975820120877;4836.46798852133;4839.361335986957;4883.487233840538;5096.566791822736;5109.64232503736;5114.641975061859;5115.283860259492;5166;5065.772040258271;5107.872303192301;5112.872178195575;5124.923126153185;5171.793128274978;4984.22744474607;4991.975040124921;5006.62450316235;5009.4489606144025;5040.823571174991;4891.364122664031;4950.777215025405;4999;5011.398632164163;5043.167877300204;4827.8551643450755;4884.682495637772;4918.95081049185;4933.703977761345;4983;5011.072951503984;5016.247562865599;5021.171506701354;5028.220625803006;5061.569766569735;4833.806647734052;4865.343178670976;4902.240152776325;4934.777934993006;4965.155923492943 19:24:42 INFO - PROCESS | 28424 | |1;ext.html;509.20055512844823;510.10476613543227;518.5644058990447;523.7486006716775;527.6570229350922;37003.4449483258;38133.04667383313;38250.8087459563;38299.61700382995;41575;38425;38950.80524597373;39004;39026;39136.21727565447;7636.809079773008;7786.493877897947;7791.065072191345;9494.145526902577;9814.90185098147;9609.423434593911;9742;9744.707658770212;9766.316357854954;9825.557849896735;9848.458334791583;9870.161036311922;9899.356541824794;9910.108090271875;9910.207183425344;9699.369540979813;9699.418034917928;9736.075072868067;9757.560909759042;9758.756031099208;9544.236461083166;9630.229581633452;9638.75903102421;9682.56428460721;9684.51577421126;33507.6649233507;33829.323413531594;33862.49206261908;33989.49015764741;34007.829960850286;3528.417811061172;3655.6161603031564;3662.9450558241647;3683.244934788389;3684.9631503684886;25860.612090818653;26099.217023489327;26104.477910441685;26417.603735943783;27124.457510849672;3312.668733126692;3533.522974398449;3555.093451169961;3567.340042092221;3589.73077019222;238692;239898;239898;240193;240251;44586.77706611446;44643.3124521927;44741.77629111834;44874.551254487036;45069;47112.29331560029;47192.7640361796;47305.76347118311;47427.762861185474;47457.28814067792;11532.88467115335;11843;11879.287242765462;11897;11903.464344104535;7936.722214722457;8196.5491897945;8998.86501702475;9318.347715659975;9402.247820174369;14997.925010375096;15111.244437778067;15111.924440377948;15186.696266074616;15264.542063738105;5976.880462390728;6578.703958321887;6613.537052406382;6646.235682896432;6687.331266873371;782.9491083079581;791.5606838204851;822.4037572759702;833.5248908122434;833.6998680475024;26825.597616035775;27072.59391109135;27261.727382726316;27336.863315683295;27436.862815686192;926.3284119013662;928.331601247101;939.8402271613842;946.6402766948653;947.7298969793713;14467.49363772263;14480.203588802717;14538.927305363406;14570.344334504973;14622.341994610268;334587;336374;337272;338177;338405;47638;48291.275630865566;48329;48368.75815620899;48371.27443088357;1153.4866984191954;1191.7795207886568;1197.2098415046203;1207.3842340406457;1208.275034979023;24707.25878223656;25571.744282556938;26427.339316517242;26538.734612653625;26727.465450690488;40201.597984020955;40265.194696105325;40573.1885362297;40625.1874962505;40694.25073609188;282019;282367;283264;283625;284363;22012.339629811133;23077.53844923126;23079.653805193273;24133;24547;35621;35649.28701425905;35652.28695426129;36168.457473137394;36421.635783641825;30790.53814192744;30984.53523197199;31164;31251.37497250088;31677.524837127923;30013.3997320048;31028.379432411675;31709.207269817518;31771.682283177797;31844;32673.18317042093;33284;33414.33171336511;33494.66505335013;33578.66421335755;25450.236492905242;27230.455390892468;28812.711872881002;28915.56626650644;29090.854545727136;22642.320730378116;22897.198598048988;22916.3970170953;23063.423414414774;23193.304200874 19:24:42 INFO - PROCESS | 28424 | |2;jquery.html;365.51751687772145;366.92661467706455;372.1607774468573;376.0823590439328;388.06089263981164;15197.316120774563;16099.275532601047;16647.999999999985;16824.411145609905;16828.74756878648;16113.91943040286;16222.7566586501;16474;16497;16691.49925502237;4781.306710526971;5029.7736601853;5044.899102017957;5047.64666473347;5059.089363914494;3867.4972253606993;4054.8378064877515;4936.3829521309835;5538.6399884007415;5769.394213607574;5928.051511758098;5933.910991335133;5934.080217566284;5939;5953.613015154023;5702.173184888189;5795.4784069433745;5814.680192589406;5861.794837180678;5862.384449632812;5059.988002399498;5102.081625307444;5119.59043276537;5119.769610367543;5126.103341763534;19742.50643733918;19785.406437806745;19889.403317900487;19921.203151873906;20052.598948021103;2472.4807790364043;2513.497300539881;2574.858382788946;2596;2599.363156026767;12270.877291227152;12338.383080846012;12566.120371573994;12591.307478088702;12801.423935922812;1695.262560786062;1728.7320465327894;1736.9131543422905;1744.310997156129;1757.7275522294065;61781.07328390123;62133.689331553505;62350.68824655893;62395.688021560054;62944.370556294765;9312.161905428544;9346.626134954662;9462.43225406464;9480.620775169054;9631.08504692053;12877.4205160768;12880.613581592566;12880.742385152245;12901.419436125398;13030.478780848849;6672.799816005528;6761.22245941723;6955.269696681877;7021.824454388579;7041.612711300825;6246.15676883624;6445.097686323918;6551.901721474182;6601.933980660228;6621.86756264872;5742.569307301969;5857.47282744555;5881.235439392937;5901.29184497863;6024.608400453956;1535.6084198529304;1594.2028985507247;1607.3490236454254;1655.3709590355588;1715.9742603860952;809.0695699944993;815.2906970935325;817.1256755271921;820.979475513117;838.6854929401475;16037.278322475517;16140.35438582467;16342.428015019656;16360.181990900408;16487.093209873332;828.7886588919787;829.3779665251062;831.5800520736989;835.1648351648352;848.9617967191491;9428.669996550088;9489.145976862115;9548.522573871278;9606.66376676813;9723.805523889483;302384;307579;310295;310631;311668;57811.421885780604;59617.105743413886;59962;60256.39743602595;60446.697766510886;876.4741155306765;882.4264228251687;911.4485736129546;911.8814554107923;915.9313051521162;14345.211013394364;14408.495702650356;14437.06159099655;14718.190499522201;15203.847961520243;31442.685573143975;31918.36163276768;32519.51220731738;34039;36813.26373472569;45919.31121033254;46847;47067;47128.52871471241;47404;6766.2218844831505;7523.608132495506;7623.9618801905635;7722.768316950501;7946.125926148004;8304.418690691835;8602.932387744351;11437.656870293904;11533.308001519936;11604.47779849892;9108.908910911072;9983.400995940267;10378.948105259426;10490.265681402534;10530.526126324181;5024.221245706921;8195.34437245007;8345.54099524532;10030.64892728751;10465.319754215952;9575.377600455948;9738;9752.317337786288;9837.458939758382;10223.897761022294;6627.105340778933;6755.966220168868;6939.201991771011;7194.525122349801;7396.667149978156;8944.329175312008;10588.629397971034;10676.359418434919;10913.18151138652;11108.389038602954 19:24:42 INFO - PROCESS | 28424 | |3;mootools.html;1282.1345591725583;1290.8580056193823;1292.7931530955047;1296.7989961555957;1303.2571434282456;6633.800985970416;6814.761483348084;7037.683304251308;7455.776326710201;7506.924930750698;7021.262767409412;7253.854922901539;7264.273572642746;7330.523515971458;7430.368418684405;2150.0432307623155;2186.3440967709703;2187.8796666183352;2188.9233876814314;2195.560887822434;2115.227941801239;2145.0454547726267;2159.8272138228904;2174.8042676159143;2238.6418173092306;2183.170395249803;2198.736151661803;2199.351191398533;2213.2806837777707;2215.8892055397246;2080.2719048333115;2104.074207348762;2113.228671534894;2116.291042500764;2118.0892216346965;2123.0870725587993;2139.5934772393352;2156.2345367394664;2165.220520612578;2171.6633921742155;7387.85224295511;7431.888521672179;7512.699492020312;7550.282723141293;7551.282628150317;4470.463544374696;4609.308603709437;4610.469795973472;4612.077584483117;4612.262038073892;2851.1019029006006;2966.7181617746496;3037.164779685582;3042.1786117748306;3077.3999070181326;1126.3410904620807;1185.88319849069;1205.7933980815176;1206.221986818506;1223.6390264871795;9773.364731292444;9914.206863450907;9934.552945117486;9938.204943604494;9947.900520994843;3734.6638802507905;3912.295786758354;3922.490076290121;3982.6415622593527;4099.7745124017865;7826.295633393022;7878.290953814069;7911.84176316482;7919.643616037292;7925.920740792633;4567.086582683411;4571.405717256802;4574.656900732459;4575.58819706228;4576.58810707038;4137.234611596864;4185.058361868616;4253.617174454314;4266.296061149876;4267.850625228164;3145.653978062411;3169.3661267746543;3255.251292202807;3265.967340326614;3282.3271229397915;923.2475532441039;946.9005754395827;982.7444864335324;993.4734590666958;998.7702828349375;819.397742659145;823.7117009046785;837.3330940953084;851.527402291734;854.2354592639678;4945;4999;5074.441811400743;5153.974230128901;5167.612429067835;846.6740304982626;847.5550336073611;849.5327569836566;864.6498168241872;866.7833041739565;3461.1866211440292;3556.87550935716;3576.8748093816594;3583.157957879896;3663.084228942764;8466.957665211634;8712.477251364939;8887.866681999774;8902.777430564287;8939;8793.604287807064;8863.778405539913;8887.15572020657;8891.155340242667;8892.15524525169;6782.728690852409;6783.423409010289;6884.793456196322;6897;6930.826729331807;5067.417247016493;5149.279100925798;5161.948380516147;5185.637005409585;5191.792328306826;7958.880616790637;8064.919350806652;8104;8105.230003149692;8121.756347309354;8126.634301456567;8146.674133034612;8184.263416292562;8273.544955027532;8299.95850020746;5948.078047902582;6013.30846952606;6022.247219097613;6022.759089636365;6024.277086749443;6886.758963436456;6892.379685828299;6967.233604303421;6980.581165130108;7053.365197132282;5606.971965140148;6326.398992095744;6380.840478987877;6387.840303992437;6469.838254043687;6229.96885015572;6234.844128896814;6251.468625166912;6268.498520118471;6273.96863015682;5806.622569532967;5806.925718742046;5808.912866306924;5838.562107842014;5844.211031510692;4533.478649955297;4574.4510658721165;4631.374764406897;4658.86023419298;4660.487346391962;4344.131173765197;4418.1163767246035;4496.258117410591;4523.5250298718165;4593.104344652761 19:24:42 INFO - PROCESS | 28424 | |4;prototype.html;342.4879804691984;345.9066052165915;353.3163328958465;354.9325628130655;355.6532380928597;4919.532644398785;4959.6032317414565;4960.2311641695505;4967.329410529577;4968.478309777466;4881.414230292361;4882.1700310947135;4896.608271338293;4921.532454416833;4925.655204135712;3719.5164628598313;3836.6163383661687;3851.691864650835;3908.7492002559193;3978.443017977471;3889.3388124018843;3912.5351028851783;3914.3737002079674;3916.432117342998;3950.802459877009;3922.8430862765454;3928.350092960963;3931.567527571965;3938.7833669148185;3943.2704949584418;3607.8376473058775;3757.154640205959;3935.8032098394965;3964.86122985697;3972.9602703973023;3328.8169150696704;3334.866605335784;3347.364000839857;3351.882684106069;3354.4297469430257;4710.764461776932;4773.3078703588135;4787.712737235777;4790.137775200463;4809.254565542346;4318.287482565373;4325.286327755916;4326.156399502099;4339.1972485090355;4349.869503914856;5001.224810154432;5099.59203263738;5108.386993560796;5127.1796512558185;5140.794368225266;3628.183658676803;3637.836297366625;3640.690541303992;3651.543557055368;3651.7626354286886;5339.6262261641705;5357.303550538405;5367.141257398797;5386.946130538684;5395.951287522537;3620.8551657933913;3657.7256705747177;3665.716999050311;3682.8526858925343;3747.831347589365;3679.7424180307657;3699.9445008324897;3715.6841668458483;3720.330340538675;3742.5883152853708;4239.321708526621;4264.402983582301;4274.487061552633;4275.46556680415;4284.228838808982;4858.805647774049;5146.614003949719;5166.225066240094;5177.275181474596;5200.7139607321205;1236.9690757731128;1259.5654499197763;1262.3435813377175;1269.968250793719;1270.7712611729792;835.2148979958819;870.3385427075468;882.2544949517647;891.4517571693492;896.6368620708623;4411.558844115562;4561.384213131185;4561.931571026437;4576.244919588231;4596.609288210473;5381.219723140122;5390.245365648734;5394.568434525228;5410.756515956791;5482.998705472473;4594.793234304464;4608.769561521911;4618.376519169936;4624.30635404692;4629.398178236875;2654.588538776493;2777.5833624956417;2793.4413117376607;2798.418893325265;2802.6127067101916;4895.804167833318;4906.337644418029;4915.21356582945;4921.2864134700985;4923.35067752307;5118.334616499906;5237.711925844039;5286.233496143038;5352.57179425645;5359.678419294854;4831;4838.677434831301;4844.370231869834;4862.756862156807;4862.756862156878;5213.218017297436;5221.772883372329;5227.451117632594;5233.842984710464;5240.711760853037;4945.629077819106;5120.8719782004255;5121.462246464217;5169.379674439091;5279.788808447619;4994.875128121826;5003.399592048831;5006.749662516932;5016.498350164954;5017.422996355466;3732.2535492900984;3732.272206919733;3754.831032603485;3772.2078363543965;3806.7715937043868;5174.430812610534;5264.341957255343;5366.168243922042;5373.516383525502;5377.225515579928;5105.7191854448365;5109.540141387293;5131.538161565477;5138.614603904647;5147.819826306061;5082.390113186441;5121.308623335802;5147.356580427447;5159.690418574897;5174.370073426859;4956.752162391938;5031.698098114125;5050.267711181931;5070.721110338819;5101.668391554537;5005.824796132118;5151.459096794782;5153.45888681698;5165.656929198511;5200.595839123491;5098.592112631055;5099.311592934906;5129.333186685707;5133.204353325241;5134 19:24:42 INFO - PROCESS | 28424 | |5;yui.html;664.0868805392586;679.5447050476183;731.9971638854767;739.866823971685;755.65617643972;12549;13663.111897726665;13663.453461861514;13693.315334233299;13732.794008089873;12501.874981250185;12593.811092833615;12710.555130570432;12711.618651440449;12714.554990575332;636.7930422612646;654.4600704418873;761.4327326142032;761.866673332166;772.4592785050459;765.7166848266149;778.9912063877292;794.8450052239815;797.3063434811693;809.9511133082672;811.7483580090161;812.0742353716768;813.9511629302232;816.4652152839899;830.8047608811925;843.7637461510786;844.8352571248608;847.92792612628;848.9023762267357;853.1468531468531;590.4508806809708;602.8402473344568;606.9059295809157;619.8326451858018;624.2696045626627;12884.87115128846;12917.354132293347;12919.67700807478;12939.353032348345;13593.59219223425;12866.935665321613;13641.727165456734;13790.448382064806;13844.93077534616;13932.094413863066;9906.40561566301;10172.151797496712;10419.635312764092;10524.736881577945;10608;4034.616711412411;4059.7361171523758;4114.423980642712;4116.958830411688;4289.613934745857;59916.40083599152;60322;60707.39292607061;61430.69284653593;61558;9990.450525221037;10014.780489753455;10146.644867429604;10185.388876667424;10224.386536807815;17117.572060698334;17238.827611723973;17314.480565583053;17432.738508922375;17593;6297.748090076346;6325.114483972247;6345.7144428499905;6424;6490.286068532458;3499.125218695326;3638.7816730996224;3638.9818050909576;3639.927201455956;3667.0465678923674;2647.3249321422913;2733.72662733725;3077.9692203077684;3224.548563201107;3231.079142444439;515.559196886664;522.2401405954328;524.593440083938;525.6898429926362;537.1486194381948;628.2241431831684;634.2895956528718;640.4219250329588;642.3512252624789;657.8256761958085;8197.262246397853;8676.219140277406;8684.826303474021;8720.825583488422;9051.637934482547;631.2488139114439;637.1875858280637;642.2646070249538;644.6583310845259;650.7169381319046;4056.269871423172;4088.4889388826396;4149.688773342012;4170.4995400552125;4229.411735422799;55589.166162507594;58405.70797145987;63570;67119.32880671228;69804.65097674479;56037;57636;58921;59744.40255597388;61146;51841.7407912958;51922;52068.479315206365;52198;52497.47502524926;8129.430939834391;8347.54088525137;8357.373197010127;8433.241008309282;8545.74362769118;36469.81765091157;36897;37393.25213495769;37618.24763504769;37852.24295514129;45323.77338113288;45759.313610295205;45821;46140.53859461497;47337.52662473331;9889.50552472388;10014.499275036365;10183.236257280585;10235.23235757336;10344.689659310232;11642.825357619811;11686.474108665301;11705.297682139098;11997.160198786001;11999.700007499883;10547.789044219226;10580.841287380541;10672.62645807393;11126.443677816238;11154.665360039211;10763.46182690878;10827.458627068772;10984.121270298518;11139.554417823521;11257.943710281395;10933.289336193122;11099.334039957628;11167.218294719616;11176.131621825489;11202.775944480902;9058.728238152866;9211.585478653611;9359.15767580921;9592.36929721935;9809.656662016796;8689.739307820775;9220.815583688423;9229.49237791928;9286.907130928605;9341.532923353941 19:24:42 INFO - PROCESS | 28424 | __end_tp_report 19:24:42 INFO - PROCESS | 28424 | __start_cc_report 19:24:42 INFO - PROCESS | 28424 | _x_x_mozilla_cycle_collect,325 19:24:42 INFO - PROCESS | 28424 | __end_cc_report 19:24:42 INFO - PROCESS | 28424 | __startTimestamp1483500282126__endTimestamp 19:24:42 INFO - PROCESS | 28424 | 19:24:42 INFO - PROCESS | 28424 | ------- Summary: start ------- 19:24:42 INFO - PROCESS | 28424 | Number of tests: 6 19:24:42 INFO - PROCESS | 28424 | 19:24:42 INFO - PROCESS | 28424 | [#0] dojo.html Cycles:165 Average:4764.88 Median:4884.68 stddev:526.35 (10.8%) stddev-sans-first:499.44 19:24:42 INFO - PROCESS | 28424 | Values: 2586.0 2591.1 2592.0 2624.4 2626.3 4786.5 4832.4 4833.6 4862.7 4864.4 4815.4 4825.4 4857.4 4858.4 4952.3 4421.2 4433.9 4468.8 4558.0 4581.0 4150.6 4590.7 4596.0 4615.9 4616.5 4418.7 4517.4 4527.2 4560.2 4616.8 4425.8 4438.6 4454.6 4496.9 4573.1 4486.1 4486.6 4491.7 4495.6 4515.6 4822.4 4823.8 4834.7 4878.8 4881.7 5043.1 5100.7 5152.7 5172.5 5186.4 5248.3 5254.0 5257.7 5271.4 5306.9 4864.6 4894.0 4896.3 4907.8 4943.3 5186.1 5220.9 5248.0 5288.7 5373.8 4998.1 5047.3 5076.1 5100.0 5100.5 5070.6 5170.4 5184.8 5222.1 5227.0 5057.5 5068.1 5153.7 5206.7 5211.8 5201.3 5212.1 5230.1 5236.5 5265.2 4072.1 4098.8 4112.1 4136.8 4181.6 3628.6 3640.9 3654.6 3661.0 3663.8 4475.4 4478.8 4489.1 4497.6 4521.0 5103.8 5149.5 5236.0 5241.4 5267.1 4396.9 4418.2 4420.1 4438.9 4442.0 4608.8 4609.9 4623.0 4628.5 4656.1 4741.9 4836.6 4840.2 4845.2 4893.6 5132.4 5132.8 5153.4 5176.5 5234.8 4824.2 4836.0 4836.5 4839.4 4883.5 5096.6 5109.6 5114.6 5115.3 5166.0 5065.8 5107.9 5112.9 5124.9 5171.8 4984.2 4992.0 5006.6 5009.4 5040.8 4891.4 4950.8 4999.0 5011.4 5043.2 4827.9 4884.7 4919.0 4933.7 4983.0 5011.1 5016.2 5021.2 5028.2 5061.6 4833.8 4865.3 4902.2 4934.8 4965.2 19:24:42 INFO - PROCESS | 28424 | 19:24:42 INFO - PROCESS | 28424 | [#1] ext.html Cycles:180 Average:43118.00 Median:35650.79 stddev:75879.77 (212.8%) stddev-sans-first:76025.19 19:24:42 INFO - PROCESS | 28424 | Values: 509.2 510.1 518.6 523.7 527.7 37003.4 38133.0 38250.8 38299.6 41575.0 38425.0 38950.8 39004.0 39026.0 39136.2 7636.8 7786.5 7791.1 9494.1 9814.9 9609.4 9742.0 9744.7 9766.3 9825.6 9848.5 9870.2 9899.4 9910.1 9910.2 9699.4 9699.4 9736.1 9757.6 9758.8 9544.2 9630.2 9638.8 9682.6 9684.5 33507.7 33829.3 33862.5 33989.5 34007.8 3528.4 3655.6 3662.9 3683.2 3685.0 25860.6 26099.2 26104.5 26417.6 27124.5 3312.7 3533.5 3555.1 3567.3 3589.7 238692.0 239898.0 239898.0 240193.0 240251.0 44586.8 44643.3 44741.8 44874.6 45069.0 47112.3 47192.8 47305.8 47427.8 47457.3 11532.9 11843.0 11879.3 11897.0 11903.5 7936.7 8196.5 8998.9 9318.3 9402.2 14997.9 15111.2 15111.9 15186.7 15264.5 5976.9 6578.7 6613.5 6646.2 6687.3 782.9 791.6 822.4 833.5 833.7 26825.6 27072.6 27261.7 27336.9 27436.9 926.3 928.3 939.8 946.6 947.7 14467.5 14480.2 14538.9 14570.3 14622.3 334587.0 336374.0 337272.0 338177.0 338405.0 47638.0 48291.3 48329.0 48368.8 48371.3 1153.5 1191.8 1197.2 1207.4 1208.3 24707.3 25571.7 26427.3 26538.7 26727.5 40201.6 40265.2 40573.2 40625.2 40694.3 282019.0 282367.0 283264.0 283625.0 284363.0 22012.3 23077.5 23079.7 24133.0 24547.0 35621.0 35649.3 35652.3 36168.5 36421.6 30790.5 30984.5 31164.0 31251.4 31677.5 30013.4 31028.4 31709.2 31771.7 31844.0 32673.2 33284.0 33414.3 33494.7 33578.7 25450.2 27230.5 28812.7 28915.6 29090.9 22642.3 22897.2 22916.4 23063.4 23193.3 19:24:42 INFO - PROCESS | 28424 | 19:24:42 INFO - PROCESS | 28424 | [#2] jquery.html Cycles:180 Average:21026.45 Median:5053.37 stddev:50918.96 (1007.6%) stddev-sans-first:51038.17 19:24:42 INFO - PROCESS | 28424 | Values: 365.5 366.9 372.2 376.1 388.1 15197.3 16099.3 16648.0 16824.4 16828.7 16113.9 16222.8 16474.0 16497.0 16691.5 4781.3 5029.8 5044.9 5047.6 5059.1 3867.5 4054.8 4936.4 5538.6 5769.4 5928.1 5933.9 5934.1 5939.0 5953.6 5702.2 5795.5 5814.7 5861.8 5862.4 5060.0 5102.1 5119.6 5119.8 5126.1 19742.5 19785.4 19889.4 19921.2 20052.6 2472.5 2513.5 2574.9 2596.0 2599.4 12270.9 12338.4 12566.1 12591.3 12801.4 1695.3 1728.7 1736.9 1744.3 1757.7 61781.1 62133.7 62350.7 62395.7 62944.4 9312.2 9346.6 9462.4 9480.6 9631.1 12877.4 12880.6 12880.7 12901.4 13030.5 6672.8 6761.2 6955.3 7021.8 7041.6 6246.2 6445.1 6551.9 6601.9 6621.9 5742.6 5857.5 5881.2 5901.3 6024.6 1535.6 1594.2 1607.3 1655.4 1716.0 809.1 815.3 817.1 821.0 838.7 16037.3 16140.4 16342.4 16360.2 16487.1 828.8 829.4 831.6 835.2 849.0 9428.7 9489.1 9548.5 9606.7 9723.8 302384.0 307579.0 310295.0 310631.0 311668.0 57811.4 59617.1 59962.0 60256.4 60446.7 876.5 882.4 911.4 911.9 915.9 14345.2 14408.5 14437.1 14718.2 15203.8 31442.7 31918.4 32519.5 34039.0 36813.3 45919.3 46847.0 47067.0 47128.5 47404.0 6766.2 7523.6 7624.0 7722.8 7946.1 8304.4 8602.9 11437.7 11533.3 11604.5 9108.9 9983.4 10378.9 10490.3 10530.5 5024.2 8195.3 8345.5 10030.6 10465.3 9575.4 9738.0 9752.3 9837.5 10223.9 6627.1 6756.0 6939.2 7194.5 7396.7 8944.3 10588.6 10676.4 10913.2 11108.4 19:24:42 INFO - PROCESS | 28424 | 19:24:42 INFO - PROCESS | 28424 | [#3] mootools.html Cycles:180 Average:4834.27 Median:5706.80 stddev:2586.55 (45.3%) stddev-sans-first:2580.02 19:24:42 INFO - PROCESS | 28424 | Values: 1282.1 1290.9 1292.8 1296.8 1303.3 6633.8 6814.8 7037.7 7455.8 7506.9 7021.3 7253.9 7264.3 7330.5 7430.4 2150.0 2186.3 2187.9 2188.9 2195.6 2115.2 2145.0 2159.8 2174.8 2238.6 2183.2 2198.7 2199.4 2213.3 2215.9 2080.3 2104.1 2113.2 2116.3 2118.1 2123.1 2139.6 2156.2 2165.2 2171.7 7387.9 7431.9 7512.7 7550.3 7551.3 4470.5 4609.3 4610.5 4612.1 4612.3 2851.1 2966.7 3037.2 3042.2 3077.4 1126.3 1185.9 1205.8 1206.2 1223.6 9773.4 9914.2 9934.6 9938.2 9947.9 3734.7 3912.3 3922.5 3982.6 4099.8 7826.3 7878.3 7911.8 7919.6 7925.9 4567.1 4571.4 4574.7 4575.6 4576.6 4137.2 4185.1 4253.6 4266.3 4267.9 3145.7 3169.4 3255.3 3266.0 3282.3 923.2 946.9 982.7 993.5 998.8 819.4 823.7 837.3 851.5 854.2 4945.0 4999.0 5074.4 5154.0 5167.6 846.7 847.6 849.5 864.6 866.8 3461.2 3556.9 3576.9 3583.2 3663.1 8467.0 8712.5 8887.9 8902.8 8939.0 8793.6 8863.8 8887.2 8891.2 8892.2 6782.7 6783.4 6884.8 6897.0 6930.8 5067.4 5149.3 5161.9 5185.6 5191.8 7958.9 8064.9 8104.0 8105.2 8121.8 8126.6 8146.7 8184.3 8273.5 8300.0 5948.1 6013.3 6022.2 6022.8 6024.3 6886.8 6892.4 6967.2 6980.6 7053.4 5607.0 6326.4 6380.8 6387.8 6469.8 6230.0 6234.8 6251.5 6268.5 6274.0 5806.6 5806.9 5808.9 5838.6 5844.2 4533.5 4574.5 4631.4 4658.9 4660.5 4344.1 4418.1 4496.3 4523.5 4593.1 19:24:42 INFO - PROCESS | 28424 | 19:24:42 INFO - PROCESS | 28424 | [#4] prototype.html Cycles:180 Average:4266.05 Median:4872.09 stddev:1238.04 (25.4%) stddev-sans-first:1205.98 19:24:42 INFO - PROCESS | 28424 | Values: 342.5 345.9 353.3 354.9 355.7 4919.5 4959.6 4960.2 4967.3 4968.5 4881.4 4882.2 4896.6 4921.5 4925.7 3719.5 3836.6 3851.7 3908.7 3978.4 3889.3 3912.5 3914.4 3916.4 3950.8 3922.8 3928.4 3931.6 3938.8 3943.3 3607.8 3757.2 3935.8 3964.9 3973.0 3328.8 3334.9 3347.4 3351.9 3354.4 4710.8 4773.3 4787.7 4790.1 4809.3 4318.3 4325.3 4326.2 4339.2 4349.9 5001.2 5099.6 5108.4 5127.2 5140.8 3628.2 3637.8 3640.7 3651.5 3651.8 5339.6 5357.3 5367.1 5386.9 5396.0 3620.9 3657.7 3665.7 3682.9 3747.8 3679.7 3699.9 3715.7 3720.3 3742.6 4239.3 4264.4 4274.5 4275.5 4284.2 4858.8 5146.6 5166.2 5177.3 5200.7 1237.0 1259.6 1262.3 1270.0 1270.8 835.2 870.3 882.3 891.5 896.6 4411.6 4561.4 4561.9 4576.2 4596.6 5381.2 5390.2 5394.6 5410.8 5483.0 4594.8 4608.8 4618.4 4624.3 4629.4 2654.6 2777.6 2793.4 2798.4 2802.6 4895.8 4906.3 4915.2 4921.3 4923.4 5118.3 5237.7 5286.2 5352.6 5359.7 4831.0 4838.7 4844.4 4862.8 4862.8 5213.2 5221.8 5227.5 5233.8 5240.7 4945.6 5120.9 5121.5 5169.4 5279.8 4994.9 5003.4 5006.7 5016.5 5017.4 3732.3 3732.3 3754.8 3772.2 3806.8 5174.4 5264.3 5366.2 5373.5 5377.2 5105.7 5109.5 5131.5 5138.6 5147.8 5082.4 5121.3 5147.4 5159.7 5174.4 4956.8 5031.7 5050.3 5070.7 5101.7 5005.8 5151.5 5153.5 5165.7 5200.6 5098.6 5099.3 5129.3 5133.2 5134.0 19:24:42 INFO - PROCESS | 28424 | 19:24:42 INFO - PROCESS | 28424 | [#5] yui.html Cycles:180 Average:14620.98 Median:52133.24 stddev:18222.38 (35.0%) stddev-sans-first:18243.36 19:24:42 INFO - PROCESS | 28424 | Values: 664.1 679.5 732.0 739.9 755.7 12549.0 13663.1 13663.5 13693.3 13732.8 12501.9 12593.8 12710.6 12711.6 12714.6 636.8 654.5 761.4 761.9 772.5 765.7 779.0 794.8 797.3 810.0 811.7 812.1 814.0 816.5 830.8 843.8 844.8 847.9 848.9 853.1 590.5 602.8 606.9 619.8 624.3 12884.9 12917.4 12919.7 12939.4 13593.6 12866.9 13641.7 13790.4 13844.9 13932.1 9906.4 10172.2 10419.6 10524.7 10608.0 4034.6 4059.7 4114.4 4117.0 4289.6 59916.4 60322.0 60707.4 61430.7 61558.0 9990.5 10014.8 10146.6 10185.4 10224.4 17117.6 17238.8 17314.5 17432.7 17593.0 6297.7 6325.1 6345.7 6424.0 6490.3 3499.1 3638.8 3639.0 3639.9 3667.0 2647.3 2733.7 3078.0 3224.5 3231.1 515.6 522.2 524.6 525.7 537.1 628.2 634.3 640.4 642.4 657.8 8197.3 8676.2 8684.8 8720.8 9051.6 631.2 637.2 642.3 644.7 650.7 4056.3 4088.5 4149.7 4170.5 4229.4 55589.2 58405.7 63570.0 67119.3 69804.7 56037.0 57636.0 58921.0 59744.4 61146.0 51841.7 51922.0 52068.5 52198.0 52497.5 8129.4 8347.5 8357.4 8433.2 8545.7 36469.8 36897.0 37393.3 37618.2 37852.2 45323.8 45759.3 45821.0 46140.5 47337.5 9889.5 10014.5 10183.2 10235.2 10344.7 11642.8 11686.5 11705.3 11997.2 11999.7 10547.8 10580.8 10672.6 11126.4 11154.7 10763.5 10827.5 10984.1 11139.6 11257.9 10933.3 11099.3 11167.2 11176.1 11202.8 9058.7 9211.6 9359.2 9592.4 9809.7 8689.7 9220.8 9229.5 9286.9 9341.5 19:24:42 INFO - PROCESS | 28424 | -------- Summary: end -------- 19:24:42 INFO - PROCESS | 28424 | 19:24:43 INFO - TEST-INFO | 28424: exit 0 19:24:43 INFO - TEST-OK | dromaeo_css | took 1119128ms 19:24:43 INFO - TEST-START | kraken 19:24:43 INFO - operating with platform_type : linux_ 19:24:43 INFO - Initialising browser for kraken test... 19:24:43 INFO - TEST-INFO | started process 28775 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJx5z6i/profile http://localhost:53309/getInfo.html) 19:24:43 INFO - PROCESS | 28775 | 1483500283535 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:4901 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3756 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2789 < callProvider()@resource://gre/modules/AddonManager.jsm:260 < _startProvider()@resource://gre/modules/AddonManager.jsm:755 < startup()@resource://gre/modules/AddonManager.jsm:937 < startup()@resource://gre/modules/AddonManager.jsm:2886 < observe()@resource://gre/components/addonManager.js:65 19:24:47 INFO - PROCESS | 28775 | __metrics Screen width/height:1600/1200 19:24:47 INFO - PROCESS | 28775 | colorDepth:24 19:24:47 INFO - PROCESS | 28775 | Browser inner width/height: 1024/697 19:24:47 INFO - PROCESS | 28775 | __metrics 19:24:47 ERROR - PROCESS | 28775 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 19:24:49 INFO - TEST-INFO | 28775: exit 0 19:24:49 INFO - Browser initialized. 19:24:49 INFO - Running cycle 1/1 for kraken test... 19:24:49 INFO - TEST-INFO | started process 28896 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJx5z6i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:25:01 INFO - PROCESS | 28896 | RSS: Main: 157921280 19:25:01 INFO - PROCESS | 28896 | 19:25:03 INFO - PROCESS | 28896 | Cycle 1(1): loaded http://localhost:53309/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53309/tests/kraken/driver.html?testName=audio-beat-detection) 19:25:04 INFO - PROCESS | 28896 | RSS: Main: 163758080 19:25:04 INFO - PROCESS | 28896 | 19:25:07 INFO - PROCESS | 28896 | Cycle 1(1): loaded http://localhost:53309/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53309/tests/kraken/driver.html?testName=audio-dft) 19:25:08 INFO - PROCESS | 28896 | RSS: Main: 162553856 19:25:08 INFO - PROCESS | 28896 | 19:25:11 INFO - PROCESS | 28896 | Cycle 1(1): loaded http://localhost:53309/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53309/tests/kraken/driver.html?testName=audio-fft) 19:25:11 INFO - PROCESS | 28896 | RSS: Main: 159449088 19:25:11 INFO - PROCESS | 28896 | 19:25:13 INFO - PROCESS | 28896 | Cycle 1(1): loaded http://localhost:53309/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53309/tests/kraken/driver.html?testName=audio-oscillator) 19:25:14 INFO - PROCESS | 28896 | RSS: Main: 159662080 19:25:14 INFO - PROCESS | 28896 | 19:25:16 INFO - PROCESS | 28896 | Cycle 1(1): loaded http://localhost:53309/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53309/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:25:17 INFO - PROCESS | 28896 | RSS: Main: 159928320 19:25:17 INFO - PROCESS | 28896 | 19:25:20 INFO - PROCESS | 28896 | Cycle 1(1): loaded http://localhost:53309/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53309/tests/kraken/driver.html?testName=imaging-darkroom) 19:25:21 INFO - PROCESS | 28896 | RSS: Main: 165425152 19:25:21 INFO - PROCESS | 28896 | 19:25:24 INFO - PROCESS | 28896 | Cycle 1(1): loaded http://localhost:53309/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53309/tests/kraken/driver.html?testName=imaging-desaturate) 19:25:25 INFO - PROCESS | 28896 | RSS: Main: 161689600 19:25:25 INFO - PROCESS | 28896 | 19:25:28 INFO - PROCESS | 28896 | Cycle 1(1): loaded http://localhost:53309/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53309/tests/kraken/driver.html?testName=json-parse-financial) 19:25:28 INFO - PROCESS | 28896 | RSS: Main: 162721792 19:25:28 INFO - PROCESS | 28896 | 19:25:30 INFO - PROCESS | 28896 | Cycle 1(1): loaded http://localhost:53309/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53309/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:25:31 INFO - PROCESS | 28896 | RSS: Main: 163659776 19:25:31 INFO - PROCESS | 28896 | 19:25:33 INFO - PROCESS | 28896 | Cycle 1(1): loaded http://localhost:53309/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53309/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:25:33 INFO - PROCESS | 28896 | RSS: Main: 162746368 19:25:33 INFO - PROCESS | 28896 | 19:25:35 INFO - PROCESS | 28896 | Cycle 1(1): loaded http://localhost:53309/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53309/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:25:36 INFO - PROCESS | 28896 | RSS: Main: 163303424 19:25:36 INFO - PROCESS | 28896 | 19:25:39 INFO - PROCESS | 28896 | Cycle 1(1): loaded http://localhost:53309/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53309/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:25:40 INFO - PROCESS | 28896 | RSS: Main: 163573760 19:25:40 INFO - PROCESS | 28896 | 19:25:43 INFO - PROCESS | 28896 | Cycle 1(1): loaded http://localhost:53309/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53309/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:25:43 INFO - PROCESS | 28896 | RSS: Main: 163409920 19:25:43 INFO - PROCESS | 28896 | 19:25:45 INFO - PROCESS | 28896 | Cycle 1(1): loaded http://localhost:53309/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53309/tests/kraken/driver.html?testName=ai-astar) 19:25:45 INFO - PROCESS | 28896 | RSS: Main: 165502976 19:25:45 INFO - PROCESS | 28896 | 19:25:45 INFO - PROCESS | 28896 | __start_tp_report 19:25:45 INFO - PROCESS | 28896 | _x_x_mozilla_page_load 19:25:45 INFO - PROCESS | 28896 | _x_x_mozilla_page_load_details 19:25:45 INFO - PROCESS | 28896 | |i|pagename|runs| 19:25:45 INFO - PROCESS | 28896 | |0;ai-astar;111;117;117;117;118;116;117;118;116;117 19:25:45 INFO - PROCESS | 28896 | |1;audio-beat-detection;157;135;135;178;130;130;128;130;150;128 19:25:45 INFO - PROCESS | 28896 | |2;audio-dft;166;164;165;174;162;163;162;166;163;163 19:25:45 INFO - PROCESS | 28896 | |3;audio-fft;77;78;77;110;78;78;78;77;96;80 19:25:45 INFO - PROCESS | 28896 | |4;audio-oscillator;85;84;105;84;85;85;106;85;85;116 19:25:45 INFO - PROCESS | 28896 | |5;imaging-gaussian-blur;117;118;118;117;118;122;119;117;121;118 19:25:45 INFO - PROCESS | 28896 | |6;imaging-darkroom;150;151;150;151;151;151;152;151;153;151 19:25:45 INFO - PROCESS | 28896 | |7;imaging-desaturate;96;96;96;97;96;96;96;96;97;97 19:25:45 INFO - PROCESS | 28896 | |8;json-parse-financial;64;63;63;64;63;66;65;64;63;63 19:25:45 INFO - PROCESS | 28896 | |9;json-stringify-tinderbox;68;68;68;67;68;68;67;69;69;69 19:25:45 INFO - PROCESS | 28896 | |10;stanford-crypto-aes;88;92;86;86;86;87;89;90;86;87 19:25:45 INFO - PROCESS | 28896 | |11;stanford-crypto-ccm;140;136;138;151;141;139;141;154;185;142 19:25:45 INFO - PROCESS | 28896 | |12;stanford-crypto-pbkdf2;182;184;178;188;178;180;180;185;186;181 19:25:45 INFO - PROCESS | 28896 | |13;stanford-crypto-sha256-iterative;69;71;74;69;76;72;73;71;71;70 19:25:45 INFO - PROCESS | 28896 | __end_tp_report 19:25:45 INFO - PROCESS | 28896 | __start_cc_report 19:25:45 INFO - PROCESS | 28896 | _x_x_mozilla_cycle_collect,796 19:25:45 INFO - PROCESS | 28896 | __end_cc_report 19:25:45 INFO - PROCESS | 28896 | __startTimestamp1483500345913__endTimestamp 19:25:45 INFO - PROCESS | 28896 | 19:25:45 INFO - PROCESS | 28896 | ------- Summary: start ------- 19:25:45 INFO - PROCESS | 28896 | Number of tests: 14 19:25:45 INFO - PROCESS | 28896 | 19:25:45 INFO - PROCESS | 28896 | [#0] ai-astar Cycles:10 Average:116.40 Median:117.00 stddev:2.01 (1.7%) stddev-sans-first:0.71 19:25:45 INFO - PROCESS | 28896 | Values: 111.0 117.0 117.0 117.0 118.0 116.0 117.0 118.0 116.0 117.0 19:25:45 INFO - PROCESS | 28896 | 19:25:45 INFO - PROCESS | 28896 | [#1] audio-beat-detection Cycles:10 Average:140.10 Median:135.00 stddev:16.57 (12.3%) stddev-sans-first:16.41 19:25:45 INFO - PROCESS | 28896 | Values: 157.0 135.0 135.0 178.0 130.0 130.0 128.0 130.0 150.0 128.0 19:25:45 INFO - PROCESS | 28896 | 19:25:45 INFO - PROCESS | 28896 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.50 stddev:3.55 (2.2%) stddev-sans-first:3.74 19:25:45 INFO - PROCESS | 28896 | Values: 166.0 164.0 165.0 174.0 162.0 163.0 162.0 166.0 163.0 163.0 19:25:45 INFO - PROCESS | 28896 | 19:25:45 INFO - PROCESS | 28896 | [#3] audio-fft Cycles:10 Average:82.90 Median:78.00 stddev:11.13 (14.3%) stddev-sans-first:11.60 19:25:45 INFO - PROCESS | 28896 | Values: 77.0 78.0 77.0 110.0 78.0 78.0 78.0 77.0 96.0 80.0 19:25:45 INFO - PROCESS | 28896 | 19:25:45 INFO - PROCESS | 28896 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:85.00 stddev:12.08 (14.2%) stddev-sans-first:12.55 19:25:45 INFO - PROCESS | 28896 | Values: 85.0 84.0 105.0 84.0 85.0 85.0 106.0 85.0 85.0 116.0 19:25:45 INFO - PROCESS | 28896 | 19:25:45 INFO - PROCESS | 28896 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.00 stddev:1.72 (1.5%) stddev-sans-first:1.73 19:25:45 INFO - PROCESS | 28896 | Values: 117.0 118.0 118.0 117.0 118.0 122.0 119.0 117.0 121.0 118.0 19:25:45 INFO - PROCESS | 28896 | 19:25:45 INFO - PROCESS | 28896 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:0.88 (0.6%) stddev-sans-first:0.83 19:25:45 INFO - PROCESS | 28896 | Values: 150.0 151.0 150.0 151.0 151.0 151.0 152.0 151.0 153.0 151.0 19:25:45 INFO - PROCESS | 28896 | 19:25:45 INFO - PROCESS | 28896 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 19:25:45 INFO - PROCESS | 28896 | Values: 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 97.0 97.0 19:25:45 INFO - PROCESS | 28896 | 19:25:45 INFO - PROCESS | 28896 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:1.03 (1.6%) stddev-sans-first:1.09 19:25:45 INFO - PROCESS | 28896 | Values: 64.0 63.0 63.0 64.0 63.0 66.0 65.0 64.0 63.0 63.0 19:25:45 INFO - PROCESS | 28896 | 19:25:45 INFO - PROCESS | 28896 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 19:25:45 INFO - PROCESS | 28896 | Values: 68.0 68.0 68.0 67.0 68.0 68.0 67.0 69.0 69.0 69.0 19:25:45 INFO - PROCESS | 28896 | 19:25:45 INFO - PROCESS | 28896 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:87.50 stddev:2.06 (2.4%) stddev-sans-first:2.18 19:25:45 INFO - PROCESS | 28896 | Values: 88.0 92.0 86.0 86.0 86.0 87.0 89.0 90.0 86.0 87.0 19:25:45 INFO - PROCESS | 28896 | 19:25:45 INFO - PROCESS | 28896 | [#11] stanford-crypto-ccm Cycles:10 Average:146.70 Median:141.50 stddev:14.61 (10.3%) stddev-sans-first:15.29 19:25:45 INFO - PROCESS | 28896 | Values: 140.0 136.0 138.0 151.0 141.0 139.0 141.0 154.0 185.0 142.0 19:25:45 INFO - PROCESS | 28896 | 19:25:45 INFO - PROCESS | 28896 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.20 Median:183.00 stddev:3.43 (1.9%) stddev-sans-first:3.63 19:25:45 INFO - PROCESS | 28896 | Values: 182.0 184.0 178.0 188.0 178.0 180.0 180.0 185.0 186.0 181.0 19:25:45 INFO - PROCESS | 28896 | 19:25:45 INFO - PROCESS | 28896 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:71.50 stddev:2.22 (3.1%) stddev-sans-first:2.15 19:25:45 INFO - PROCESS | 28896 | Values: 69.0 71.0 74.0 69.0 76.0 72.0 73.0 71.0 71.0 70.0 19:25:45 INFO - PROCESS | 28896 | -------- Summary: end -------- 19:25:45 INFO - PROCESS | 28896 | 19:25:47 INFO - TEST-INFO | 28896: exit 0 19:25:47 INFO - TEST-OK | kraken | took 64077ms 19:25:47 INFO - SUITE-END | took 1183s 19:25:47 INFO - Completed test suite (00:19:43) 19:25:47 INFO - javascript benchmark 19:25:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6268.566760637994, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2586.0, 2591.119019533359, 2591.961120583193, 2624.396388830569, 2626.277773612256, 4786.468330134358, 4832.395950506191, 4833.589144922686, 4862.708237505748, 4864.440589332224, 4815.398075240595, 4825.396825396825, 4857.368542089533, 4858.36841210643, 4952.306677065214, 4421.182081314951, 4433.911321773563, 4468.75421851798, 4558.0, 4580.97709511452, 4150.564190759972, 4590.655700822452, 4595.977020114895, 4615.930761038587, 4616.515265897083, 4418.734875907456, 4517.435320584927, 4527.185106680829, 4560.247559152735, 4616.792244348995, 4425.778711064434, 4438.644908407352, 4454.621357184611, 4496.910061798779, 4573.062522182944, 4486.1027794440915, 4486.573775491323, 4491.708038977456, 4495.64034877209, 4515.571020753023, 4822.397200349957, 4823.758812059418, 4834.734089625069, 4878.829240976549, 4881.731504767236, 5043.092243396187, 5100.719460429675, 5152.6650767699975, 5172.5344718975475, 5186.377634683824, 5248.265242866002, 5253.973730131325, 5257.7108259045735, 5271.446498117719, 5306.946930530684, 4864.635152363587, 4893.975530122327, 4896.265560165933, 4907.754612269444, 4943.307936888838, 5186.118359878829, 5220.895582088337, 5248.002879452968, 5288.735563221823, 5373.838784836461, 4998.075356059141, 5047.318611987408, 5076.060928728197, 5100.0, 5100.48995100487, 5070.594352451795, 5170.40540337866, 5184.818531351385, 5222.112240919053, 5226.97386513065, 5057.468965758616, 5068.087744206078, 5153.6907785532985, 5206.713630750345, 5211.8175863845345, 5201.3238279024245, 5212.113940630102, 5230.137027390514, 5236.528712415901, 5265.236540701577, 4072.144849581621, 4098.7950602469755, 4112.115895082572, 4136.793160341971, 4181.581841815855, 3628.618995005539, 3640.8725694601094, 3654.5979942206336, 3660.9816950915074, 3663.816809159531, 4475.4181956345465, 4478.753668548261, 4489.147062058199, 4497.550244975476, 4521.0, 5103.770330335144, 5149.510796474329, 5235.973820130951, 5241.449647787003, 5267.078261304257, 4396.890077748082, 4418.2047231498, 4420.138073075784, 4438.866833994985, 4441.955580444219, 4608.815647374135, 4609.907801843944, 4623.0, 4628.467726211529, 4656.138614356287, 4741.9051618968115, 4836.588889944253, 4840.185373033426, 4845.152098382699, 4893.584045356185, 5132.358455193101, 5132.769025393792, 5153.433122356612, 5176.534111929945, 5234.7906083756225, 4824.155772739827, 4835.975820120877, 4836.46798852133, 4839.361335986957, 4883.487233840538, 5096.566791822736, 5109.64232503736, 5114.641975061859, 5115.283860259492, 5166.0, 5065.772040258271, 5107.872303192301, 5112.872178195575, 5124.923126153185, 5171.793128274978, 4984.22744474607, 4991.975040124921, 5006.62450316235, 5009.4489606144025, 5040.823571174991, 4891.364122664031, 4950.777215025405, 4999.0, 5011.398632164163, 5043.167877300204, 4827.8551643450755, 4884.682495637772, 4918.95081049185, 4933.703977761345, 4983.0, 5011.072951503984, 5016.247562865599, 5021.171506701354, 5028.220625803006, 5061.569766569735, 4833.806647734052, 4865.343178670976, 4902.240152776325, 4934.777934993006, 4965.155923492943], "value": 4728.887745897133, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.20055512844823, 510.10476613543227, 518.5644058990447, 523.7486006716775, 527.6570229350922, 37003.4449483258, 38133.04667383313, 38250.8087459563, 38299.61700382995, 41575.0, 38425.0, 38950.80524597373, 39004.0, 39026.0, 39136.21727565447, 7636.809079773008, 7786.493877897947, 7791.065072191345, 9494.145526902577, 9814.90185098147, 9609.423434593911, 9742.0, 9744.707658770212, 9766.316357854954, 9825.557849896735, 9848.458334791583, 9870.161036311922, 9899.356541824794, 9910.108090271875, 9910.207183425344, 9699.369540979813, 9699.418034917928, 9736.075072868067, 9757.560909759042, 9758.756031099208, 9544.236461083166, 9630.229581633452, 9638.75903102421, 9682.56428460721, 9684.51577421126, 33507.6649233507, 33829.323413531594, 33862.49206261908, 33989.49015764741, 34007.829960850286, 3528.417811061172, 3655.6161603031564, 3662.9450558241647, 3683.244934788389, 3684.9631503684886, 25860.612090818653, 26099.217023489327, 26104.477910441685, 26417.603735943783, 27124.457510849672, 3312.668733126692, 3533.522974398449, 3555.093451169961, 3567.340042092221, 3589.73077019222, 238692.0, 239898.0, 239898.0, 240193.0, 240251.0, 44586.77706611446, 44643.3124521927, 44741.77629111834, 44874.551254487036, 45069.0, 47112.29331560029, 47192.7640361796, 47305.76347118311, 47427.762861185474, 47457.28814067792, 11532.88467115335, 11843.0, 11879.287242765462, 11897.0, 11903.464344104535, 7936.722214722457, 8196.5491897945, 8998.86501702475, 9318.347715659975, 9402.247820174369, 14997.925010375096, 15111.244437778067, 15111.924440377948, 15186.696266074616, 15264.542063738105, 5976.880462390728, 6578.703958321887, 6613.537052406382, 6646.235682896432, 6687.331266873371, 782.9491083079581, 791.5606838204851, 822.4037572759702, 833.5248908122434, 833.6998680475024, 26825.597616035775, 27072.59391109135, 27261.727382726316, 27336.863315683295, 27436.862815686192, 926.3284119013662, 928.331601247101, 939.8402271613842, 946.6402766948653, 947.7298969793713, 14467.49363772263, 14480.203588802717, 14538.927305363406, 14570.344334504973, 14622.341994610268, 334587.0, 336374.0, 337272.0, 338177.0, 338405.0, 47638.0, 48291.275630865566, 48329.0, 48368.75815620899, 48371.27443088357, 1153.4866984191954, 1191.7795207886568, 1197.2098415046203, 1207.3842340406457, 1208.275034979023, 24707.25878223656, 25571.744282556938, 26427.339316517242, 26538.734612653625, 26727.465450690488, 40201.597984020955, 40265.194696105325, 40573.1885362297, 40625.1874962505, 40694.25073609188, 282019.0, 282367.0, 283264.0, 283625.0, 284363.0, 22012.339629811133, 23077.53844923126, 23079.653805193273, 24133.0, 24547.0, 35621.0, 35649.28701425905, 35652.28695426129, 36168.457473137394, 36421.635783641825, 30790.53814192744, 30984.53523197199, 31164.0, 31251.37497250088, 31677.524837127923, 30013.3997320048, 31028.379432411675, 31709.207269817518, 31771.682283177797, 31844.0, 32673.18317042093, 33284.0, 33414.33171336511, 33494.66505335013, 33578.66421335755, 25450.236492905242, 27230.455390892468, 28812.711872881002, 28915.56626650644, 29090.854545727136, 22642.320730378116, 22897.198598048988, 22916.3970170953, 23063.423414414774, 23193.304200874], "value": 16713.61603040295, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.51751687772145, 366.92661467706455, 372.1607774468573, 376.0823590439328, 388.06089263981164, 15197.316120774563, 16099.275532601047, 16647.999999999985, 16824.411145609905, 16828.74756878648, 16113.91943040286, 16222.7566586501, 16474.0, 16497.0, 16691.49925502237, 4781.306710526971, 5029.7736601853, 5044.899102017957, 5047.64666473347, 5059.089363914494, 3867.4972253606993, 4054.8378064877515, 4936.3829521309835, 5538.6399884007415, 5769.394213607574, 5928.051511758098, 5933.910991335133, 5934.080217566284, 5939.0, 5953.613015154023, 5702.173184888189, 5795.4784069433745, 5814.680192589406, 5861.794837180678, 5862.384449632812, 5059.988002399498, 5102.081625307444, 5119.59043276537, 5119.769610367543, 5126.103341763534, 19742.50643733918, 19785.406437806745, 19889.403317900487, 19921.203151873906, 20052.598948021103, 2472.4807790364043, 2513.497300539881, 2574.858382788946, 2596.0, 2599.363156026767, 12270.877291227152, 12338.383080846012, 12566.120371573994, 12591.307478088702, 12801.423935922812, 1695.262560786062, 1728.7320465327894, 1736.9131543422905, 1744.310997156129, 1757.7275522294065, 61781.07328390123, 62133.689331553505, 62350.68824655893, 62395.688021560054, 62944.370556294765, 9312.161905428544, 9346.626134954662, 9462.43225406464, 9480.620775169054, 9631.08504692053, 12877.4205160768, 12880.613581592566, 12880.742385152245, 12901.419436125398, 13030.478780848849, 6672.799816005528, 6761.22245941723, 6955.269696681877, 7021.824454388579, 7041.612711300825, 6246.15676883624, 6445.097686323918, 6551.901721474182, 6601.933980660228, 6621.86756264872, 5742.569307301969, 5857.47282744555, 5881.235439392937, 5901.29184497863, 6024.608400453956, 1535.6084198529304, 1594.2028985507247, 1607.3490236454254, 1655.3709590355588, 1715.9742603860952, 809.0695699944993, 815.2906970935325, 817.1256755271921, 820.979475513117, 838.6854929401475, 16037.278322475517, 16140.35438582467, 16342.428015019656, 16360.181990900408, 16487.093209873332, 828.7886588919787, 829.3779665251062, 831.5800520736989, 835.1648351648352, 848.9617967191491, 9428.669996550088, 9489.145976862115, 9548.522573871278, 9606.66376676813, 9723.805523889483, 302384.0, 307579.0, 310295.0, 310631.0, 311668.0, 57811.421885780604, 59617.105743413886, 59962.0, 60256.39743602595, 60446.697766510886, 876.4741155306765, 882.4264228251687, 911.4485736129546, 911.8814554107923, 915.9313051521162, 14345.211013394364, 14408.495702650356, 14437.06159099655, 14718.190499522201, 15203.847961520243, 31442.685573143975, 31918.36163276768, 32519.51220731738, 34039.0, 36813.26373472569, 45919.31121033254, 46847.0, 47067.0, 47128.52871471241, 47404.0, 6766.2218844831505, 7523.608132495506, 7623.9618801905635, 7722.768316950501, 7946.125926148004, 8304.418690691835, 8602.932387744351, 11437.656870293904, 11533.308001519936, 11604.47779849892, 9108.908910911072, 9983.400995940267, 10378.948105259426, 10490.265681402534, 10530.526126324181, 5024.221245706921, 8195.34437245007, 8345.54099524532, 10030.64892728751, 10465.319754215952, 9575.377600455948, 9738.0, 9752.317337786288, 9837.458939758382, 10223.897761022294, 6627.105340778933, 6755.966220168868, 6939.201991771011, 7194.525122349801, 7396.667149978156, 8944.329175312008, 10588.629397971034, 10676.359418434919, 10913.18151138652, 11108.389038602954], "value": 7974.70976925773, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1282.1345591725583, 1290.8580056193823, 1292.7931530955047, 1296.7989961555957, 1303.2571434282456, 6633.800985970416, 6814.761483348084, 7037.683304251308, 7455.776326710201, 7506.924930750698, 7021.262767409412, 7253.854922901539, 7264.273572642746, 7330.523515971458, 7430.368418684405, 2150.0432307623155, 2186.3440967709703, 2187.8796666183352, 2188.9233876814314, 2195.560887822434, 2115.227941801239, 2145.0454547726267, 2159.8272138228904, 2174.8042676159143, 2238.6418173092306, 2183.170395249803, 2198.736151661803, 2199.351191398533, 2213.2806837777707, 2215.8892055397246, 2080.2719048333115, 2104.074207348762, 2113.228671534894, 2116.291042500764, 2118.0892216346965, 2123.0870725587993, 2139.5934772393352, 2156.2345367394664, 2165.220520612578, 2171.6633921742155, 7387.85224295511, 7431.888521672179, 7512.699492020312, 7550.282723141293, 7551.282628150317, 4470.463544374696, 4609.308603709437, 4610.469795973472, 4612.077584483117, 4612.262038073892, 2851.1019029006006, 2966.7181617746496, 3037.164779685582, 3042.1786117748306, 3077.3999070181326, 1126.3410904620807, 1185.88319849069, 1205.7933980815176, 1206.221986818506, 1223.6390264871795, 9773.364731292444, 9914.206863450907, 9934.552945117486, 9938.204943604494, 9947.900520994843, 3734.6638802507905, 3912.295786758354, 3922.490076290121, 3982.6415622593527, 4099.7745124017865, 7826.295633393022, 7878.290953814069, 7911.84176316482, 7919.643616037292, 7925.920740792633, 4567.086582683411, 4571.405717256802, 4574.656900732459, 4575.58819706228, 4576.58810707038, 4137.234611596864, 4185.058361868616, 4253.617174454314, 4266.296061149876, 4267.850625228164, 3145.653978062411, 3169.3661267746543, 3255.251292202807, 3265.967340326614, 3282.3271229397915, 923.2475532441039, 946.9005754395827, 982.7444864335324, 993.4734590666958, 998.7702828349375, 819.397742659145, 823.7117009046785, 837.3330940953084, 851.527402291734, 854.2354592639678, 4945.0, 4999.0, 5074.441811400743, 5153.974230128901, 5167.612429067835, 846.6740304982626, 847.5550336073611, 849.5327569836566, 864.6498168241872, 866.7833041739565, 3461.1866211440292, 3556.87550935716, 3576.8748093816594, 3583.157957879896, 3663.084228942764, 8466.957665211634, 8712.477251364939, 8887.866681999774, 8902.777430564287, 8939.0, 8793.604287807064, 8863.778405539913, 8887.15572020657, 8891.155340242667, 8892.15524525169, 6782.728690852409, 6783.423409010289, 6884.793456196322, 6897.0, 6930.826729331807, 5067.417247016493, 5149.279100925798, 5161.948380516147, 5185.637005409585, 5191.792328306826, 7958.880616790637, 8064.919350806652, 8104.0, 8105.230003149692, 8121.756347309354, 8126.634301456567, 8146.674133034612, 8184.263416292562, 8273.544955027532, 8299.95850020746, 5948.078047902582, 6013.30846952606, 6022.247219097613, 6022.759089636365, 6024.277086749443, 6886.758963436456, 6892.379685828299, 6967.233604303421, 6980.581165130108, 7053.365197132282, 5606.971965140148, 6326.398992095744, 6380.840478987877, 6387.840303992437, 6469.838254043687, 6229.96885015572, 6234.844128896814, 6251.468625166912, 6268.498520118471, 6273.96863015682, 5806.622569532967, 5806.925718742046, 5808.912866306924, 5838.562107842014, 5844.211031510692, 4533.478649955297, 4574.4510658721165, 4631.374764406897, 4658.86023419298, 4660.487346391962, 4344.131173765197, 4418.1163767246035, 4496.258117410591, 4523.5250298718165, 4593.104344652761], "value": 3959.998492334395, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.4879804691984, 345.9066052165915, 353.3163328958465, 354.9325628130655, 355.6532380928597, 4919.532644398785, 4959.6032317414565, 4960.2311641695505, 4967.329410529577, 4968.478309777466, 4881.414230292361, 4882.1700310947135, 4896.608271338293, 4921.532454416833, 4925.655204135712, 3719.5164628598313, 3836.6163383661687, 3851.691864650835, 3908.7492002559193, 3978.443017977471, 3889.3388124018843, 3912.5351028851783, 3914.3737002079674, 3916.432117342998, 3950.802459877009, 3922.8430862765454, 3928.350092960963, 3931.567527571965, 3938.7833669148185, 3943.2704949584418, 3607.8376473058775, 3757.154640205959, 3935.8032098394965, 3964.86122985697, 3972.9602703973023, 3328.8169150696704, 3334.866605335784, 3347.364000839857, 3351.882684106069, 3354.4297469430257, 4710.764461776932, 4773.3078703588135, 4787.712737235777, 4790.137775200463, 4809.254565542346, 4318.287482565373, 4325.286327755916, 4326.156399502099, 4339.1972485090355, 4349.869503914856, 5001.224810154432, 5099.59203263738, 5108.386993560796, 5127.1796512558185, 5140.794368225266, 3628.183658676803, 3637.836297366625, 3640.690541303992, 3651.543557055368, 3651.7626354286886, 5339.6262261641705, 5357.303550538405, 5367.141257398797, 5386.946130538684, 5395.951287522537, 3620.8551657933913, 3657.7256705747177, 3665.716999050311, 3682.8526858925343, 3747.831347589365, 3679.7424180307657, 3699.9445008324897, 3715.6841668458483, 3720.330340538675, 3742.5883152853708, 4239.321708526621, 4264.402983582301, 4274.487061552633, 4275.46556680415, 4284.228838808982, 4858.805647774049, 5146.614003949719, 5166.225066240094, 5177.275181474596, 5200.7139607321205, 1236.9690757731128, 1259.5654499197763, 1262.3435813377175, 1269.968250793719, 1270.7712611729792, 835.2148979958819, 870.3385427075468, 882.2544949517647, 891.4517571693492, 896.6368620708623, 4411.558844115562, 4561.384213131185, 4561.931571026437, 4576.244919588231, 4596.609288210473, 5381.219723140122, 5390.245365648734, 5394.568434525228, 5410.756515956791, 5482.998705472473, 4594.793234304464, 4608.769561521911, 4618.376519169936, 4624.30635404692, 4629.398178236875, 2654.588538776493, 2777.5833624956417, 2793.4413117376607, 2798.418893325265, 2802.6127067101916, 4895.804167833318, 4906.337644418029, 4915.21356582945, 4921.2864134700985, 4923.35067752307, 5118.334616499906, 5237.711925844039, 5286.233496143038, 5352.57179425645, 5359.678419294854, 4831.0, 4838.677434831301, 4844.370231869834, 4862.756862156807, 4862.756862156878, 5213.218017297436, 5221.772883372329, 5227.451117632594, 5233.842984710464, 5240.711760853037, 4945.629077819106, 5120.8719782004255, 5121.462246464217, 5169.379674439091, 5279.788808447619, 4994.875128121826, 5003.399592048831, 5006.749662516932, 5016.498350164954, 5017.422996355466, 3732.2535492900984, 3732.272206919733, 3754.831032603485, 3772.2078363543965, 3806.7715937043868, 5174.430812610534, 5264.341957255343, 5366.168243922042, 5373.516383525502, 5377.225515579928, 5105.7191854448365, 5109.540141387293, 5131.538161565477, 5138.614603904647, 5147.819826306061, 5082.390113186441, 5121.308623335802, 5147.356580427447, 5159.690418574897, 5174.370073426859, 4956.752162391938, 5031.698098114125, 5050.267711181931, 5070.721110338819, 5101.668391554537, 5005.824796132118, 5151.459096794782, 5153.45888681698, 5165.656929198511, 5200.595839123491, 5098.592112631055, 5099.311592934906, 5129.333186685707, 5133.204353325241, 5134.0], "value": 3883.2368450007034, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.0868805392586, 679.5447050476183, 731.9971638854767, 739.866823971685, 755.65617643972, 12549.0, 13663.111897726665, 13663.453461861514, 13693.315334233299, 13732.794008089873, 12501.874981250185, 12593.811092833615, 12710.555130570432, 12711.618651440449, 12714.554990575332, 636.7930422612646, 654.4600704418873, 761.4327326142032, 761.866673332166, 772.4592785050459, 765.7166848266149, 778.9912063877292, 794.8450052239815, 797.3063434811693, 809.9511133082672, 811.7483580090161, 812.0742353716768, 813.9511629302232, 816.4652152839899, 830.8047608811925, 843.7637461510786, 844.8352571248608, 847.92792612628, 848.9023762267357, 853.1468531468531, 590.4508806809708, 602.8402473344568, 606.9059295809157, 619.8326451858018, 624.2696045626627, 12884.87115128846, 12917.354132293347, 12919.67700807478, 12939.353032348345, 13593.59219223425, 12866.935665321613, 13641.727165456734, 13790.448382064806, 13844.93077534616, 13932.094413863066, 9906.40561566301, 10172.151797496712, 10419.635312764092, 10524.736881577945, 10608.0, 4034.616711412411, 4059.7361171523758, 4114.423980642712, 4116.958830411688, 4289.613934745857, 59916.40083599152, 60322.0, 60707.39292607061, 61430.69284653593, 61558.0, 9990.450525221037, 10014.780489753455, 10146.644867429604, 10185.388876667424, 10224.386536807815, 17117.572060698334, 17238.827611723973, 17314.480565583053, 17432.738508922375, 17593.0, 6297.748090076346, 6325.114483972247, 6345.7144428499905, 6424.0, 6490.286068532458, 3499.125218695326, 3638.7816730996224, 3638.9818050909576, 3639.927201455956, 3667.0465678923674, 2647.3249321422913, 2733.72662733725, 3077.9692203077684, 3224.548563201107, 3231.079142444439, 515.559196886664, 522.2401405954328, 524.593440083938, 525.6898429926362, 537.1486194381948, 628.2241431831684, 634.2895956528718, 640.4219250329588, 642.3512252624789, 657.8256761958085, 8197.262246397853, 8676.219140277406, 8684.826303474021, 8720.825583488422, 9051.637934482547, 631.2488139114439, 637.1875858280637, 642.2646070249538, 644.6583310845259, 650.7169381319046, 4056.269871423172, 4088.4889388826396, 4149.688773342012, 4170.4995400552125, 4229.411735422799, 55589.166162507594, 58405.70797145987, 63570.0, 67119.32880671228, 69804.65097674479, 56037.0, 57636.0, 58921.0, 59744.40255597388, 61146.0, 51841.7407912958, 51922.0, 52068.479315206365, 52198.0, 52497.47502524926, 8129.430939834391, 8347.54088525137, 8357.373197010127, 8433.241008309282, 8545.74362769118, 36469.81765091157, 36897.0, 37393.25213495769, 37618.24763504769, 37852.24295514129, 45323.77338113288, 45759.313610295205, 45821.0, 46140.53859461497, 47337.52662473331, 9889.50552472388, 10014.499275036365, 10183.236257280585, 10235.23235757336, 10344.689659310232, 11642.825357619811, 11686.474108665301, 11705.297682139098, 11997.160198786001, 11999.700007499883, 10547.789044219226, 10580.841287380541, 10672.62645807393, 11126.443677816238, 11154.665360039211, 10763.46182690878, 10827.458627068772, 10984.121270298518, 11139.554417823521, 11257.943710281395, 10933.289336193122, 11099.334039957628, 11167.218294719616, 11176.131621825489, 11202.775944480902, 9058.728238152866, 9211.585478653611, 9359.15767580921, 9592.36929721935, 9809.656662016796, 8689.739307820775, 9220.815583688423, 9229.49237791928, 9286.907130928605, 9341.532923353941], "value": 6259.344416988397, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1582.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 117.0, 117.0, 117.0, 118.0, 116.0, 117.0, 118.0, 116.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 135.0, 135.0, 178.0, 130.0, 130.0, 128.0, 130.0, 150.0, 128.0], "value": 140.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 165.0, 174.0, 162.0, 163.0, 162.0, 166.0, 163.0, 163.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 110.0, 78.0, 78.0, 78.0, 77.0, 96.0, 80.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 105.0, 84.0, 85.0, 85.0, 106.0, 85.0, 85.0, 116.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 122.0, 119.0, 117.0, 121.0, 118.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 151.0, 151.0, 151.0, 152.0, 151.0, 153.0, 151.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 64.0, 63.0, 66.0, 65.0, 64.0, 63.0, 63.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 67.0, 68.0, 68.0, 67.0, 69.0, 69.0, 69.0], "value": 68.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 92.0, 86.0, 86.0, 86.0, 87.0, 89.0, 90.0, 86.0, 87.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 136.0, 138.0, 151.0, 141.0, 139.0, 141.0, 154.0, 185.0, 142.0], "value": 146.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 178.0, 188.0, 178.0, 180.0, 180.0, 185.0, 186.0, 181.0], "value": 182.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 74.0, 69.0, 76.0, 72.0, 73.0, 71.0, 71.0, 70.0], "value": 71.6, "unit": "score"}]}]} 19:25:47 INFO - Return code: 0 19:25:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:25:47 ERROR - # TBPL SUCCESS # 19:25:47 INFO - Running post-action listener: _resource_record_post_action 19:25:47 INFO - [mozharness: 2017-01-04 03:25:47.707506Z] Finished run-tests step (success) 19:25:47 INFO - Running post-run listener: _resource_record_post_run 19:25:47 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 399396864; Read time: 16; Write time: 251072 19:25:47 INFO - TinderboxPrint: CPU usage
13.5% 19:25:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 19:25:47 INFO - TinderboxPrint: I/O write bytes / time
399,396,864 / 251,072 19:25:47 INFO - TinderboxPrint: CPU idle
8,282.3 (86.5%) 19:25:47 INFO - TinderboxPrint: CPU user
1,233.2 (12.9%) 19:25:47 INFO - TinderboxPrint: Swap in / out
0 / 0 19:25:47 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 116047872; Read time: 0; Write time: 80048 19:25:47 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282402816; Read time: 16; Write time: 171000 19:25:48 INFO - Running post-run listener: _upload_blobber_files 19:25:48 INFO - Blob upload gear active. 19:25:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:25:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:25:48 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'] 19:25:48 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 19:25:48 INFO - (blobuploader) - INFO - Open directory for files ... 19:25:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:25:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:25:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:49 INFO - (blobuploader) - INFO - Done attempting. 19:25:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:25:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:25:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:50 INFO - (blobuploader) - INFO - Done attempting. 19:25:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:25:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:25:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:51 INFO - (blobuploader) - INFO - Done attempting. 19:25:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:25:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:25:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:54 INFO - (blobuploader) - INFO - Done attempting. 19:25:54 INFO - (blobuploader) - INFO - Iteration through files over. 19:25:54 INFO - Return code: 0 19:25:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:25:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:25:54 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8393ed7e6211e5d6854bdcf419a0f9cb17cfbf64cd85fa2ee2067b756df1c5dcadfff1c0ce8251df9d03b824676351ebb95ef7c34e4185af718af200d25e6d9d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b46839841c5ce8551422b695a4b6b26bdcca9283552dd43ee6e7680e15d90502c8f2b9930fc0dff94083c0d0fa6f24e5446a2725e9e404abcb7f54cbda8c1f77", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/696e0e24fd2c913d4525cc985384e57b3012f4533a9b8ac321e907cce0dc54f13abce942bebf3a14dfe880452a664e3b5fe0c23d75a62ec8449dabb230c805f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d44baaa8b965d77edd2e754b5b667915c70a1261300e7f66779aa2c40ad2d158f935730ec0ecf83bb960f0c4447615d893c530159507667109a459a12d37086"} 19:25:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:25:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:25:54 INFO - Contents: 19:25:54 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8393ed7e6211e5d6854bdcf419a0f9cb17cfbf64cd85fa2ee2067b756df1c5dcadfff1c0ce8251df9d03b824676351ebb95ef7c34e4185af718af200d25e6d9d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b46839841c5ce8551422b695a4b6b26bdcca9283552dd43ee6e7680e15d90502c8f2b9930fc0dff94083c0d0fa6f24e5446a2725e9e404abcb7f54cbda8c1f77", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/696e0e24fd2c913d4525cc985384e57b3012f4533a9b8ac321e907cce0dc54f13abce942bebf3a14dfe880452a664e3b5fe0c23d75a62ec8449dabb230c805f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d44baaa8b965d77edd2e754b5b667915c70a1261300e7f66779aa2c40ad2d158f935730ec0ecf83bb960f0c4447615d893c530159507667109a459a12d37086"} 19:25:54 INFO - Running post-run listener: copy_logs_to_upload_dir 19:25:54 INFO - Copying logs to upload dir... 19:25:54 INFO - mkdir: /builds/slave/test/build/upload/logs 19:25:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.593163 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-01-03 19:25:53.714638) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-03 19:25:53.718441) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698 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/8393ed7e6211e5d6854bdcf419a0f9cb17cfbf64cd85fa2ee2067b756df1c5dcadfff1c0ce8251df9d03b824676351ebb95ef7c34e4185af718af200d25e6d9d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b46839841c5ce8551422b695a4b6b26bdcca9283552dd43ee6e7680e15d90502c8f2b9930fc0dff94083c0d0fa6f24e5446a2725e9e404abcb7f54cbda8c1f77", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/696e0e24fd2c913d4525cc985384e57b3012f4533a9b8ac321e907cce0dc54f13abce942bebf3a14dfe880452a664e3b5fe0c23d75a62ec8449dabb230c805f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d44baaa8b965d77edd2e754b5b667915c70a1261300e7f66779aa2c40ad2d158f935730ec0ecf83bb960f0c4447615d893c530159507667109a459a12d37086"} build_url:https://queue.taskcluster.net/v1/task/G6xocfjFQ8upFN4_wB7OlA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/G6xocfjFQ8upFN4_wB7OlA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8393ed7e6211e5d6854bdcf419a0f9cb17cfbf64cd85fa2ee2067b756df1c5dcadfff1c0ce8251df9d03b824676351ebb95ef7c34e4185af718af200d25e6d9d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b46839841c5ce8551422b695a4b6b26bdcca9283552dd43ee6e7680e15d90502c8f2b9930fc0dff94083c0d0fa6f24e5446a2725e9e404abcb7f54cbda8c1f77", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/696e0e24fd2c913d4525cc985384e57b3012f4533a9b8ac321e907cce0dc54f13abce942bebf3a14dfe880452a664e3b5fe0c23d75a62ec8449dabb230c805f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d44baaa8b965d77edd2e754b5b667915c70a1261300e7f66779aa2c40ad2d158f935730ec0ecf83bb960f0c4447615d893c530159507667109a459a12d37086"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-03 19:25:53.742820) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 19:25:53.743125) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1483498890.599554-377318698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004744 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 19:25:53.825833) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-03 19:25:53.826164) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-03 19:25:53.826469) ========= ========= Total master_lag: 0.16 =========