builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-082 starttime: 1490614245.96 results: success (0) revision: 9577ddeaafd85554c2a855f385a87472a089d5c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 04:30:45.963305) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 04:30:45.963841) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 04:30:45.964174) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 04:30:46.390451) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 04:30:46.391090) ========= 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=51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-27 04:30:48-- 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% 54.8M=0s 2017-03-27 04:30:48 (54.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.207349 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 04:30:46.717630) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 04:30:46.717991) ========= 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=51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015170 ========= master_lag: 0.27 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 04:30:47.003500) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-27 04:30:47.003906) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9577ddeaafd85554c2a855f385a87472a089d5c0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 9577ddeaafd85554c2a855f385a87472a089d5c0 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-27 04:30:48,765 truncating revision to first 12 chars 2017-03-27 04:30:48,765 Setting DEBUG logging. 2017-03-27 04:30:48,765 attempt 1/10 2017-03-27 04:30:48,765 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9577ddeaafd8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-27 04:30:50,717 unpacking tar archive at: mozilla-central-9577ddeaafd8/testing/mozharness/ program finished with exit code 0 elapsedTime=2.346588 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-27 04:30:49.482168) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 04:30:49.482564) ========= script_repo_revision: 9577ddeaafd85554c2a855f385a87472a089d5c0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 04:30:49.483005) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 04:30:49.483329) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 04:30:50.000941) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-03-27 04:30:50.001428) ========= /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=51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:30:51 INFO - MultiFileLogger online at 20170327 04:30:51 in /builds/slave/test 04:30:51 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 04:30:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:30:51 INFO - {'append_to_log': False, 04:30:51 INFO - 'base_work_dir': '/builds/slave/test', 04:30:51 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:30:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:30:51 INFO - 'branch': 'Firefox-Non-PGO', 04:30:51 INFO - 'buildbot_json_path': 'buildprops.json', 04:30:51 INFO - 'config_files': ('talos/linux_config.py',), 04:30:51 INFO - 'default_actions': ('clobber', 04:30:51 INFO - 'read-buildbot-config', 04:30:51 INFO - 'download-and-extract', 04:30:51 INFO - 'populate-webroot', 04:30:51 INFO - 'create-virtualenv', 04:30:51 INFO - 'install', 04:30:51 INFO - 'run-tests'), 04:30:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:30:51 INFO - 'download_minidump_stackwalk': True, 04:30:51 INFO - 'download_symbols': 'ondemand', 04:30:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:30:51 INFO - 'tooltool.py': '/tools/tooltool.py', 04:30:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:30:51 INFO - '/tools/misc-python/virtualenv.py')}, 04:30:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:30:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:30:51 INFO - 'gecko_profile': False, 04:30:51 INFO - 'gecko_profile_interval': 0, 04:30:51 INFO - 'installer_path': 'installer.exe', 04:30:51 INFO - 'log_level': 'info', 04:30:51 INFO - 'log_name': 'talos', 04:30:51 INFO - 'log_to_console': True, 04:30:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:30:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:30:51 INFO - 'opt_config_files': (), 04:30:51 INFO - 'pip_index': False, 04:30:51 INFO - 'suite': 'dromaeojs-e10s', 04:30:51 INFO - 'system_bits': '32', 04:30:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:30:51 INFO - 'title': 'talos-linux64-ix-082', 04:30:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:30:51 INFO - 'use_talos_json': True, 04:30:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:30:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:30:51 INFO - 'work_dir': 'build'} 04:30:51 INFO - [mozharness: 2017-03-27 11:30:51.852443Z] Running clobber step. 04:30:51 INFO - Running pre-action listener: _resource_record_pre_action 04:30:51 INFO - Running main action method: clobber 04:30:51 INFO - rmtree: /builds/slave/test/build 04:30:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:30:52 INFO - Running post-action listener: _resource_record_post_action 04:30:52 INFO - [mozharness: 2017-03-27 11:30:52.808149Z] Finished clobber step (success) 04:30:52 INFO - [mozharness: 2017-03-27 11:30:52.808253Z] Running read-buildbot-config step. 04:30:52 INFO - Running pre-action listener: _resource_record_pre_action 04:30:52 INFO - Running main action method: read_buildbot_config 04:30:52 INFO - Using buildbot properties: 04:30:52 INFO - { 04:30:52 INFO - "project": "", 04:30:52 INFO - "product": "firefox", 04:30:52 INFO - "who": "cbook@mozilla.com", 04:30:52 INFO - "installer_path": "public/build/target.tar.bz2", 04:30:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:30:52 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:30:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:30:52 INFO - "stage_platform": "linux64", 04:30:52 INFO - "basedir": "/builds/slave/test", 04:30:52 INFO - "buildnumber": 772, 04:30:52 INFO - "platform": "ubuntu64_hw", 04:30:52 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:30:52 INFO - "slavebuilddir": "test", 04:30:52 INFO - "taskId": "F4xy9c_OSquMlH2cmuo5pQ", 04:30:52 INFO - "branch": "mozilla-central", 04:30:52 INFO - "script_repo_revision": "production", 04:30:52 INFO - "revision": "9577ddeaafd85554c2a855f385a87472a089d5c0", 04:30:52 INFO - "slavename": "talos-linux64-ix-082", 04:30:52 INFO - "repo_path": "mozilla-central" 04:30:52 INFO - } 04:30:52 INFO - Finding installer, test and symbols from parent task. 04:30:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F4xy9c_OSquMlH2cmuo5pQ'}, attempt #1 04:30:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F4xy9c_OSquMlH2cmuo5pQ'}, attempt #1 04:30:53 INFO - Task dependencies: NHWnFCYqQ9O1R46PMmJ_dQ 04:30:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ'}, attempt #1 04:30:54 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.tar.bz2 04:30:54 INFO - Set test_url: https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/test_packages.json 04:30:54 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.crashreporter-symbols.zip 04:30:54 INFO - Running post-action listener: _resource_record_post_action 04:30:54 INFO - [mozharness: 2017-03-27 11:30:54.539122Z] Finished read-buildbot-config step (success) 04:30:54 INFO - [mozharness: 2017-03-27 11:30:54.539342Z] Running download-and-extract step. 04:30:54 INFO - Running pre-action listener: _resource_record_pre_action 04:30:54 INFO - Running main action method: download_and_extract 04:30:54 INFO - mkdir: /builds/slave/test/build/tests 04:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:54 INFO - trying https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.test_packages.json 04:30:54 INFO - Downloading https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:30:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:30:55 INFO - Downloaded 986 bytes. 04:30:55 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:30:55 INFO - Using the following test package requirements: 04:30:55 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:30:55 INFO - u'common': [u'target.common.tests.zip'], 04:30:55 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:30:55 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:30:55 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:30:55 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:30:55 INFO - u'mozbase': [u'target.common.tests.zip'], 04:30:55 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:30:55 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:30:55 INFO - u'web-platform': [u'target.common.tests.zip', 04:30:55 INFO - u'target.web-platform.tests.zip'], 04:30:55 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:30:55 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:30:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.common.tests.zip 04:30:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:30:55 INFO - Fetch https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.common.tests.zip into memory 04:30:56 INFO - Expected file size: 58140496 04:30:56 INFO - Obtained file size: 58140496 04:31:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:31:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.common.tests.zip 04:31:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:31:06 INFO - Fetch https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.common.tests.zip into memory 04:31:07 INFO - Expected file size: 58140496 04:31:07 INFO - Obtained file size: 58140496 04:31:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.talos.tests.zip 04:31:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:31:17 INFO - Fetch https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.talos.tests.zip into memory 04:31:18 INFO - Expected file size: 14404171 04:31:18 INFO - Obtained file size: 14404171 04:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:19 INFO - trying https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.tar.bz2 04:31:19 INFO - Downloading https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:31:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:31:20 INFO - Downloaded 62583801 bytes. 04:31:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.tar.bz2 04:31:20 INFO - mkdir: /builds/slave/test/properties 04:31:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:31:20 INFO - Writing to file /builds/slave/test/properties/build_url 04:31:20 INFO - Contents: 04:31:20 INFO - build_url:https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.tar.bz2 04:31:20 INFO - Running post-action listener: _resource_record_post_action 04:31:20 INFO - Running post-action listener: set_extra_try_arguments 04:31:20 INFO - [mozharness: 2017-03-27 11:31:20.520864Z] Finished download-and-extract step (success) 04:31:20 INFO - [mozharness: 2017-03-27 11:31:20.520960Z] Running populate-webroot step. 04:31:20 INFO - Running pre-action listener: _resource_record_pre_action 04:31:20 INFO - Running main action method: populate_webroot 04:31:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:31:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:31:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:31:20 INFO - '--tppagecycles', 04:31:20 INFO - '7'], 04:31:20 INFO - 'tests': ['tsvgm']}}, 04:31:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:31:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:31:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:31:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:31:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:31:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:31:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:31:20 INFO - 'talos_options': ['--disable-e10s'], 04:31:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:31:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:31:20 INFO - 'talos_options': ['--disable-e10s'], 04:31:20 INFO - 'tests': ['damp', 'tps']}, 04:31:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:31:20 INFO - 'tests': ['damp', 'tps']}, 04:31:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:31:20 INFO - 'tests': ['dromaeo_dom']}, 04:31:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:31:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:31:20 INFO - 'tests': ['basic_compositor_video']}, 04:31:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:31:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:31:20 INFO - 'tests': ['a11yr', 04:31:20 INFO - 'ts_paint', 04:31:20 INFO - 'tpaint', 04:31:20 INFO - 'sessionrestore', 04:31:20 INFO - 'sessionrestore_no_auto_restore', 04:31:20 INFO - 'tabpaint']}, 04:31:20 INFO - 'other-e10s': {'tests': ['a11yr', 04:31:20 INFO - 'ts_paint', 04:31:20 INFO - 'tpaint', 04:31:20 INFO - 'sessionrestore', 04:31:20 INFO - 'sessionrestore_no_auto_restore', 04:31:20 INFO - 'tabpaint']}, 04:31:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:31:20 INFO - 'ts_paint', 04:31:20 INFO - 'tpaint', 04:31:20 INFO - 'sessionrestore', 04:31:20 INFO - 'sessionrestore_no_auto_restore', 04:31:20 INFO - 'tabpaint']}, 04:31:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:31:20 INFO - 'ts_paint', 04:31:20 INFO - 'tpaint', 04:31:20 INFO - 'sessionrestore', 04:31:20 INFO - 'sessionrestore_no_auto_restore', 04:31:20 INFO - 'tabpaint']}, 04:31:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:31:20 INFO - 'tests': ['a11yr', 04:31:20 INFO - 'ts_paint', 04:31:20 INFO - 'tpaint', 04:31:20 INFO - 'sessionrestore', 04:31:20 INFO - 'sessionrestore_no_auto_restore', 04:31:20 INFO - 'tabpaint']}, 04:31:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:31:20 INFO - 'tests': ['a11yr', 04:31:20 INFO - 'ts_paint', 04:31:20 INFO - 'tpaint', 04:31:20 INFO - 'sessionrestore', 04:31:20 INFO - 'sessionrestore_no_auto_restore', 04:31:20 INFO - 'tabpaint']}, 04:31:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:31:20 INFO - 'tests': ['tsvgx', 04:31:20 INFO - 'tsvgr_opacity', 04:31:20 INFO - 'tart', 04:31:20 INFO - 'tscrollx', 04:31:20 INFO - 'cart', 04:31:20 INFO - 'tsvg_static']}, 04:31:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:31:20 INFO - 'tsvgr_opacity', 04:31:20 INFO - 'tart', 04:31:20 INFO - 'tscrollx', 04:31:20 INFO - 'cart', 04:31:20 INFO - 'tsvg_static']}, 04:31:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:31:20 INFO - 'talos_options': ['--disable-e10s'], 04:31:20 INFO - 'tests': ['tp5o']}, 04:31:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:31:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:31:20 INFO - 'talos_options': ['--disable-e10s', 04:31:20 INFO - '--xperf_path', 04:31:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:20 INFO - 'tests': ['tp5n']}, 04:31:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:31:20 INFO - 'talos_options': ['--xperf_path', 04:31:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:20 INFO - 'tests': ['tp5n']}}, 04:31:20 INFO - 'talos.zip': {'path': '', 04:31:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:31:20 INFO - Running post-action listener: _resource_record_post_action 04:31:20 INFO - [mozharness: 2017-03-27 11:31:20.534117Z] Finished populate-webroot step (success) 04:31:20 INFO - [mozharness: 2017-03-27 11:31:20.534206Z] Running create-virtualenv step. 04:31:20 INFO - Running pre-action listener: _resource_record_pre_action 04:31:20 INFO - Running main action method: create_virtualenv 04:31:20 INFO - Creating virtualenv /builds/slave/test/build/venv 04:31:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:31:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:31:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:31:20 INFO - Using real prefix '/usr' 04:31:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:31:21 INFO - Installing distribute.............................................................................................................................................................................................done. 04:31:23 INFO - Installing pip.................done. 04:31:23 INFO - Return code: 0 04:31:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:31:23 INFO - Reading from file tmpfile_stdout 04:31:23 INFO - Output received: 04:31:23 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:31:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:31:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258d290>, '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 0x258db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258e040>, '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': '51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:31:23 INFO - Using env: {'DISPLAY': ':0', 04:31:23 INFO - 'HOME': '/home/cltbld', 04:31:23 INFO - 'LANG': 'en_US.UTF-8', 04:31:23 INFO - 'LANGUAGE': 'en_US:en', 04:31:23 INFO - 'LOGNAME': 'cltbld', 04:31:23 INFO - 'MAIL': '/var/mail/cltbld', 04:31:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:23 INFO - 'MOZ_NO_REMOTE': '1', 04:31:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:23 INFO - 'NO_EM_RESTART': '1', 04:31:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:23 INFO - 'PWD': '/builds/slave/test', 04:31:23 INFO - 'SHELL': '/bin/bash', 04:31:23 INFO - 'SHLVL': '1', 04:31:23 INFO - 'TERM': 'linux', 04:31:23 INFO - 'TMOUT': '86400', 04:31:23 INFO - 'USER': 'cltbld', 04:31:23 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206', 04:31:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:23 INFO - '_': '/tools/buildbot/bin/python'} 04:31:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:31:23 INFO - Cleaning up... 04:31:23 INFO - Return code: 0 04:31:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:31:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258d290>, '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 0x258db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258e040>, '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': '51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:31:23 INFO - Using env: {'DISPLAY': ':0', 04:31:23 INFO - 'HOME': '/home/cltbld', 04:31:23 INFO - 'LANG': 'en_US.UTF-8', 04:31:23 INFO - 'LANGUAGE': 'en_US:en', 04:31:23 INFO - 'LOGNAME': 'cltbld', 04:31:23 INFO - 'MAIL': '/var/mail/cltbld', 04:31:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:23 INFO - 'MOZ_NO_REMOTE': '1', 04:31:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:23 INFO - 'NO_EM_RESTART': '1', 04:31:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:23 INFO - 'PWD': '/builds/slave/test', 04:31:23 INFO - 'SHELL': '/bin/bash', 04:31:23 INFO - 'SHLVL': '1', 04:31:23 INFO - 'TERM': 'linux', 04:31:23 INFO - 'TMOUT': '86400', 04:31:23 INFO - 'USER': 'cltbld', 04:31:23 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206', 04:31:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:23 INFO - '_': '/tools/buildbot/bin/python'} 04:31:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:24 INFO - Downloading/unpacking psutil>=3.1.1 04:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:31:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:30 INFO - Installing collected packages: psutil 04:31:30 INFO - Running setup.py install for psutil 04:31:30 INFO - building 'psutil._psutil_linux' extension 04:31:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:31:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:31:30 INFO - building 'psutil._psutil_posix' extension 04:31:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:31:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:31:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:30 INFO - Successfully installed psutil 04:31:30 INFO - Cleaning up... 04:31:30 INFO - Return code: 0 04:31:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:31: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')]} 04:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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')]} 04:31:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:31 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 0x22f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258d290>, '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 0x258db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258e040>, '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': '51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:31:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:31:31 INFO - Using env: {'DISPLAY': ':0', 04:31:31 INFO - 'HOME': '/home/cltbld', 04:31:31 INFO - 'LANG': 'en_US.UTF-8', 04:31:31 INFO - 'LANGUAGE': 'en_US:en', 04:31:31 INFO - 'LOGNAME': 'cltbld', 04:31:31 INFO - 'MAIL': '/var/mail/cltbld', 04:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:31 INFO - 'MOZ_NO_REMOTE': '1', 04:31:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:31 INFO - 'NO_EM_RESTART': '1', 04:31:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:31 INFO - 'PWD': '/builds/slave/test', 04:31:31 INFO - 'SHELL': '/bin/bash', 04:31:31 INFO - 'SHLVL': '1', 04:31:31 INFO - 'TERM': 'linux', 04:31:31 INFO - 'TMOUT': '86400', 04:31:31 INFO - 'USER': 'cltbld', 04:31:31 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206', 04:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:31 INFO - '_': '/tools/buildbot/bin/python'} 04:31:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:31:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:31:35 INFO - Installing collected packages: mozsystemmonitor 04:31:35 INFO - Running setup.py install for mozsystemmonitor 04:31:36 INFO - Successfully installed mozsystemmonitor 04:31:36 INFO - Cleaning up... 04:31:36 INFO - Return code: 0 04:31:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258d290>, '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 0x258db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258e040>, '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': '51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:31:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:31:36 INFO - Using env: {'DISPLAY': ':0', 04:31:36 INFO - 'HOME': '/home/cltbld', 04:31:36 INFO - 'LANG': 'en_US.UTF-8', 04:31:36 INFO - 'LANGUAGE': 'en_US:en', 04:31:36 INFO - 'LOGNAME': 'cltbld', 04:31:36 INFO - 'MAIL': '/var/mail/cltbld', 04:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:36 INFO - 'MOZ_NO_REMOTE': '1', 04:31:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:36 INFO - 'NO_EM_RESTART': '1', 04:31:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:36 INFO - 'PWD': '/builds/slave/test', 04:31:36 INFO - 'SHELL': '/bin/bash', 04:31:36 INFO - 'SHLVL': '1', 04:31:36 INFO - 'TERM': 'linux', 04:31:36 INFO - 'TMOUT': '86400', 04:31:36 INFO - 'USER': 'cltbld', 04:31:36 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206', 04:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:36 INFO - '_': '/tools/buildbot/bin/python'} 04:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:36 INFO - Downloading/unpacking jsonschema==2.5.1 04:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:31:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:40 INFO - Downloading functools32-3.2.3-2.tar.gz 04:31:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:31:40 INFO - warning: no files found matching '*.txt' 04:31:40 INFO - no previously-included directories found matching 'build' 04:31:40 INFO - no previously-included directories found matching 'dist' 04:31:40 INFO - no previously-included directories found matching '.git*' 04:31:40 INFO - Installing collected packages: jsonschema, functools32 04:31:40 INFO - Running setup.py install for functools32 04:31:41 INFO - warning: no files found matching '*.txt' 04:31:41 INFO - no previously-included directories found matching 'build' 04:31:41 INFO - no previously-included directories found matching 'dist' 04:31:41 INFO - no previously-included directories found matching '.git*' 04:31:41 INFO - Successfully installed jsonschema functools32 04:31:41 INFO - Cleaning up... 04:31:41 INFO - Return code: 0 04:31:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:41 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 0x22f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258d290>, '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 0x258db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258e040>, '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': '51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:31:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:31:41 INFO - Using env: {'DISPLAY': ':0', 04:31:41 INFO - 'HOME': '/home/cltbld', 04:31:41 INFO - 'LANG': 'en_US.UTF-8', 04:31:41 INFO - 'LANGUAGE': 'en_US:en', 04:31:41 INFO - 'LOGNAME': 'cltbld', 04:31:41 INFO - 'MAIL': '/var/mail/cltbld', 04:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:41 INFO - 'MOZ_NO_REMOTE': '1', 04:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:41 INFO - 'NO_EM_RESTART': '1', 04:31:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:41 INFO - 'PWD': '/builds/slave/test', 04:31:41 INFO - 'SHELL': '/bin/bash', 04:31:41 INFO - 'SHLVL': '1', 04:31:41 INFO - 'TERM': 'linux', 04:31:41 INFO - 'TMOUT': '86400', 04:31:41 INFO - 'USER': 'cltbld', 04:31:41 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206', 04:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:41 INFO - '_': '/tools/buildbot/bin/python'} 04:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:31:41 INFO - Cleaning up... 04:31:41 INFO - Return code: 0 04:31:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:41 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 0x22f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258d290>, '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 0x258db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258e040>, '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': '51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:31:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:31:41 INFO - Using env: {'DISPLAY': ':0', 04:31:41 INFO - 'HOME': '/home/cltbld', 04:31:41 INFO - 'LANG': 'en_US.UTF-8', 04:31:41 INFO - 'LANGUAGE': 'en_US:en', 04:31:41 INFO - 'LOGNAME': 'cltbld', 04:31:41 INFO - 'MAIL': '/var/mail/cltbld', 04:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:41 INFO - 'MOZ_NO_REMOTE': '1', 04:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:41 INFO - 'NO_EM_RESTART': '1', 04:31:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:41 INFO - 'PWD': '/builds/slave/test', 04:31:41 INFO - 'SHELL': '/bin/bash', 04:31:41 INFO - 'SHLVL': '1', 04:31:41 INFO - 'TERM': 'linux', 04:31:41 INFO - 'TMOUT': '86400', 04:31:41 INFO - 'USER': 'cltbld', 04:31:41 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206', 04:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:41 INFO - '_': '/tools/buildbot/bin/python'} 04:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:41 INFO - Downloading/unpacking blobuploader==1.2.4 04:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:45 INFO - Downloading blobuploader-1.2.4.tar.gz 04:31:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:31:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:31:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:46 INFO - Downloading docopt-0.6.1.tar.gz 04:31:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:31:46 INFO - Installing collected packages: blobuploader, requests, docopt 04:31:46 INFO - Running setup.py install for blobuploader 04:31:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:31:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:31:46 INFO - Running setup.py install for requests 04:31:46 INFO - Running setup.py install for docopt 04:31:46 INFO - Successfully installed blobuploader requests docopt 04:31:46 INFO - Cleaning up... 04:31:46 INFO - Return code: 0 04:31:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31: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')]} 04:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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')]} 04:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:47 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 0x22f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258d290>, '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 0x258db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258e040>, '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': '51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:47 INFO - Using env: {'DISPLAY': ':0', 04:31:47 INFO - 'HOME': '/home/cltbld', 04:31:47 INFO - 'LANG': 'en_US.UTF-8', 04:31:47 INFO - 'LANGUAGE': 'en_US:en', 04:31:47 INFO - 'LOGNAME': 'cltbld', 04:31:47 INFO - 'MAIL': '/var/mail/cltbld', 04:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:47 INFO - 'MOZ_NO_REMOTE': '1', 04:31:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:47 INFO - 'NO_EM_RESTART': '1', 04:31:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:47 INFO - 'PWD': '/builds/slave/test', 04:31:47 INFO - 'SHELL': '/bin/bash', 04:31:47 INFO - 'SHLVL': '1', 04:31:47 INFO - 'TERM': 'linux', 04:31:47 INFO - 'TMOUT': '86400', 04:31:47 INFO - 'USER': 'cltbld', 04:31:47 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206', 04:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:47 INFO - '_': '/tools/buildbot/bin/python'} 04:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:47 INFO - Running setup.py (path:/tmp/pip-oMY8L0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:47 INFO - Running setup.py (path:/tmp/pip-NnsfaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:47 INFO - Running setup.py (path:/tmp/pip-RKOc90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:47 INFO - Running setup.py (path:/tmp/pip-gr5D8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:47 INFO - Running setup.py (path:/tmp/pip-UynQRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:47 INFO - Running setup.py (path:/tmp/pip-1T8mlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:48 INFO - Running setup.py (path:/tmp/pip-PNHl1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:48 INFO - Running setup.py (path:/tmp/pip-6f8Dxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:48 INFO - Running setup.py (path:/tmp/pip-qvnEzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:48 INFO - Running setup.py (path:/tmp/pip-nUpOvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:48 INFO - Running setup.py (path:/tmp/pip-cFDYCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:48 INFO - Running setup.py (path:/tmp/pip-zXfAsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:48 INFO - Running setup.py (path:/tmp/pip-vP8ENd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:48 INFO - Running setup.py (path:/tmp/pip-YUo504-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:48 INFO - Running setup.py (path:/tmp/pip-a6dzVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:48 INFO - Running setup.py (path:/tmp/pip-IRqFhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:48 INFO - Running setup.py (path:/tmp/pip-RVCYXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:31:48 INFO - Running setup.py install for manifestparser 04:31:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:31:48 INFO - Running setup.py install for mozcrash 04:31:49 INFO - Running setup.py install for mozdebug 04:31:49 INFO - Running setup.py install for mozdevice 04:31:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:31:49 INFO - Running setup.py install for mozfile 04:31:49 INFO - Running setup.py install for mozhttpd 04:31:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:31:49 INFO - Running setup.py install for mozinfo 04:31:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:31:49 INFO - Running setup.py install for mozInstall 04:31:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:31:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:31:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:31:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:31:49 INFO - Running setup.py install for mozleak 04:31:49 INFO - Running setup.py install for mozlog 04:31:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:31:49 INFO - Running setup.py install for moznetwork 04:31:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:31:49 INFO - Running setup.py install for mozprocess 04:31:50 INFO - Running setup.py install for mozprofile 04:31:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:31:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:31:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:31:50 INFO - Running setup.py install for mozrunner 04:31:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:31:50 INFO - Running setup.py install for mozscreenshot 04:31:50 INFO - Running setup.py install for moztest 04:31:50 INFO - Running setup.py install for mozversion 04:31:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:31:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:31:50 INFO - Cleaning up... 04:31:50 INFO - Return code: 0 04:31:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:50 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 0x22f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258d290>, '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 0x258db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258e040>, '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': '51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:50 INFO - Using env: {'DISPLAY': ':0', 04:31:50 INFO - 'HOME': '/home/cltbld', 04:31:50 INFO - 'LANG': 'en_US.UTF-8', 04:31:50 INFO - 'LANGUAGE': 'en_US:en', 04:31:50 INFO - 'LOGNAME': 'cltbld', 04:31:50 INFO - 'MAIL': '/var/mail/cltbld', 04:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:50 INFO - 'MOZ_NO_REMOTE': '1', 04:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:50 INFO - 'NO_EM_RESTART': '1', 04:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:50 INFO - 'PWD': '/builds/slave/test', 04:31:50 INFO - 'SHELL': '/bin/bash', 04:31:50 INFO - 'SHLVL': '1', 04:31:50 INFO - 'TERM': 'linux', 04:31:50 INFO - 'TMOUT': '86400', 04:31:50 INFO - 'USER': 'cltbld', 04:31:50 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206', 04:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:50 INFO - '_': '/tools/buildbot/bin/python'} 04:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:51 INFO - Running setup.py (path:/tmp/pip-26haNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:51 INFO - Running setup.py (path:/tmp/pip-rgV6oX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:51 INFO - Running setup.py (path:/tmp/pip-VIQOIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:51 INFO - Running setup.py (path:/tmp/pip-cnFy1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:51 INFO - Running setup.py (path:/tmp/pip-10h8SO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:51 INFO - Running setup.py (path:/tmp/pip-Z17hFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:51 INFO - Running setup.py (path:/tmp/pip-mS3xu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:51 INFO - Running setup.py (path:/tmp/pip-P3fM0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:51 INFO - Running setup.py (path:/tmp/pip-fjaQts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:51 INFO - Running setup.py (path:/tmp/pip-g6K8H_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:51 INFO - Running setup.py (path:/tmp/pip-ZlXnxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:51 INFO - Running setup.py (path:/tmp/pip-s3pfpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:51 INFO - Running setup.py (path:/tmp/pip-oNHm9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:51 INFO - Running setup.py (path:/tmp/pip-lKFDF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:52 INFO - Running setup.py (path:/tmp/pip-ToQb5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:52 INFO - Running setup.py (path:/tmp/pip-mllSY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:52 INFO - Running setup.py (path:/tmp/pip-XeluO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:31:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:57 INFO - Downloading blessings-1.6.tar.gz 04:31:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:31:57 INFO - Installing collected packages: blessings 04:31:57 INFO - Running setup.py install for blessings 04:31:57 INFO - Successfully installed blessings 04:31:57 INFO - Cleaning up... 04:31:57 INFO - Return code: 0 04:31:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:31:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:58 INFO - Reading from file tmpfile_stdout 04:31:58 INFO - Current package versions: 04:31:58 INFO - argparse == 1.2.1 04:31:58 INFO - blessings == 1.6 04:31:58 INFO - blobuploader == 1.2.4 04:31:58 INFO - docopt == 0.6.1 04:31:58 INFO - functools32 == 3.2.3-2 04:31:58 INFO - jsonschema == 2.5.1 04:31:58 INFO - manifestparser == 1.1 04:31:58 INFO - mozInstall == 1.12 04:31:58 INFO - mozcrash == 1.0 04:31:58 INFO - mozdebug == 0.1 04:31:58 INFO - mozdevice == 0.49 04:31:58 INFO - mozfile == 1.2 04:31:58 INFO - mozhttpd == 0.7 04:31:58 INFO - mozinfo == 0.9 04:31:58 INFO - mozleak == 0.1 04:31:58 INFO - mozlog == 3.4 04:31:58 INFO - moznetwork == 0.27 04:31:58 INFO - mozprocess == 0.25 04:31:58 INFO - mozprofile == 0.28 04:31:58 INFO - mozrunner == 6.13 04:31:58 INFO - mozscreenshot == 0.1 04:31:58 INFO - mozsystemmonitor == 0.3 04:31:58 INFO - moztest == 0.8 04:31:58 INFO - mozversion == 1.4 04:31:58 INFO - psutil == 3.1.1 04:31:58 INFO - requests == 1.2.3 04:31:58 INFO - wsgiref == 0.1.2 04:31:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:58 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 0x22f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258d290>, '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 0x258db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258e040>, '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': '51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:31:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:58 INFO - Using env: {'DISPLAY': ':0', 04:31:58 INFO - 'HOME': '/home/cltbld', 04:31:58 INFO - 'LANG': 'en_US.UTF-8', 04:31:58 INFO - 'LANGUAGE': 'en_US:en', 04:31:58 INFO - 'LOGNAME': 'cltbld', 04:31:58 INFO - 'MAIL': '/var/mail/cltbld', 04:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:58 INFO - 'MOZ_NO_REMOTE': '1', 04:31:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:58 INFO - 'NO_EM_RESTART': '1', 04:31:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:58 INFO - 'PWD': '/builds/slave/test', 04:31:58 INFO - 'SHELL': '/bin/bash', 04:31:58 INFO - 'SHLVL': '1', 04:31:58 INFO - 'TERM': 'linux', 04:31:58 INFO - 'TMOUT': '86400', 04:31:58 INFO - 'USER': 'cltbld', 04:31:58 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206', 04:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:58 INFO - '_': '/tools/buildbot/bin/python'} 04:31:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:31:58 INFO - Cleaning up... 04:31:58 INFO - Return code: 0 04:31:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258d290>, '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 0x258db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258e040>, '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': '51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:31:59 INFO - Using env: {'DISPLAY': ':0', 04:31:59 INFO - 'HOME': '/home/cltbld', 04:31:59 INFO - 'LANG': 'en_US.UTF-8', 04:31:59 INFO - 'LANGUAGE': 'en_US:en', 04:31:59 INFO - 'LOGNAME': 'cltbld', 04:31:59 INFO - 'MAIL': '/var/mail/cltbld', 04:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:59 INFO - 'MOZ_NO_REMOTE': '1', 04:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:59 INFO - 'NO_EM_RESTART': '1', 04:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:59 INFO - 'PWD': '/builds/slave/test', 04:31:59 INFO - 'SHELL': '/bin/bash', 04:31:59 INFO - 'SHLVL': '1', 04:31:59 INFO - 'TERM': 'linux', 04:31:59 INFO - 'TMOUT': '86400', 04:31:59 INFO - 'USER': 'cltbld', 04:31:59 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206', 04:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:59 INFO - '_': '/tools/buildbot/bin/python'} 04:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:31:59 INFO - Cleaning up... 04:31:59 INFO - Return code: 0 04:31:59 INFO - Running post-action listener: _resource_record_post_action 04:31:59 INFO - Running post-action listener: _start_resource_monitoring 04:31:59 INFO - Starting resource monitoring. 04:31:59 INFO - [mozharness: 2017-03-27 11:31:59.364482Z] Finished create-virtualenv step (success) 04:31:59 INFO - [mozharness: 2017-03-27 11:31:59.364965Z] Running install step. 04:31:59 INFO - Running pre-action listener: _resource_record_pre_action 04:31:59 INFO - Running main action method: install 04:31:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:59 INFO - Reading from file tmpfile_stdout 04:31:59 INFO - Detecting whether we're running mozinstall >=1.0... 04:31:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:31:59 INFO - Reading from file tmpfile_stdout 04:31:59 INFO - Output received: 04:31:59 INFO - Usage: mozinstall [options] installer 04:31:59 INFO - Options: 04:31:59 INFO - -h, --help show this help message and exit 04:31:59 INFO - -d DEST, --destination=DEST 04:31:59 INFO - Directory to install application into. [default: 04:31:59 INFO - "/builds/slave/test"] 04:31:59 INFO - --app=APP Application being installed. [default: firefox] 04:31:59 INFO - mkdir: /builds/slave/test/build/application 04:31:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:32:15 INFO - Reading from file tmpfile_stdout 04:32:15 INFO - Output received: 04:32:15 INFO - /builds/slave/test/build/application/firefox/firefox 04:32:15 INFO - Running post-action listener: _resource_record_post_action 04:32:15 INFO - [mozharness: 2017-03-27 11:32:15.309151Z] Finished install step (success) 04:32:15 INFO - [mozharness: 2017-03-27 11:32:15.309423Z] Running run-tests step. 04:32:15 INFO - Running pre-action listener: _resource_record_pre_action 04:32:15 INFO - Running main action method: run_tests 04:32:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:32:15 INFO - Python 2.7.3 04:32:15 INFO - Return code: 0 04:32:15 INFO - grabbing minidump binary from tooltool 04:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:15 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 0x258d290>, '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 0x258db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258e040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:32:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:32:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:32:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:32:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:32:15 INFO - Return code: 0 04:32:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:32:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:32:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:32:15 INFO - ENV: RUST_BACKTRACE is now 1 04:32:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:32:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:32:15 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/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--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 04:32:15 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/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-082 --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 04:32:15 INFO - Using env: {'DISPLAY': ':0', 04:32:15 INFO - 'HOME': '/home/cltbld', 04:32:15 INFO - 'LANG': 'en_US.UTF-8', 04:32:15 INFO - 'LANGUAGE': 'en_US:en', 04:32:15 INFO - 'LOGNAME': 'cltbld', 04:32:15 INFO - 'MAIL': '/var/mail/cltbld', 04:32:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:32:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:15 INFO - 'MOZ_NO_REMOTE': '1', 04:32:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:32:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:15 INFO - 'NO_EM_RESTART': '1', 04:32:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:15 INFO - 'PWD': '/builds/slave/test', 04:32:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:32:15 INFO - 'RUST_BACKTRACE': '1', 04:32:15 INFO - 'SHELL': '/bin/bash', 04:32:15 INFO - 'SHLVL': '1', 04:32:15 INFO - 'TERM': 'linux', 04:32:15 INFO - 'TMOUT': '86400', 04:32:15 INFO - 'USER': 'cltbld', 04:32:15 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206', 04:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:15 INFO - '_': '/tools/buildbot/bin/python'} 04:32:15 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/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--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 04:32:15 INFO - mozversion application_buildid: 20170327105736 04:32:15 INFO - mozversion application_changeset: 9577ddeaafd85554c2a855f385a87472a089d5c0 04:32:15 INFO - mozversion application_display_name: Nightly 04:32:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:32:15 INFO - mozversion application_name: Firefox 04:32:15 INFO - mozversion application_remotingname: firefox 04:32:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:32:15 INFO - mozversion application_vendor: Mozilla 04:32:15 INFO - mozversion application_version: 55.0a1 04:32:15 INFO - mozversion platform_buildid: 20170327105736 04:32:15 INFO - mozversion platform_changeset: 9577ddeaafd85554c2a855f385a87472a089d5c0 04:32:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:32:15 INFO - mozversion platform_version: 55.0a1 04:32:15 INFO - using testdate: 1490614335 04:32:15 INFO - actual date: 1490614335 04:32:15 INFO - starting webserver on 'localhost:45285' 04:32:15 INFO - SUITE-START | Running 2 tests 04:32:15 INFO - TEST-START | dromaeo_css 04:32:15 INFO - operating with platform_type : linux_ 04:32:15 INFO - Initialising browser for dromaeo_css test... 04:32:15 INFO - TEST-INFO | started process 4983 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvmjL5u/profile http://localhost:45285/getInfo.html) 04:32:20 INFO - PID 4983 | __metrics Screen width/height:1600/1200 04:32:20 INFO - PID 4983 | colorDepth:24 04:32:20 INFO - PID 4983 | Browser inner width/height: 1024/697 04:32:20 INFO - PID 4983 | __metrics 04:32:20 ERROR - PID 4983 | 1490614340940 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6376:36 < canClose@browser.js:5227:12 < forceQuit@jar:file:///tmp/tmpvmjL5u/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmpvmjL5u/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmpvmjL5u/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmpvmjL5u/profile/extensions/talos-powers@TalosPowersService.js:55:9 04:32:21 ERROR - PID 4983 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 04:32:22 INFO - TEST-INFO | 4983: exit 0 04:32:22 INFO - Browser initialized. 04:32:22 INFO - Running cycle 1/1 for dromaeo_css test... 04:32:22 INFO - TEST-INFO | started process 5117 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvmjL5u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:34 INFO - PID 5117 | RSS: Main: 156049408 04:32:34 INFO - PID 5117 | 04:35:38 INFO - PID 5117 | Cycle 1(1): loaded http://localhost:45285/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45285/tests/dromaeo/cssquery-ext.html) 04:35:40 INFO - PID 5117 | RSS: Main: 165380096 04:35:40 INFO - PID 5117 | 04:37:22 INFO - PID 5117 | ************************* 04:37:22 INFO - PID 5117 | A coding exception was thrown and uncaught in a Task. 04:37:22 INFO - PID 5117 | 04:37:22 ERROR - PID 5117 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:37:22 INFO - PID 5117 | Full stack: 04:37:22 INFO - PID 5117 | ************************* 04:37:22 INFO - PID 5117 | ************************* 04:37:22 INFO - PID 5117 | A coding exception was thrown and uncaught in a Task. 04:37:22 INFO - PID 5117 | 04:37:22 ERROR - PID 5117 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:37:22 INFO - PID 5117 | Full stack: 04:37:22 INFO - PID 5117 | ************************* 04:37:22 INFO - PID 5117 | ************************* 04:37:22 INFO - PID 5117 | A coding exception was thrown and uncaught in a Task. 04:37:22 INFO - PID 5117 | 04:37:22 ERROR - PID 5117 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:37:22 INFO - PID 5117 | Full stack: 04:37:22 INFO - PID 5117 | ************************* 04:37:22 INFO - PID 5117 | ************************* 04:37:22 INFO - PID 5117 | A coding exception was thrown and uncaught in a Task. 04:37:22 INFO - PID 5117 | 04:37:22 ERROR - PID 5117 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:37:22 INFO - PID 5117 | Full stack: 04:37:22 INFO - PID 5117 | ************************* 04:38:42 INFO - PID 5117 | Cycle 1(1): loaded http://localhost:45285/tests/dromaeo/cssquery-ext.html (next: http://localhost:45285/tests/dromaeo/cssquery-jquery.html) 04:38:43 INFO - PID 5117 | RSS: Main: 161742848 04:38:43 INFO - PID 5117 | 04:41:45 INFO - PID 5117 | Cycle 1(1): loaded http://localhost:45285/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45285/tests/dromaeo/cssquery-mootools.html) 04:41:46 INFO - PID 5117 | RSS: Main: 169705472 04:41:46 INFO - PID 5117 | 04:44:47 INFO - PID 5117 | Cycle 1(1): loaded http://localhost:45285/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45285/tests/dromaeo/cssquery-prototype.html) 04:44:48 INFO - PID 5117 | RSS: Main: 161226752 04:44:48 INFO - PID 5117 | 04:47:51 INFO - PID 5117 | Cycle 1(1): loaded http://localhost:45285/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45285/tests/dromaeo/cssquery-yui.html) 04:47:52 INFO - PID 5117 | RSS: Main: 168796160 04:47:52 INFO - PID 5117 | 04:50:54 INFO - PID 5117 | Cycle 1(1): loaded http://localhost:45285/tests/dromaeo/cssquery-yui.html (next: http://localhost:45285/tests/dromaeo/cssquery-dojo.html) 04:50:54 INFO - PID 5117 | RSS: Main: 162480128 04:50:54 INFO - PID 5117 | 04:50:54 INFO - PID 5117 | __start_tp_report 04:50:54 INFO - PID 5117 | _x_x_mozilla_page_load 04:50:55 INFO - PID 5117 | _x_x_mozilla_page_load_details 04:50:55 INFO - PID 5117 | |i|pagename|runs| 04:50:55 INFO - PID 5117 | |0;dojo.html;2702.6891907430645;2722.618833363331;2733.5079685656574;2756.6416365872433;2758.3104223944;5137.460566640505;5298.576113910887;5321.92017119743;5351.625386222966;5362.490563396476;5186.636935414523;5306.867328316794;5337.893242135155;5385.892282154355;5394.514493695567;4861.465238823726;4872.926906096412;4898.216285394337;4933.383327084114;4951.702897826124;4882.414110306768;4929.2359684248995;4940.08608407444;4941;4941.45643979162;4790.664653474223;4833.734144622044;4836.540528649808;4874.46380898101;4912.533309335608;4812.061647978646;4842.515748425165;4844.467108618049;4898.314236006961;4920.729359885205;4766.451858036336;4784.258439941815;4827.275908613701;4846.29728689338;4849.709017458964;5138.588912886998;5189.403218629868;5332.92000619991;5347.6256662033675;5386.515213630752;5671.461211184931;5707.229524014247;5738.741756620962;5747.942520574783;5759.107338362561;5821.214136091616;5829.912551311733;5832.387599302055;5845.7369418376275;5850.853728656775;5191.428942816287;5371.811986580451;5393.460653934614;5397.4062853086125;5402.243685883979;5738.655680659173;5808.041673123887;5813.837232553422;5820.243368362086;5835.445632664975;5562.610617256753;5579.46995035471;5625.746841392147;5653.886922261532;5697.800576979786;5787.826365209051;5791.478766910998;5792.0732682771395;5806.767729290866;5824;5718.971405143031;5734.082546792493;5739.16782066598;5739.626924249994;5742.425757424224;5489.066858633962;5560.221568980346;5671.319441667027;5713.9142912855505;5752.137179423036;4692.389989301369;4695.81216751333;4699.412573428322;4717.080169367009;4739.146953548326;4022.4770779798437;4029.597040295947;4042.9797851011144;4071.572484889103;4083.5303940047274;4796.2805579163405;4853.927191092136;4942.135126352874;4946.554810067111;4974.278729584263;5777.88444231113;5779.479846813807;5784.739686714108;5823.242978412779;5843.03589907669;4873.390826146731;4902.779374928136;4916.06594746997;4916.70499770015;4970.652054356233;4981.476944920803;5039.546440820271;5087.465816089258;5088.974555127201;5092.796288148433;5201.375834899836;5203;5204.921926171186;5205.973970130125;5212.192110222922;5556.749946252347;5591.944080559142;5610.046292130266;5613.859653508532;5620.690862002629;5372.865678358073;5385.649932754359;5431;5435.483629055233;5451.836444906659;5617.213590097472;5687.971560142173;5689.601727879009;5695;5698.943010569841;5569.33168019824;5776.682282474336;5811.070228763378;5815.534757219497;5817.243758311392;5448.101063324507;5563.388027317073;5581.246531718329;5586.245856809279;5638.85902852432;5572.052751032254;5572.554195664256;5579.442055794388;5589.776408943597;5594.692291923983;5429.945700542944;5456.399796022355;5494.2033405155225;5495.587830912617;5572.10846264612;5439.728013599225;5503.724813759216;5507.339119305709;5507.614466987273;5652.576056795675;5342.786288548415;5352.4915133062295;5360.463953604608;5371.40914499397;5371.677699338053 04:50:55 INFO - PID 5117 | |1;ext.html;670.9731610735571;733.5012191709637;754.7018927523627;1056.5034433816109;1068.0601071057467;30240.546391804142;31168.064958051295;31213.219669508275;31224.687753122464;31227.687723122763;32555;32681.836590817013;32923.341533169325;32978.34043319132;33060.504092438576;7219.386352160046;7298.124225092983;7384.0400747902695;7402.7038918443195;7413.518121322124;7335.523190992569;7420.666070026835;7442.590657513834;7446.51597646154;7456.701731930743;7530.359919406857;7593.772186834376;7599.278068583503;7608.35328997036;7620;7490.176080631099;7522.247775222461;7563.054618172729;7581.052368453943;7583.81040473987;7359.227281135457;7360.852782944311;7397.667104980235;7416.258374162595;7432.256774322578;32370.514442283384;32398.838005810056;32510.18724531882;32612.6738732612;32725;2633.486470138324;2640.485105404447;2681.611166380864;2685.368938299498;2687.113252626648;23983.40041498959;24077.518449631083;24270.87864560666;24401.83995574529;24645.137420190207;2800.313923088836;2806.6211061506638;2820.675622303441;2827.759640430566;2830.1368082734757;152546.23726881406;153261.2336938308;153480;153605.46394536024;153676.23161884118;42306;42463.787681062015;42481.787591061846;42522.78738606349;42528.14943701109;43999.340009899875;44191.11617767627;44361;44376.11247775026;44469.777651112185;13273.933630331787;13521.797173042412;13536.932315338361;13599.388027538784;13613.11514751538;10726.785464290671;10783.78432431347;10785.298955567863;10829.620963266249;10859.674209773719;12870.22778633285;13047.934760326138;13181.209127452383;13342.13276137048;13391.933040334736;5510.118381059011;5575.470330318613;5611.242482264842;5612.940947183713;5619.4099619540175;859.1966511311944;882.8146089321315;884.9380543361902;899.8740176375313;928.1692884868005;20366.389008329774;21362.252321168686;21514.677279840816;21554.13783448676;21747.130114795233;967.9128878400978;976.8144052629978;983.2134292566061;999.6251405722854;1003.8193125237382;10720.303180293256;11113.11095112389;11154.498047587878;11154.944225278983;11180.273282236629;237018;239431;239437;239996;240489;38683.41974870379;39313.41029884554;42415;42872.78563607162;42878.571214287454;1222.6698791326291;1244.440001999104;1251.4618713952905;1253.8620751717303;1260.861305256421;21324.89337553302;21526;22524.549509010056;22810.885945570168;24278.15026474065;29272.268193294487;29350.559741603465;29382.706172937997;29418.55872161962;29457;182041;183265;183779.08110459897;183812;184133;26277.605835912094;26427.735722642527;26629;26827.865860670572;26861.328466788487;32137.196570085936;32152.19619509531;32298.677013229568;32443;32544.674553254164;25076.247712568653;25392.619110713724;25988.870055650357;26418;26855.194344169708;25111.49777004486;25399.44407782875;25750.484990300465;26364.340891477867;26412.471750565266;27626.5856012164;28018.71981280161;28220.858895706213;28230;28242.43515129645;24578.38554036092;24849.751502484745;25616.487670246865;25717.871410642827;25954;18406.442803177397;19144.138513766637;19169.233230670616;19336.8066319335;19367.3221437249 04:50:55 INFO - PID 5117 | |2;jquery.html;413.7372768292137;424.3267415283712;433.2631057132235;433.51013354908946;446.3862189489452;17993.91003044986;18297.451076467692;18462.261509539618;18636.62726745464;18674.626507469842;16089.597760056004;16104.194790260499;16784.832151678478;16833.915830420832;16949.237284322204;5564.27664403629;5643.266375371196;5785.681787501686;5820.097884827837;5836.562257830658;5757.453041961007;5848.152017957394;5848.707564621774;5867.530597552207;5874.1776151338845;5622.887542249153;5733.254676891998;5745.454181852718;5761.30864296285;5825.970870145665;5669.036263835137;5676.148577713335;5708.20085188074;5712.8857422851725;5713.771449142029;5120.15517439622;5150.3047088642925;5165.457626949192;5175.378954525481;5179.974100129513;22237.332880013626;22265.554688906293;22350.552988940293;22423.32730018102;22609.77390226093;1577.069528977897;1588.0392362620564;1588.6107903563586;1609.589554663565;1632.6734653069434;13705.588832335046;14309.57071287863;14554.563363099123;14644.487442939553;14928.40286388554;1738.8869723467933;1785.196661502329;1789.5705030792517;1805.6930321845318;1805.7201133824278;81033.08397166972;81237;82351;82761.17238827655;83071.5846420764;11043.503042363112;11163.776724465466;11345.546178152947;11346.716332091764;11406.714832129097;16039.919800401156;16060.839391606169;16063.759043614355;16088.839111608968;16158.576213568058;7536.321731044232;7761.379089672812;7844.725434609762;7973.60131993398;8028.518288902685;7113.608751518716;7186.281371862772;7383.852322953511;7392.112946446461;7395.038644976119;6825;6917.239103698589;6930.826729331807;6994.160700715946;7000.964995174992;2024.574839283767;2031.086011294923;2032.309014934929;2041.2345370486069;2057.567910738732;843.6498852976069;846.2087947768856;877.6752601537472;882.5234373438271;906.805036917066;16144.515664530083;16201.513954581145;16373.099479528502;16740.246688899028;17356.65286694259;893.4326702543931;894.865770134485;900.4732231644562;902.1429641840147;907.0611916666219;8931.464112153291;9062.864057039149;9408.670696525589;9414.152726254533;9573.228952643643;417255;418889;425200;445716;447292;76771;79716;85193;87130;92483.537582313;1074.8925107489188;1102.9558817647205;1113.1095123900848;1122.2144498850837;1125.487903004131;15728;15953.361865525249;16097.034177949361;16861.325546977983;17060.829391705924;36097.27805443824;36185.27629447449;36802.447963281105;37029.44455833111;37081;54063.18905216346;54407.72796135994;54492.18261725998;54771.05819656207;56782.71608641931;7407.111146662435;7482.925170748441;7516.699332026877;7583.544987300779;7622.31399174077;11024.779504410028;11037.11703063769;11076.612318568812;11484.770304593694;11881.346525940811;8671.913280867111;8821.955890220508;9106.95446522763;9265;9370.250379969722;7473.364763995121;7918.802029949297;8292.709755158541;8382.329413646772;8663.913360866563;9091.272698183997;9166.450012999241;9319.86020209684;9445.622175113192;9623.085806848338;7276.272372762682;7294.635268236673;7297.781066568012;7408.851822963618;7706.152323244551;9020.729378118667;9036.864447033431;9369.625214991323;9599.856002159833;9884.406935583887 04:50:55 INFO - PID 5117 | |3;mootools.html;1256.4848412151018;1299.8115273285368;1300.8894243989255;1305.1125234840306;1314.6910476038133;9189.540522973857;9558.808823823529;9564.282678799093;9860.309778315503;10089.798204035915;9805.313628046022;9922.652707155252;9944.701658950244;9991.150752186073;9995.35030223035;2214.7010153629294;2253.9323820285417;2257.932262032142;2258.5369999150216;2267.7278726552836;2084.0934193625744;2155.698202251686;2173.1959175105235;2187.9015444305046;2192.6491761318193;2081.2403472732494;2127.8297736181066;2130.1479408236673;2139.0160526157906;2170.945726356838;2126.234555560005;2128.3508529898377;2129.755078166015;2131.435169680028;2137.657974724052;1818.863585231113;1875.8311751942254;2029.411470673503;2090.822280106193;2096.119629755506;9652.22782177424;9736.853947190797;9747.3664211826;9786.951065244699;9836.213102951746;5382.946170538284;5605.831825045255;5704.77180912763;5705.71471426427;5715.914261286084;3205.6634053424523;3268.199291173654;3310.304835984446;3317.2370354818286;3338.9499157512414;1027.9280450368476;1057.3497299161038;1069.5400977579638;1086.6902932664152;1087.5649740103943;14953.700925981528;14965.326560304813;14986.550403487803;15003.924980375137;15066.849331506764;4770.666053376231;4820.132376172252;4871.2206047032305;4956.851294461172;4978.502149785065;10900.945495272474;10911;10918.290311129751;10942.617008404668;10948.343099413902;5539.19681646159;5600.635958662674;5602.635828671205;5629.887402251932;5637.9718101409235;4859.684120532154;4948.653594248368;5030.798768049311;5077.822276220389;5128.8717782055;3741.887743367649;3874.9031274217805;3880.553736320303;3942.2115576884166;3951.9012024699036;1093.147345070846;1098.2257508456678;1107.2747350485445;1116.6705821782593;1117.1118960426481;698.7554355975368;713.6966789114606;724.5869854183065;734.2730696610317;752.9548227106282;5461.15352120422;5524.392316845144;5670.149477578396;5771.88456230873;5783.4794868461195;539.6411386427982;553.2807350444486;556.8301667991302;559.7816851427947;565.1409857017311;3400.6769356911054;3402.6937575617817;3409.9829500852834;3431;3530.5763308402643;13079.738405231841;13516.729665406638;13636.181829090287;13707.109037912503;13741.312934353242;13015.479380824661;13464;13504.392302346418;13522.661933451545;13559.389827457788;9342.2526197904;9618.134367906781;9622.566984485715;9690.12788849007;9710.563024663907;5646.830595082154;5692.544596432358;5694;5754.280714910637;5828.184054232495;11667.241629294069;11673.883261167619;11864.169508134348;11892.10809189297;11919.284842909454;12149.149559530748;12162.087843411602;12331.69170770702;12344.259344439362;12443.253404795742;7540.434467414856;7639.121501027453;7657.1959944205055;7868.25251601097;7957.084935232522;9331.813363732552;9399.060093990547;9416.62333506652;9422.199113075465;9579.712608621752;8125.431219814793;8127;8161.836763264821;8295.253427191581;8364.581770911553;7849;7855.803604909923;7869.291763741291;7991.4006449515355;8031.718889838828;6827.385535301847;6876.243613202644;6931.064306318583;6951.582905025714;6982.162140543167;5049.469805670352;5115.539601435739;5136.434992150935;5155.355580552431;5222.321098257202;5216.0901768123595;5295.808443100272;5381.461853814587;5398.973005134949;5492.423295554069 04:50:55 INFO - PID 5117 | |4;prototype.html;394.62313490616464;398.1559094719192;400.42339031794216;402.20765092767255;402.48682929265175;5545.833624991252;5607.130894711316;5609.1025435930205;5628.887422251558;5659.745311460983;4871.805127794884;5406.648567843097;5452.454754524546;5524.613501835708;5546.112621980484;4383.780810959455;4387.3857659927635;4394.494633117184;4402.339649052636;4405.207062728708;4406.823727050914;4412.867613971586;4420.4253447052;4428.3800267962515;4430.224710675635;4281.400603915455;4360.258756011485;4384.473863136428;4390.846320378771;4420.20436321462;4374.4094547236355;4392.802323895432;4405.581469760367;4412.477695195153;4417.094495628405;3939.7589759225752;3950.150717595731;3970.9007274818073;3971.9871432784744;3973.1060511384994;5290.153575427913;5388.1648344506275;5413.079776438015;5434.809781657663;5440.863978400532;5047.394312682465;5071.670341427833;5098.1842905135;5103.311053007834;5108.463611320833;5758.366579676274;5808.2449281593545;5812.244408226903;5819.854503637401;5827.854303642401;4228.154369126187;4313.245182093121;4332.1985432695055;4363.105563359503;4380.299152135675;5802.506786923117;6027.5835178733405;6063.514918806485;6102.603330783485;6133.509319254449;4367.606915377632;4452.443444569429;4464.598186163196;4478.776061196927;4503.324501324828;4541.841035563805;4548.545145485491;4551.908961820811;4571;4589.35748995141;4944.431390390079;5060.5951523878;5077.111505486525;5080.840642726826;5083.847484575469;5826.581968483032;5832.387599302097;5833.912491312633;5846.473817356458;5867.8020478839135;1587.7618357246506;1604.9759253611205;1614.5802091456071;1617.7977752780903;1624.3664970661453;1071.8017166824006;1144.2619510415902;1151.0676352154615;1157.6121999130216;1160.2922217447351;5125.461826508237;5132.999065182254;5136.8202112925865;5143.974280128576;5159.871003224949;6053.334133245339;6092.390760923872;6093.969530152321;6100.633961962297;6107.969460152671;4989.351384320015;5079;5094.974525127351;5113.769880355393;5114.820981265712;3185.9362812743616;3223.6615155408813;3233.916637926274;3234.3531293740875;3236.563063986379;5442.8095016675015;5592.4900276925;5619.988402087663;5642;5643.855334972766;6142.416470435302;6152.692365381713;6183.628982261079;6184.073113572914;6188.412100850412;5598.496135347838;5626.043572592669;5629.4652008059165;5635.718214089279;5662.801801936913;5796.855078623068;6037.547183961308;6047.848803779941;6071.726772295346;6083.270007599116;5889.587728858939;5906.940930590639;5915.2310199675485;5924.377940316377;5926.407359264039;5216.747980484733;5413.512783849473;5418.376886658085;5565.276514053147;5613.663180209201;4476.552344765498;4487.102579484182;4502.302143167814;4503.189425903369;4503.909921801611;5912.881742365214;6011.218541589566;6021;6043.456088952015;6060.575759696779;5764.913526297025;5766.500709815395;5793.855153621024;5795.971020144872;5828.562857785768;5771.509421699035;5786.103154011135;5792.536597072309;5801.6519008859605;5825;5499.5325397340075;5658.575606829587;5703.718512594995;5716.485516303553;5717.742701578356;5837.591368604157;5869.178315035983;5875.294964604275;5902.822915312548;5903.144044113666;5574.888502229852;5655.858603534944;5738.569607279387;5747.626404283708;5769.913451298318 04:50:55 INFO - PID 5117 | |5;yui.html;705.4954910069252;705.59428328711;711.1750369571298;718.7448455798192;750.1785544828415;11919.702007449807;11996.46015929283;12047.879521204786;12313.569025084123;13099.14855534392;12444.813327800068;13009.34953252336;13030.022748293868;13031.73936521269;13051.869481305184;831.6423937706784;864.6282098697558;873.1137895036543;873.9512584898116;875.4265955798962;804.5414113955048;836.05943313772;855.0295414704293;855.7218903856241;858.2318824651933;864.8010957479784;865.6537385045968;866.23338345564;868.2793281576309;873.1312344217513;859.1408591408591;859.5186695450568;861.0399404663787;864.597961947691;865.9307255419583;634.2104080419907;640.8654182621608;640.9519286053518;642.9549931504797;643.0482885329739;13720.382582783699;13863.653408664763;14072;14123.929380353033;14226.644333891632;13621.25083120428;14201.928990355085;14305.57083287503;14363.928180359137;14576.125432474086;10739.239452532658;10856.131509479223;10877.292975956538;11065;11488.655340339803;2701.3786829029236;2766.4190519990825;2771.556550951838;2778.70823563527;2834.518131917579;48735.75632121817;60678.089828652606;61184.38815611876;61580;61877.09966405354;10875.45622718861;10879.945600271947;10941.398223097647;11092.893989682902;11202.887971120348;21391.67912481314;21429.142834286766;21431.142754289966;21494.57010859774;21592;6597.86804263912;6651.733930642817;6671.833204169838;6782.660866956632;6919.481038922101;3404.7446441516986;3415;3425.143714071482;3443.3113377324635;3446.9827650861585;3692.2615476904725;3714.272863118663;3741.251749650081;3760.6239376062176;3780.584135745066;634.9777757778455;642.8649983503423;643.1092936283281;647.2944490505278;655.1221363373007;511.53450360172064;515.8014164546677;521.9373675159005;525.8519098030317;533.8131653921097;8235.794105147419;8319.750407487785;8417.747467575982;8455.788605284793;8694.26098781598;512.7464792238093;530.8646295194778;542.6960901894872;546.7621584610707;548.358420647843;3726.2174943261675;3793.8103094845146;3885.825137868803;3919.7060220483577;3962.821673024721;62737.686311569065;63180.68409657922;63528.68235658885;65903.34096659068;66102.66948665226;45347;56052.71973640106;56104.719476403174;56459.43540564624;56752.71623641856;39475.407868881986;42779.57220427756;46948.59154225379;47655.5234447658;47889.76055119702;8525.658973640984;9032.232260257952;9039.864402033843;9051.54742262871;9173.266138709021;23344.6498302529;24652.260432186347;24955.625665615393;25112.874435627706;25243.11649092273;29217.561736574393;29782.25544361408;29850.701492984794;30076.699233007388;30148.547771783004;10957.671269861918;11096.778064438828;11139.944300278446;11239;11444;11901.761964760482;11967.401629918644;12144.39278036077;12487.825240016784;12540.561080362144;11218.326900386002;11230.55077796879;11514.36670983104;11656.825147622962;11931.880681193077;11278.379689117177;11619.244749091282;11655.708607284885;11771.882281177079;12052.698682533006;11122.44387780624;11817;11835.34905580167;11855.525778968744;11880.227785193934;8422.83154336922;8657.567121644019;8926.41737032556;9019.864702029343;9051.954740226256;9199.678011269574;9348;10194.133498652698;10280.17758579297;10382.68851934413 04:50:55 INFO - PID 5117 | __end_tp_report 04:50:55 INFO - PID 5117 | __start_cc_report 04:50:55 INFO - PID 5117 | _x_x_mozilla_cycle_collect,376 04:50:55 INFO - PID 5117 | __end_cc_report 04:50:55 INFO - PID 5117 | __startTimestamp1490615454996__endTimestamp 04:50:55 INFO - PID 5117 | 04:50:55 INFO - PID 5117 | ------- Summary: start ------- 04:50:55 INFO - PID 5117 | Number of tests: 6 04:50:55 INFO - PID 5117 | 04:50:55 INFO - PID 5117 | [#0] dojo.html Cycles:165 Average:5245.76 Median:5386.52 stddev:607.42 (11.3%) stddev-sans-first:575.59 04:50:55 INFO - PID 5117 | Values: 2702.7 2722.6 2733.5 2756.6 2758.3 5137.5 5298.6 5321.9 5351.6 5362.5 5186.6 5306.9 5337.9 5385.9 5394.5 4861.5 4872.9 4898.2 4933.4 4951.7 4882.4 4929.2 4940.1 4941.0 4941.5 4790.7 4833.7 4836.5 4874.5 4912.5 4812.1 4842.5 4844.5 4898.3 4920.7 4766.5 4784.3 4827.3 4846.3 4849.7 5138.6 5189.4 5332.9 5347.6 5386.5 5671.5 5707.2 5738.7 5747.9 5759.1 5821.2 5829.9 5832.4 5845.7 5850.9 5191.4 5371.8 5393.5 5397.4 5402.2 5738.7 5808.0 5813.8 5820.2 5835.4 5562.6 5579.5 5625.7 5653.9 5697.8 5787.8 5791.5 5792.1 5806.8 5824.0 5719.0 5734.1 5739.2 5739.6 5742.4 5489.1 5560.2 5671.3 5713.9 5752.1 4692.4 4695.8 4699.4 4717.1 4739.1 4022.5 4029.6 4043.0 4071.6 4083.5 4796.3 4853.9 4942.1 4946.6 4974.3 5777.9 5779.5 5784.7 5823.2 5843.0 4873.4 4902.8 4916.1 4916.7 4970.7 4981.5 5039.5 5087.5 5089.0 5092.8 5201.4 5203.0 5204.9 5206.0 5212.2 5556.7 5591.9 5610.0 5613.9 5620.7 5372.9 5385.6 5431.0 5435.5 5451.8 5617.2 5688.0 5689.6 5695.0 5698.9 5569.3 5776.7 5811.1 5815.5 5817.2 5448.1 5563.4 5581.2 5586.2 5638.9 5572.1 5572.6 5579.4 5589.8 5594.7 5429.9 5456.4 5494.2 5495.6 5572.1 5439.7 5503.7 5507.3 5507.6 5652.6 5342.8 5352.5 5360.5 5371.4 5371.7 04:50:55 INFO - PID 5117 | 04:50:55 INFO - PID 5117 | [#1] ext.html Cycles:180 Average:32829.17 Median:15412.67 stddev:50800.18 (329.6%) stddev-sans-first:50885.30 04:50:55 INFO - PID 5117 | Values: 671.0 733.5 754.7 1056.5 1068.1 30240.5 31168.1 31213.2 31224.7 31227.7 32555.0 32681.8 32923.3 32978.3 33060.5 7219.4 7298.1 7384.0 7402.7 7413.5 7335.5 7420.7 7442.6 7446.5 7456.7 7530.4 7593.8 7599.3 7608.4 7620.0 7490.2 7522.2 7563.1 7581.1 7583.8 7359.2 7360.9 7397.7 7416.3 7432.3 32370.5 32398.8 32510.2 32612.7 32725.0 2633.5 2640.5 2681.6 2685.4 2687.1 23983.4 24077.5 24270.9 24401.8 24645.1 2800.3 2806.6 2820.7 2827.8 2830.1 152546.2 153261.2 153480.0 153605.5 153676.2 42306.0 42463.8 42481.8 42522.8 42528.1 43999.3 44191.1 44361.0 44376.1 44469.8 13273.9 13521.8 13536.9 13599.4 13613.1 10726.8 10783.8 10785.3 10829.6 10859.7 12870.2 13047.9 13181.2 13342.1 13391.9 5510.1 5575.5 5611.2 5612.9 5619.4 859.2 882.8 884.9 899.9 928.2 20366.4 21362.3 21514.7 21554.1 21747.1 967.9 976.8 983.2 999.6 1003.8 10720.3 11113.1 11154.5 11154.9 11180.3 237018.0 239431.0 239437.0 239996.0 240489.0 38683.4 39313.4 42415.0 42872.8 42878.6 1222.7 1244.4 1251.5 1253.9 1260.9 21324.9 21526.0 22524.5 22810.9 24278.2 29272.3 29350.6 29382.7 29418.6 29457.0 182041.0 183265.0 183779.1 183812.0 184133.0 26277.6 26427.7 26629.0 26827.9 26861.3 32137.2 32152.2 32298.7 32443.0 32544.7 25076.2 25392.6 25988.9 26418.0 26855.2 25111.5 25399.4 25750.5 26364.3 26412.5 27626.6 28018.7 28220.9 28230.0 28242.4 24578.4 24849.8 25616.5 25717.9 25954.0 18406.4 19144.1 19169.2 19336.8 19367.3 04:50:55 INFO - PID 5117 | 04:50:55 INFO - PID 5117 | [#2] jquery.html Cycles:180 Average:26420.34 Median:5633.08 stddev:71330.34 (1266.3%) stddev-sans-first:71503.71 04:50:55 INFO - PID 5117 | Values: 413.7 424.3 433.3 433.5 446.4 17993.9 18297.5 18462.3 18636.6 18674.6 16089.6 16104.2 16784.8 16833.9 16949.2 5564.3 5643.3 5785.7 5820.1 5836.6 5757.5 5848.2 5848.7 5867.5 5874.2 5622.9 5733.3 5745.5 5761.3 5826.0 5669.0 5676.1 5708.2 5712.9 5713.8 5120.2 5150.3 5165.5 5175.4 5180.0 22237.3 22265.6 22350.6 22423.3 22609.8 1577.1 1588.0 1588.6 1609.6 1632.7 13705.6 14309.6 14554.6 14644.5 14928.4 1738.9 1785.2 1789.6 1805.7 1805.7 81033.1 81237.0 82351.0 82761.2 83071.6 11043.5 11163.8 11345.5 11346.7 11406.7 16039.9 16060.8 16063.8 16088.8 16158.6 7536.3 7761.4 7844.7 7973.6 8028.5 7113.6 7186.3 7383.9 7392.1 7395.0 6825.0 6917.2 6930.8 6994.2 7001.0 2024.6 2031.1 2032.3 2041.2 2057.6 843.6 846.2 877.7 882.5 906.8 16144.5 16201.5 16373.1 16740.2 17356.7 893.4 894.9 900.5 902.1 907.1 8931.5 9062.9 9408.7 9414.2 9573.2 417255.0 418889.0 425200.0 445716.0 447292.0 76771.0 79716.0 85193.0 87130.0 92483.5 1074.9 1103.0 1113.1 1122.2 1125.5 15728.0 15953.4 16097.0 16861.3 17060.8 36097.3 36185.3 36802.4 37029.4 37081.0 54063.2 54407.7 54492.2 54771.1 56782.7 7407.1 7482.9 7516.7 7583.5 7622.3 11024.8 11037.1 11076.6 11484.8 11881.3 8671.9 8822.0 9107.0 9265.0 9370.3 7473.4 7918.8 8292.7 8382.3 8663.9 9091.3 9166.5 9319.9 9445.6 9623.1 7276.3 7294.6 7297.8 7408.9 7706.2 9020.7 9036.9 9369.6 9599.9 9884.4 04:50:55 INFO - PID 5117 | 04:50:55 INFO - PID 5117 | [#3] mootools.html Cycles:180 Average:6252.07 Median:4952.75 stddev:4071.14 (82.2%) stddev-sans-first:4065.26 04:50:55 INFO - PID 5117 | Values: 1256.5 1299.8 1300.9 1305.1 1314.7 9189.5 9558.8 9564.3 9860.3 10089.8 9805.3 9922.7 9944.7 9991.2 9995.4 2214.7 2253.9 2257.9 2258.5 2267.7 2084.1 2155.7 2173.2 2187.9 2192.6 2081.2 2127.8 2130.1 2139.0 2170.9 2126.2 2128.4 2129.8 2131.4 2137.7 1818.9 1875.8 2029.4 2090.8 2096.1 9652.2 9736.9 9747.4 9787.0 9836.2 5382.9 5605.8 5704.8 5705.7 5715.9 3205.7 3268.2 3310.3 3317.2 3338.9 1027.9 1057.3 1069.5 1086.7 1087.6 14953.7 14965.3 14986.6 15003.9 15066.8 4770.7 4820.1 4871.2 4956.9 4978.5 10900.9 10911.0 10918.3 10942.6 10948.3 5539.2 5600.6 5602.6 5629.9 5638.0 4859.7 4948.7 5030.8 5077.8 5128.9 3741.9 3874.9 3880.6 3942.2 3951.9 1093.1 1098.2 1107.3 1116.7 1117.1 698.8 713.7 724.6 734.3 753.0 5461.2 5524.4 5670.1 5771.9 5783.5 539.6 553.3 556.8 559.8 565.1 3400.7 3402.7 3410.0 3431.0 3530.6 13079.7 13516.7 13636.2 13707.1 13741.3 13015.5 13464.0 13504.4 13522.7 13559.4 9342.3 9618.1 9622.6 9690.1 9710.6 5646.8 5692.5 5694.0 5754.3 5828.2 11667.2 11673.9 11864.2 11892.1 11919.3 12149.1 12162.1 12331.7 12344.3 12443.3 7540.4 7639.1 7657.2 7868.3 7957.1 9331.8 9399.1 9416.6 9422.2 9579.7 8125.4 8127.0 8161.8 8295.3 8364.6 7849.0 7855.8 7869.3 7991.4 8031.7 6827.4 6876.2 6931.1 6951.6 6982.2 5049.5 5115.5 5136.4 5155.4 5222.3 5216.1 5295.8 5381.5 5399.0 5492.4 04:50:55 INFO - PID 5117 | 04:50:55 INFO - PID 5117 | [#4] prototype.html Cycles:180 Average:4883.56 Median:5413.30 stddev:1363.55 (25.2%) stddev-sans-first:1325.10 04:50:55 INFO - PID 5117 | Values: 394.6 398.2 400.4 402.2 402.5 5545.8 5607.1 5609.1 5628.9 5659.7 4871.8 5406.6 5452.5 5524.6 5546.1 4383.8 4387.4 4394.5 4402.3 4405.2 4406.8 4412.9 4420.4 4428.4 4430.2 4281.4 4360.3 4384.5 4390.8 4420.2 4374.4 4392.8 4405.6 4412.5 4417.1 3939.8 3950.2 3970.9 3972.0 3973.1 5290.2 5388.2 5413.1 5434.8 5440.9 5047.4 5071.7 5098.2 5103.3 5108.5 5758.4 5808.2 5812.2 5819.9 5827.9 4228.2 4313.2 4332.2 4363.1 4380.3 5802.5 6027.6 6063.5 6102.6 6133.5 4367.6 4452.4 4464.6 4478.8 4503.3 4541.8 4548.5 4551.9 4571.0 4589.4 4944.4 5060.6 5077.1 5080.8 5083.8 5826.6 5832.4 5833.9 5846.5 5867.8 1587.8 1605.0 1614.6 1617.8 1624.4 1071.8 1144.3 1151.1 1157.6 1160.3 5125.5 5133.0 5136.8 5144.0 5159.9 6053.3 6092.4 6094.0 6100.6 6108.0 4989.4 5079.0 5095.0 5113.8 5114.8 3185.9 3223.7 3233.9 3234.4 3236.6 5442.8 5592.5 5620.0 5642.0 5643.9 6142.4 6152.7 6183.6 6184.1 6188.4 5598.5 5626.0 5629.5 5635.7 5662.8 5796.9 6037.5 6047.8 6071.7 6083.3 5889.6 5906.9 5915.2 5924.4 5926.4 5216.7 5413.5 5418.4 5565.3 5613.7 4476.6 4487.1 4502.3 4503.2 4503.9 5912.9 6011.2 6021.0 6043.5 6060.6 5764.9 5766.5 5793.9 5796.0 5828.6 5771.5 5786.1 5792.5 5801.7 5825.0 5499.5 5658.6 5703.7 5716.5 5717.7 5837.6 5869.2 5875.3 5902.8 5903.1 5574.9 5655.9 5738.6 5747.6 5769.9 04:50:55 INFO - PID 5117 | 04:50:55 INFO - PID 5117 | [#5] yui.html Cycles:180 Average:13747.76 Median:3902.77 stddev:16562.02 (424.4%) stddev-sans-first:16579.53 04:50:55 INFO - PID 5117 | Values: 705.5 705.6 711.2 718.7 750.2 11919.7 11996.5 12047.9 12313.6 13099.1 12444.8 13009.3 13030.0 13031.7 13051.9 831.6 864.6 873.1 874.0 875.4 804.5 836.1 855.0 855.7 858.2 864.8 865.7 866.2 868.3 873.1 859.1 859.5 861.0 864.6 865.9 634.2 640.9 641.0 643.0 643.0 13720.4 13863.7 14072.0 14123.9 14226.6 13621.3 14201.9 14305.6 14363.9 14576.1 10739.2 10856.1 10877.3 11065.0 11488.7 2701.4 2766.4 2771.6 2778.7 2834.5 48735.8 60678.1 61184.4 61580.0 61877.1 10875.5 10879.9 10941.4 11092.9 11202.9 21391.7 21429.1 21431.1 21494.6 21592.0 6597.9 6651.7 6671.8 6782.7 6919.5 3404.7 3415.0 3425.1 3443.3 3447.0 3692.3 3714.3 3741.3 3760.6 3780.6 635.0 642.9 643.1 647.3 655.1 511.5 515.8 521.9 525.9 533.8 8235.8 8319.8 8417.7 8455.8 8694.3 512.7 530.9 542.7 546.8 548.4 3726.2 3793.8 3885.8 3919.7 3962.8 62737.7 63180.7 63528.7 65903.3 66102.7 45347.0 56052.7 56104.7 56459.4 56752.7 39475.4 42779.6 46948.6 47655.5 47889.8 8525.7 9032.2 9039.9 9051.5 9173.3 23344.6 24652.3 24955.6 25112.9 25243.1 29217.6 29782.3 29850.7 30076.7 30148.5 10957.7 11096.8 11139.9 11239.0 11444.0 11901.8 11967.4 12144.4 12487.8 12540.6 11218.3 11230.6 11514.4 11656.8 11931.9 11278.4 11619.2 11655.7 11771.9 12052.7 11122.4 11817.0 11835.3 11855.5 11880.2 8422.8 8657.6 8926.4 9019.9 9052.0 9199.7 9348.0 10194.1 10280.2 10382.7 04:50:55 INFO - PID 5117 | -------- Summary: end -------- 04:50:55 INFO - PID 5117 | 04:50:55 INFO - TEST-INFO | 5117: exit 0 04:50:55 INFO - TEST-OK | dromaeo_css | took 1120298ms 04:50:55 INFO - TEST-START | kraken 04:50:55 INFO - operating with platform_type : linux_ 04:50:55 INFO - Initialising browser for kraken test... 04:50:55 INFO - TEST-INFO | started process 5509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwnNxMv/profile http://localhost:45285/getInfo.html) 04:51:00 INFO - PID 5509 | __metrics Screen width/height:1600/1200 04:51:00 INFO - PID 5509 | colorDepth:24 04:51:00 INFO - PID 5509 | Browser inner width/height: 1024/697 04:51:00 INFO - PID 5509 | __metrics 04:51:01 ERROR - PID 5509 | 1490615461323 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6376:36 < canClose@browser.js:5227:12 < forceQuit@jar:file:///tmp/tmpwnNxMv/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmpwnNxMv/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmpwnNxMv/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmpwnNxMv/profile/extensions/talos-powers@TalosPowersService.js:55:9 04:51:01 ERROR - PID 5509 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 04:51:02 INFO - TEST-INFO | 5509: exit 0 04:51:02 INFO - Browser initialized. 04:51:02 INFO - Running cycle 1/1 for kraken test... 04:51:02 INFO - TEST-INFO | started process 5641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwnNxMv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:51:14 INFO - PID 5641 | RSS: Main: 156246016 04:51:14 INFO - PID 5641 | 04:51:17 INFO - PID 5641 | Cycle 1(1): loaded http://localhost:45285/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45285/tests/kraken/driver.html?testName=audio-beat-detection) 04:51:18 INFO - PID 5641 | RSS: Main: 161857536 04:51:18 INFO - PID 5641 | 04:51:20 INFO - PID 5641 | Cycle 1(1): loaded http://localhost:45285/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45285/tests/kraken/driver.html?testName=audio-dft) 04:51:21 INFO - PID 5641 | RSS: Main: 161136640 04:51:21 INFO - PID 5641 | 04:51:24 INFO - PID 5641 | Cycle 1(1): loaded http://localhost:45285/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45285/tests/kraken/driver.html?testName=audio-fft) 04:51:25 INFO - PID 5641 | RSS: Main: 158121984 04:51:25 INFO - PID 5641 | 04:51:27 INFO - PID 5641 | Cycle 1(1): loaded http://localhost:45285/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45285/tests/kraken/driver.html?testName=audio-oscillator) 04:51:27 INFO - PID 5641 | RSS: Main: 158883840 04:51:27 INFO - PID 5641 | 04:51:30 INFO - PID 5641 | Cycle 1(1): loaded http://localhost:45285/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45285/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:51:30 INFO - PID 5641 | RSS: Main: 159191040 04:51:30 INFO - PID 5641 | 04:51:33 INFO - PID 5641 | Cycle 1(1): loaded http://localhost:45285/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45285/tests/kraken/driver.html?testName=imaging-darkroom) 04:51:34 INFO - PID 5641 | RSS: Main: 164458496 04:51:34 INFO - PID 5641 | 04:51:38 INFO - PID 5641 | Cycle 1(1): loaded http://localhost:45285/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45285/tests/kraken/driver.html?testName=imaging-desaturate) 04:51:38 INFO - PID 5641 | RSS: Main: 161751040 04:51:38 INFO - PID 5641 | 04:51:41 INFO - PID 5641 | Cycle 1(1): loaded http://localhost:45285/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45285/tests/kraken/driver.html?testName=json-parse-financial) 04:51:42 INFO - PID 5641 | RSS: Main: 162783232 04:51:42 INFO - PID 5641 | 04:51:44 INFO - PID 5641 | Cycle 1(1): loaded http://localhost:45285/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45285/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:51:44 INFO - PID 5641 | RSS: Main: 163487744 04:51:44 INFO - PID 5641 | 04:51:46 INFO - PID 5641 | Cycle 1(1): loaded http://localhost:45285/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45285/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:51:47 INFO - PID 5641 | RSS: Main: 163057664 04:51:47 INFO - PID 5641 | 04:51:49 INFO - PID 5641 | Cycle 1(1): loaded http://localhost:45285/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45285/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:51:50 INFO - PID 5641 | RSS: Main: 163434496 04:51:50 INFO - PID 5641 | 04:51:52 INFO - PID 5641 | Cycle 1(1): loaded http://localhost:45285/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:51:53 INFO - PID 5641 | RSS: Main: 164130816 04:51:53 INFO - PID 5641 | 04:51:56 INFO - PID 5641 | Cycle 1(1): loaded http://localhost:45285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:51:57 INFO - PID 5641 | RSS: Main: 163590144 04:51:57 INFO - PID 5641 | 04:51:59 INFO - PID 5641 | Cycle 1(1): loaded http://localhost:45285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45285/tests/kraken/driver.html?testName=ai-astar) 04:51:59 INFO - PID 5641 | RSS: Main: 165105664 04:51:59 INFO - PID 5641 | 04:51:59 INFO - PID 5641 | __start_tp_report 04:51:59 INFO - PID 5641 | _x_x_mozilla_page_load 04:51:59 INFO - PID 5641 | _x_x_mozilla_page_load_details 04:51:59 INFO - PID 5641 | |i|pagename|runs| 04:51:59 INFO - PID 5641 | |0;ai-astar;110;112;111;111;113;112;114;111;112;112 04:51:59 INFO - PID 5641 | |1;audio-beat-detection;151;123;123;174;126;124;130;124;150;127 04:51:59 INFO - PID 5641 | |2;audio-dft;164;166;167;173;168;166;166;165;163;164 04:51:59 INFO - PID 5641 | |3;audio-fft;75;75;76;113;75;76;75;75;91;79 04:51:59 INFO - PID 5641 | |4;audio-oscillator;83;82;101;86;85;84;108;85;84;103 04:51:59 INFO - PID 5641 | |5;imaging-gaussian-blur;113;114;115;114;115;114;115;114;114;113 04:51:59 INFO - PID 5641 | |6;imaging-darkroom;155;152;152;165;151;151;150;150;151;151 04:51:59 INFO - PID 5641 | |7;imaging-desaturate;95;96;95;95;95;95;96;95;96;95 04:51:59 INFO - PID 5641 | |8;json-parse-financial;69;69;70;69;71;72;69;71;69;71 04:51:59 INFO - PID 5641 | |9;json-stringify-tinderbox;55;56;56;56;56;56;55;56;56;55 04:51:59 INFO - PID 5641 | |10;stanford-crypto-aes;82;83;84;84;94;93;92;83;83;82 04:51:59 INFO - PID 5641 | |11;stanford-crypto-ccm;152;135;133;132;138;140;141;138;183;136 04:51:59 INFO - PID 5641 | |12;stanford-crypto-pbkdf2;187;195;186;196;203;195;192;204;202;183 04:51:59 INFO - PID 5641 | |13;stanford-crypto-sha256-iterative;72;74;71;74;73;70;76;73;70;70 04:51:59 INFO - PID 5641 | __end_tp_report 04:51:59 INFO - PID 5641 | __start_cc_report 04:51:59 INFO - PID 5641 | _x_x_mozilla_cycle_collect,869 04:51:59 INFO - PID 5641 | __end_cc_report 04:51:59 INFO - PID 5641 | __startTimestamp1490615519599__endTimestamp 04:51:59 INFO - PID 5641 | 04:51:59 INFO - PID 5641 | ------- Summary: start ------- 04:51:59 INFO - PID 5641 | Number of tests: 14 04:51:59 INFO - PID 5641 | 04:51:59 INFO - PID 5641 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:1.14 (1.0%) stddev-sans-first:1.00 04:51:59 INFO - PID 5641 | Values: 110.0 112.0 111.0 111.0 113.0 112.0 114.0 111.0 112.0 112.0 04:51:59 INFO - PID 5641 | 04:51:59 INFO - PID 5641 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:128.50 stddev:17.33 (13.5%) stddev-sans-first:17.41 04:51:59 INFO - PID 5641 | Values: 151.0 123.0 123.0 174.0 126.0 124.0 130.0 124.0 150.0 127.0 04:51:59 INFO - PID 5641 | 04:51:59 INFO - PID 5641 | [#2] audio-dft Cycles:10 Average:166.20 Median:166.00 stddev:2.82 (1.7%) stddev-sans-first:2.88 04:51:59 INFO - PID 5641 | Values: 164.0 166.0 167.0 173.0 168.0 166.0 166.0 165.0 163.0 164.0 04:51:59 INFO - PID 5641 | 04:51:59 INFO - PID 5641 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.50 stddev:12.28 (16.3%) stddev-sans-first:12.84 04:51:59 INFO - PID 5641 | Values: 75.0 75.0 76.0 113.0 75.0 76.0 75.0 75.0 91.0 79.0 04:51:59 INFO - PID 5641 | 04:51:59 INFO - PID 5641 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:84.00 stddev:9.80 (11.7%) stddev-sans-first:10.06 04:51:59 INFO - PID 5641 | Values: 83.0 82.0 101.0 86.0 85.0 84.0 108.0 85.0 84.0 103.0 04:51:59 INFO - PID 5641 | 04:51:59 INFO - PID 5641 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.67 04:51:59 INFO - PID 5641 | Values: 113.0 114.0 115.0 114.0 115.0 114.0 115.0 114.0 114.0 113.0 04:51:59 INFO - PID 5641 | 04:51:59 INFO - PID 5641 | [#6] imaging-darkroom Cycles:10 Average:152.80 Median:151.50 stddev:4.52 (3.0%) stddev-sans-first:4.72 04:51:59 INFO - PID 5641 | Values: 155.0 152.0 152.0 165.0 151.0 151.0 150.0 150.0 151.0 151.0 04:51:59 INFO - PID 5641 | 04:51:59 INFO - PID 5641 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 04:51:59 INFO - PID 5641 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 04:51:59 INFO - PID 5641 | 04:51:59 INFO - PID 5641 | [#8] json-parse-financial Cycles:10 Average:70.00 Median:70.50 stddev:1.15 (1.6%) stddev-sans-first:1.17 04:51:59 INFO - PID 5641 | Values: 69.0 69.0 70.0 69.0 71.0 72.0 69.0 71.0 69.0 71.0 04:51:59 INFO - PID 5641 | 04:51:59 INFO - PID 5641 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:56.00 stddev:0.48 (0.9%) stddev-sans-first:0.44 04:51:59 INFO - PID 5641 | Values: 55.0 56.0 56.0 56.0 56.0 56.0 55.0 56.0 56.0 55.0 04:51:59 INFO - PID 5641 | 04:51:59 INFO - PID 5641 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:84.00 stddev:4.90 (5.8%) stddev-sans-first:4.98 04:51:59 INFO - PID 5641 | Values: 82.0 83.0 84.0 84.0 94.0 93.0 92.0 83.0 83.0 82.0 04:51:59 INFO - PID 5641 | 04:51:59 INFO - PID 5641 | [#11] stanford-crypto-ccm Cycles:10 Average:142.80 Median:139.00 stddev:15.19 (10.9%) stddev-sans-first:15.75 04:51:59 INFO - PID 5641 | Values: 152.0 135.0 133.0 132.0 138.0 140.0 141.0 138.0 183.0 136.0 04:51:59 INFO - PID 5641 | 04:51:59 INFO - PID 5641 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.30 Median:195.50 stddev:7.36 (3.8%) stddev-sans-first:7.32 04:51:59 INFO - PID 5641 | Values: 187.0 195.0 186.0 196.0 203.0 195.0 192.0 204.0 202.0 183.0 04:51:59 INFO - PID 5641 | 04:51:59 INFO - PID 5641 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:73.00 stddev:2.06 (2.8%) stddev-sans-first:2.18 04:51:59 INFO - PID 5641 | Values: 72.0 74.0 71.0 74.0 73.0 70.0 76.0 73.0 70.0 70.0 04:51:59 INFO - PID 5641 | -------- Summary: end -------- 04:51:59 INFO - PID 5641 | 04:52:00 INFO - TEST-INFO | 5641: exit 0 04:52:00 INFO - TEST-OK | kraken | took 64893ms 04:52:00 INFO - SUITE-END | took 1185s 04:52:01 INFO - Completed test suite (00:19:45) 04:52:01 INFO - javascript benchmark 04:52:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6627.68168990653, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2702.6891907430645, 2722.618833363331, 2733.5079685656574, 2756.6416365872433, 2758.3104223944, 5137.460566640505, 5298.576113910887, 5321.92017119743, 5351.625386222966, 5362.490563396476, 5186.636935414523, 5306.867328316794, 5337.893242135155, 5385.892282154355, 5394.514493695567, 4861.465238823726, 4872.926906096412, 4898.216285394337, 4933.383327084114, 4951.702897826124, 4882.414110306768, 4929.2359684248995, 4940.08608407444, 4941.0, 4941.45643979162, 4790.664653474223, 4833.734144622044, 4836.540528649808, 4874.46380898101, 4912.533309335608, 4812.061647978646, 4842.515748425165, 4844.467108618049, 4898.314236006961, 4920.729359885205, 4766.451858036336, 4784.258439941815, 4827.275908613701, 4846.29728689338, 4849.709017458964, 5138.588912886998, 5189.403218629868, 5332.92000619991, 5347.6256662033675, 5386.515213630752, 5671.461211184931, 5707.229524014247, 5738.741756620962, 5747.942520574783, 5759.107338362561, 5821.214136091616, 5829.912551311733, 5832.387599302055, 5845.7369418376275, 5850.853728656775, 5191.428942816287, 5371.811986580451, 5393.460653934614, 5397.4062853086125, 5402.243685883979, 5738.655680659173, 5808.041673123887, 5813.837232553422, 5820.243368362086, 5835.445632664975, 5562.610617256753, 5579.46995035471, 5625.746841392147, 5653.886922261532, 5697.800576979786, 5787.826365209051, 5791.478766910998, 5792.0732682771395, 5806.767729290866, 5824.0, 5718.971405143031, 5734.082546792493, 5739.16782066598, 5739.626924249994, 5742.425757424224, 5489.066858633962, 5560.221568980346, 5671.319441667027, 5713.9142912855505, 5752.137179423036, 4692.389989301369, 4695.81216751333, 4699.412573428322, 4717.080169367009, 4739.146953548326, 4022.4770779798437, 4029.597040295947, 4042.9797851011144, 4071.572484889103, 4083.5303940047274, 4796.2805579163405, 4853.927191092136, 4942.135126352874, 4946.554810067111, 4974.278729584263, 5777.88444231113, 5779.479846813807, 5784.739686714108, 5823.242978412779, 5843.03589907669, 4873.390826146731, 4902.779374928136, 4916.06594746997, 4916.70499770015, 4970.652054356233, 4981.476944920803, 5039.546440820271, 5087.465816089258, 5088.974555127201, 5092.796288148433, 5201.375834899836, 5203.0, 5204.921926171186, 5205.973970130125, 5212.192110222922, 5556.749946252347, 5591.944080559142, 5610.046292130266, 5613.859653508532, 5620.690862002629, 5372.865678358073, 5385.649932754359, 5431.0, 5435.483629055233, 5451.836444906659, 5617.213590097472, 5687.971560142173, 5689.601727879009, 5695.0, 5698.943010569841, 5569.33168019824, 5776.682282474336, 5811.070228763378, 5815.534757219497, 5817.243758311392, 5448.101063324507, 5563.388027317073, 5581.246531718329, 5586.245856809279, 5638.85902852432, 5572.052751032254, 5572.554195664256, 5579.442055794388, 5589.776408943597, 5594.692291923983, 5429.945700542944, 5456.399796022355, 5494.2033405155225, 5495.587830912617, 5572.10846264612, 5439.728013599225, 5503.724813759216, 5507.339119305709, 5507.614466987273, 5652.576056795675, 5342.786288548415, 5352.4915133062295, 5360.463953604608, 5371.40914499397, 5371.677699338053], "value": 5201.530943885907, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.9731610735571, 733.5012191709637, 754.7018927523627, 1056.5034433816109, 1068.0601071057467, 30240.546391804142, 31168.064958051295, 31213.219669508275, 31224.687753122464, 31227.687723122763, 32555.0, 32681.836590817013, 32923.341533169325, 32978.34043319132, 33060.504092438576, 7219.386352160046, 7298.124225092983, 7384.0400747902695, 7402.7038918443195, 7413.518121322124, 7335.523190992569, 7420.666070026835, 7442.590657513834, 7446.51597646154, 7456.701731930743, 7530.359919406857, 7593.772186834376, 7599.278068583503, 7608.35328997036, 7620.0, 7490.176080631099, 7522.247775222461, 7563.054618172729, 7581.052368453943, 7583.81040473987, 7359.227281135457, 7360.852782944311, 7397.667104980235, 7416.258374162595, 7432.256774322578, 32370.514442283384, 32398.838005810056, 32510.18724531882, 32612.6738732612, 32725.0, 2633.486470138324, 2640.485105404447, 2681.611166380864, 2685.368938299498, 2687.113252626648, 23983.40041498959, 24077.518449631083, 24270.87864560666, 24401.83995574529, 24645.137420190207, 2800.313923088836, 2806.6211061506638, 2820.675622303441, 2827.759640430566, 2830.1368082734757, 152546.23726881406, 153261.2336938308, 153480.0, 153605.46394536024, 153676.23161884118, 42306.0, 42463.787681062015, 42481.787591061846, 42522.78738606349, 42528.14943701109, 43999.340009899875, 44191.11617767627, 44361.0, 44376.11247775026, 44469.777651112185, 13273.933630331787, 13521.797173042412, 13536.932315338361, 13599.388027538784, 13613.11514751538, 10726.785464290671, 10783.78432431347, 10785.298955567863, 10829.620963266249, 10859.674209773719, 12870.22778633285, 13047.934760326138, 13181.209127452383, 13342.13276137048, 13391.933040334736, 5510.118381059011, 5575.470330318613, 5611.242482264842, 5612.940947183713, 5619.4099619540175, 859.1966511311944, 882.8146089321315, 884.9380543361902, 899.8740176375313, 928.1692884868005, 20366.389008329774, 21362.252321168686, 21514.677279840816, 21554.13783448676, 21747.130114795233, 967.9128878400978, 976.8144052629978, 983.2134292566061, 999.6251405722854, 1003.8193125237382, 10720.303180293256, 11113.11095112389, 11154.498047587878, 11154.944225278983, 11180.273282236629, 237018.0, 239431.0, 239437.0, 239996.0, 240489.0, 38683.41974870379, 39313.41029884554, 42415.0, 42872.78563607162, 42878.571214287454, 1222.6698791326291, 1244.440001999104, 1251.4618713952905, 1253.8620751717303, 1260.861305256421, 21324.89337553302, 21526.0, 22524.549509010056, 22810.885945570168, 24278.15026474065, 29272.268193294487, 29350.559741603465, 29382.706172937997, 29418.55872161962, 29457.0, 182041.0, 183265.0, 183779.08110459897, 183812.0, 184133.0, 26277.605835912094, 26427.735722642527, 26629.0, 26827.865860670572, 26861.328466788487, 32137.196570085936, 32152.19619509531, 32298.677013229568, 32443.0, 32544.674553254164, 25076.247712568653, 25392.619110713724, 25988.870055650357, 26418.0, 26855.194344169708, 25111.49777004486, 25399.44407782875, 25750.484990300465, 26364.340891477867, 26412.471750565266, 27626.5856012164, 28018.71981280161, 28220.858895706213, 28230.0, 28242.43515129645, 24578.38554036092, 24849.751502484745, 25616.487670246865, 25717.871410642827, 25954.0, 18406.442803177397, 19144.138513766637, 19169.233230670616, 19336.8066319335, 19367.3221437249], "value": 14632.804446847082, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.7372768292137, 424.3267415283712, 433.2631057132235, 433.51013354908946, 446.3862189489452, 17993.91003044986, 18297.451076467692, 18462.261509539618, 18636.62726745464, 18674.626507469842, 16089.597760056004, 16104.194790260499, 16784.832151678478, 16833.915830420832, 16949.237284322204, 5564.27664403629, 5643.266375371196, 5785.681787501686, 5820.097884827837, 5836.562257830658, 5757.453041961007, 5848.152017957394, 5848.707564621774, 5867.530597552207, 5874.1776151338845, 5622.887542249153, 5733.254676891998, 5745.454181852718, 5761.30864296285, 5825.970870145665, 5669.036263835137, 5676.148577713335, 5708.20085188074, 5712.8857422851725, 5713.771449142029, 5120.15517439622, 5150.3047088642925, 5165.457626949192, 5175.378954525481, 5179.974100129513, 22237.332880013626, 22265.554688906293, 22350.552988940293, 22423.32730018102, 22609.77390226093, 1577.069528977897, 1588.0392362620564, 1588.6107903563586, 1609.589554663565, 1632.6734653069434, 13705.588832335046, 14309.57071287863, 14554.563363099123, 14644.487442939553, 14928.40286388554, 1738.8869723467933, 1785.196661502329, 1789.5705030792517, 1805.6930321845318, 1805.7201133824278, 81033.08397166972, 81237.0, 82351.0, 82761.17238827655, 83071.5846420764, 11043.503042363112, 11163.776724465466, 11345.546178152947, 11346.716332091764, 11406.714832129097, 16039.919800401156, 16060.839391606169, 16063.759043614355, 16088.839111608968, 16158.576213568058, 7536.321731044232, 7761.379089672812, 7844.725434609762, 7973.60131993398, 8028.518288902685, 7113.608751518716, 7186.281371862772, 7383.852322953511, 7392.112946446461, 7395.038644976119, 6825.0, 6917.239103698589, 6930.826729331807, 6994.160700715946, 7000.964995174992, 2024.574839283767, 2031.086011294923, 2032.309014934929, 2041.2345370486069, 2057.567910738732, 843.6498852976069, 846.2087947768856, 877.6752601537472, 882.5234373438271, 906.805036917066, 16144.515664530083, 16201.513954581145, 16373.099479528502, 16740.246688899028, 17356.65286694259, 893.4326702543931, 894.865770134485, 900.4732231644562, 902.1429641840147, 907.0611916666219, 8931.464112153291, 9062.864057039149, 9408.670696525589, 9414.152726254533, 9573.228952643643, 417255.0, 418889.0, 425200.0, 445716.0, 447292.0, 76771.0, 79716.0, 85193.0, 87130.0, 92483.537582313, 1074.8925107489188, 1102.9558817647205, 1113.1095123900848, 1122.2144498850837, 1125.487903004131, 15728.0, 15953.361865525249, 16097.034177949361, 16861.325546977983, 17060.829391705924, 36097.27805443824, 36185.27629447449, 36802.447963281105, 37029.44455833111, 37081.0, 54063.18905216346, 54407.72796135994, 54492.18261725998, 54771.05819656207, 56782.71608641931, 7407.111146662435, 7482.925170748441, 7516.699332026877, 7583.544987300779, 7622.31399174077, 11024.779504410028, 11037.11703063769, 11076.612318568812, 11484.770304593694, 11881.346525940811, 8671.913280867111, 8821.955890220508, 9106.95446522763, 9265.0, 9370.250379969722, 7473.364763995121, 7918.802029949297, 8292.709755158541, 8382.329413646772, 8663.913360866563, 9091.272698183997, 9166.450012999241, 9319.86020209684, 9445.622175113192, 9623.085806848338, 7276.272372762682, 7294.635268236673, 7297.781066568012, 7408.851822963618, 7706.152323244551, 9020.729378118667, 9036.864447033431, 9369.625214991323, 9599.856002159833, 9884.406935583887], "value": 8645.937266182355, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1256.4848412151018, 1299.8115273285368, 1300.8894243989255, 1305.1125234840306, 1314.6910476038133, 9189.540522973857, 9558.808823823529, 9564.282678799093, 9860.309778315503, 10089.798204035915, 9805.313628046022, 9922.652707155252, 9944.701658950244, 9991.150752186073, 9995.35030223035, 2214.7010153629294, 2253.9323820285417, 2257.932262032142, 2258.5369999150216, 2267.7278726552836, 2084.0934193625744, 2155.698202251686, 2173.1959175105235, 2187.9015444305046, 2192.6491761318193, 2081.2403472732494, 2127.8297736181066, 2130.1479408236673, 2139.0160526157906, 2170.945726356838, 2126.234555560005, 2128.3508529898377, 2129.755078166015, 2131.435169680028, 2137.657974724052, 1818.863585231113, 1875.8311751942254, 2029.411470673503, 2090.822280106193, 2096.119629755506, 9652.22782177424, 9736.853947190797, 9747.3664211826, 9786.951065244699, 9836.213102951746, 5382.946170538284, 5605.831825045255, 5704.77180912763, 5705.71471426427, 5715.914261286084, 3205.6634053424523, 3268.199291173654, 3310.304835984446, 3317.2370354818286, 3338.9499157512414, 1027.9280450368476, 1057.3497299161038, 1069.5400977579638, 1086.6902932664152, 1087.5649740103943, 14953.700925981528, 14965.326560304813, 14986.550403487803, 15003.924980375137, 15066.849331506764, 4770.666053376231, 4820.132376172252, 4871.2206047032305, 4956.851294461172, 4978.502149785065, 10900.945495272474, 10911.0, 10918.290311129751, 10942.617008404668, 10948.343099413902, 5539.19681646159, 5600.635958662674, 5602.635828671205, 5629.887402251932, 5637.9718101409235, 4859.684120532154, 4948.653594248368, 5030.798768049311, 5077.822276220389, 5128.8717782055, 3741.887743367649, 3874.9031274217805, 3880.553736320303, 3942.2115576884166, 3951.9012024699036, 1093.147345070846, 1098.2257508456678, 1107.2747350485445, 1116.6705821782593, 1117.1118960426481, 698.7554355975368, 713.6966789114606, 724.5869854183065, 734.2730696610317, 752.9548227106282, 5461.15352120422, 5524.392316845144, 5670.149477578396, 5771.88456230873, 5783.4794868461195, 539.6411386427982, 553.2807350444486, 556.8301667991302, 559.7816851427947, 565.1409857017311, 3400.6769356911054, 3402.6937575617817, 3409.9829500852834, 3431.0, 3530.5763308402643, 13079.738405231841, 13516.729665406638, 13636.181829090287, 13707.109037912503, 13741.312934353242, 13015.479380824661, 13464.0, 13504.392302346418, 13522.661933451545, 13559.389827457788, 9342.2526197904, 9618.134367906781, 9622.566984485715, 9690.12788849007, 9710.563024663907, 5646.830595082154, 5692.544596432358, 5694.0, 5754.280714910637, 5828.184054232495, 11667.241629294069, 11673.883261167619, 11864.169508134348, 11892.10809189297, 11919.284842909454, 12149.149559530748, 12162.087843411602, 12331.69170770702, 12344.259344439362, 12443.253404795742, 7540.434467414856, 7639.121501027453, 7657.1959944205055, 7868.25251601097, 7957.084935232522, 9331.813363732552, 9399.060093990547, 9416.62333506652, 9422.199113075465, 9579.712608621752, 8125.431219814793, 8127.0, 8161.836763264821, 8295.253427191581, 8364.581770911553, 7849.0, 7855.803604909923, 7869.291763741291, 7991.4006449515355, 8031.718889838828, 6827.385535301847, 6876.243613202644, 6931.064306318583, 6951.582905025714, 6982.162140543167, 5049.469805670352, 5115.539601435739, 5136.434992150935, 5155.355580552431, 5222.321098257202, 5216.0901768123595, 5295.808443100272, 5381.461853814587, 5398.973005134949, 5492.423295554069], "value": 4644.840859571872, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.62313490616464, 398.1559094719192, 400.42339031794216, 402.20765092767255, 402.48682929265175, 5545.833624991252, 5607.130894711316, 5609.1025435930205, 5628.887422251558, 5659.745311460983, 4871.805127794884, 5406.648567843097, 5452.454754524546, 5524.613501835708, 5546.112621980484, 4383.780810959455, 4387.3857659927635, 4394.494633117184, 4402.339649052636, 4405.207062728708, 4406.823727050914, 4412.867613971586, 4420.4253447052, 4428.3800267962515, 4430.224710675635, 4281.400603915455, 4360.258756011485, 4384.473863136428, 4390.846320378771, 4420.20436321462, 4374.4094547236355, 4392.802323895432, 4405.581469760367, 4412.477695195153, 4417.094495628405, 3939.7589759225752, 3950.150717595731, 3970.9007274818073, 3971.9871432784744, 3973.1060511384994, 5290.153575427913, 5388.1648344506275, 5413.079776438015, 5434.809781657663, 5440.863978400532, 5047.394312682465, 5071.670341427833, 5098.1842905135, 5103.311053007834, 5108.463611320833, 5758.366579676274, 5808.2449281593545, 5812.244408226903, 5819.854503637401, 5827.854303642401, 4228.154369126187, 4313.245182093121, 4332.1985432695055, 4363.105563359503, 4380.299152135675, 5802.506786923117, 6027.5835178733405, 6063.514918806485, 6102.603330783485, 6133.509319254449, 4367.606915377632, 4452.443444569429, 4464.598186163196, 4478.776061196927, 4503.324501324828, 4541.841035563805, 4548.545145485491, 4551.908961820811, 4571.0, 4589.35748995141, 4944.431390390079, 5060.5951523878, 5077.111505486525, 5080.840642726826, 5083.847484575469, 5826.581968483032, 5832.387599302097, 5833.912491312633, 5846.473817356458, 5867.8020478839135, 1587.7618357246506, 1604.9759253611205, 1614.5802091456071, 1617.7977752780903, 1624.3664970661453, 1071.8017166824006, 1144.2619510415902, 1151.0676352154615, 1157.6121999130216, 1160.2922217447351, 5125.461826508237, 5132.999065182254, 5136.8202112925865, 5143.974280128576, 5159.871003224949, 6053.334133245339, 6092.390760923872, 6093.969530152321, 6100.633961962297, 6107.969460152671, 4989.351384320015, 5079.0, 5094.974525127351, 5113.769880355393, 5114.820981265712, 3185.9362812743616, 3223.6615155408813, 3233.916637926274, 3234.3531293740875, 3236.563063986379, 5442.8095016675015, 5592.4900276925, 5619.988402087663, 5642.0, 5643.855334972766, 6142.416470435302, 6152.692365381713, 6183.628982261079, 6184.073113572914, 6188.412100850412, 5598.496135347838, 5626.043572592669, 5629.4652008059165, 5635.718214089279, 5662.801801936913, 5796.855078623068, 6037.547183961308, 6047.848803779941, 6071.726772295346, 6083.270007599116, 5889.587728858939, 5906.940930590639, 5915.2310199675485, 5924.377940316377, 5926.407359264039, 5216.747980484733, 5413.512783849473, 5418.376886658085, 5565.276514053147, 5613.663180209201, 4476.552344765498, 4487.102579484182, 4502.302143167814, 4503.189425903369, 4503.909921801611, 5912.881742365214, 6011.218541589566, 6021.0, 6043.456088952015, 6060.575759696779, 5764.913526297025, 5766.500709815395, 5793.855153621024, 5795.971020144872, 5828.562857785768, 5771.509421699035, 5786.103154011135, 5792.536597072309, 5801.6519008859605, 5825.0, 5499.5325397340075, 5658.575606829587, 5703.718512594995, 5716.485516303553, 5717.742701578356, 5837.591368604157, 5869.178315035983, 5875.294964604275, 5902.822915312548, 5903.144044113666, 5574.888502229852, 5655.858603534944, 5738.569607279387, 5747.626404283708, 5769.913451298318], "value": 4474.751531410446, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.4954910069252, 705.59428328711, 711.1750369571298, 718.7448455798192, 750.1785544828415, 11919.702007449807, 11996.46015929283, 12047.879521204786, 12313.569025084123, 13099.14855534392, 12444.813327800068, 13009.34953252336, 13030.022748293868, 13031.73936521269, 13051.869481305184, 831.6423937706784, 864.6282098697558, 873.1137895036543, 873.9512584898116, 875.4265955798962, 804.5414113955048, 836.05943313772, 855.0295414704293, 855.7218903856241, 858.2318824651933, 864.8010957479784, 865.6537385045968, 866.23338345564, 868.2793281576309, 873.1312344217513, 859.1408591408591, 859.5186695450568, 861.0399404663787, 864.597961947691, 865.9307255419583, 634.2104080419907, 640.8654182621608, 640.9519286053518, 642.9549931504797, 643.0482885329739, 13720.382582783699, 13863.653408664763, 14072.0, 14123.929380353033, 14226.644333891632, 13621.25083120428, 14201.928990355085, 14305.57083287503, 14363.928180359137, 14576.125432474086, 10739.239452532658, 10856.131509479223, 10877.292975956538, 11065.0, 11488.655340339803, 2701.3786829029236, 2766.4190519990825, 2771.556550951838, 2778.70823563527, 2834.518131917579, 48735.75632121817, 60678.089828652606, 61184.38815611876, 61580.0, 61877.09966405354, 10875.45622718861, 10879.945600271947, 10941.398223097647, 11092.893989682902, 11202.887971120348, 21391.67912481314, 21429.142834286766, 21431.142754289966, 21494.57010859774, 21592.0, 6597.86804263912, 6651.733930642817, 6671.833204169838, 6782.660866956632, 6919.481038922101, 3404.7446441516986, 3415.0, 3425.143714071482, 3443.3113377324635, 3446.9827650861585, 3692.2615476904725, 3714.272863118663, 3741.251749650081, 3760.6239376062176, 3780.584135745066, 634.9777757778455, 642.8649983503423, 643.1092936283281, 647.2944490505278, 655.1221363373007, 511.53450360172064, 515.8014164546677, 521.9373675159005, 525.8519098030317, 533.8131653921097, 8235.794105147419, 8319.750407487785, 8417.747467575982, 8455.788605284793, 8694.26098781598, 512.7464792238093, 530.8646295194778, 542.6960901894872, 546.7621584610707, 548.358420647843, 3726.2174943261675, 3793.8103094845146, 3885.825137868803, 3919.7060220483577, 3962.821673024721, 62737.686311569065, 63180.68409657922, 63528.68235658885, 65903.34096659068, 66102.66948665226, 45347.0, 56052.71973640106, 56104.719476403174, 56459.43540564624, 56752.71623641856, 39475.407868881986, 42779.57220427756, 46948.59154225379, 47655.5234447658, 47889.76055119702, 8525.658973640984, 9032.232260257952, 9039.864402033843, 9051.54742262871, 9173.266138709021, 23344.6498302529, 24652.260432186347, 24955.625665615393, 25112.874435627706, 25243.11649092273, 29217.561736574393, 29782.25544361408, 29850.701492984794, 30076.699233007388, 30148.547771783004, 10957.671269861918, 11096.778064438828, 11139.944300278446, 11239.0, 11444.0, 11901.761964760482, 11967.401629918644, 12144.39278036077, 12487.825240016784, 12540.561080362144, 11218.326900386002, 11230.55077796879, 11514.36670983104, 11656.825147622962, 11931.880681193077, 11278.379689117177, 11619.244749091282, 11655.708607284885, 11771.882281177079, 12052.698682533006, 11122.44387780624, 11817.0, 11835.34905580167, 11855.525778968744, 11880.227785193934, 8422.83154336922, 8657.567121644019, 8926.41737032556, 9019.864702029343, 9051.954740226256, 9199.678011269574, 9348.0, 10194.133498652698, 10280.17758579297, 10382.68851934413], "value": 6196.24209702881, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1567.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 111.0, 111.0, 113.0, 112.0, 114.0, 111.0, 112.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 123.0, 123.0, 174.0, 126.0, 124.0, 130.0, 124.0, 150.0, 127.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 167.0, 173.0, 168.0, 166.0, 166.0, 165.0, 163.0, 164.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 113.0, 75.0, 76.0, 75.0, 75.0, 91.0, 79.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 101.0, 86.0, 85.0, 84.0, 108.0, 85.0, 84.0, 103.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 115.0, 114.0, 115.0, 114.0, 115.0, 114.0, 114.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 152.0, 152.0, 165.0, 151.0, 151.0, 150.0, 150.0, 151.0, 151.0], "value": 152.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 70.0, 69.0, 71.0, 72.0, 69.0, 71.0, 69.0, 71.0], "value": 70.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 56.0, 56.0, 56.0, 55.0, 56.0, 56.0, 55.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 84.0, 84.0, 94.0, 93.0, 92.0, 83.0, 83.0, 82.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 135.0, 133.0, 132.0, 138.0, 140.0, 141.0, 138.0, 183.0, 136.0], "value": 142.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 195.0, 186.0, 196.0, 203.0, 195.0, 192.0, 204.0, 202.0, 183.0], "value": 194.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 71.0, 74.0, 73.0, 70.0, 76.0, 73.0, 70.0, 70.0], "value": 72.3, "unit": "score"}]}]} 04:52:01 INFO - Return code: 0 04:52:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:52:01 ERROR - # TBPL SUCCESS # 04:52:01 INFO - Running post-action listener: _resource_record_post_action 04:52:01 INFO - [mozharness: 2017-03-27 11:52:01.405443Z] Finished run-tests step (success) 04:52:01 INFO - Running post-run listener: _resource_record_post_run 04:52:01 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 258285568; Read time: 24; Write time: 141772 04:52:01 INFO - TinderboxPrint: CPU usage
13.3% 04:52:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 04:52:01 INFO - TinderboxPrint: I/O write bytes / time
258,285,568 / 141,772 04:52:01 INFO - TinderboxPrint: CPU idle
8,309.2 (86.7%) 04:52:01 INFO - TinderboxPrint: CPU user
1,219.9 (12.7%) 04:52:01 INFO - TinderboxPrint: Swap in / out
0 / 0 04:52:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 2822144; Read time: 0; Write time: 588 04:52:01 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 255463424; Read time: 24; Write time: 141184 04:52:02 INFO - Running post-run listener: _upload_blobber_files 04:52:02 INFO - Blob upload gear active. 04:52:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:52:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:52:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:52:02 INFO - (blobuploader) - INFO - Open directory for files ... 04:52:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:52:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:52:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:05 INFO - (blobuploader) - INFO - Done attempting. 04:52:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:52:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:52:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:07 INFO - (blobuploader) - INFO - Done attempting. 04:52:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:52:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:52:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:08 INFO - (blobuploader) - INFO - Done attempting. 04:52:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:52:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:52:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:09 INFO - (blobuploader) - INFO - Done attempting. 04:52:09 INFO - (blobuploader) - INFO - Iteration through files over. 04:52:09 INFO - Return code: 0 04:52:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:52:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:52:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8d9e5a0921c86606d8a16f072693617b839386e96e3358ba59d3541a5ec1880a8890ebccdc57f9f032292903bfc868f343fc536438c908d3db4525f0f26076b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c03672da34a90c36e099a1da99ca7e903b83d603273f1d05af4b3bca47009f59393ba58165ad0d39fe51fa083c8a84429e4c4cf303170e727a255a4270a2d137", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4720c1a12686d70a17350ccf4db787529a718ea2547ce7770f27b5cca79896a1524643049a9cc9463dd4b6c40d4b65a0494ac021f5afbc7ad82c3caa57c07844", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5eadd449cad3b9f47cf2ecf3621f7a231e0138b4aa8e92eff825b3672eaa37dca9339a26c1434506f332db8940adde10d07aa471300a4dce61a62af751470a6e"} 04:52:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:52:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:52:09 INFO - Contents: 04:52:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8d9e5a0921c86606d8a16f072693617b839386e96e3358ba59d3541a5ec1880a8890ebccdc57f9f032292903bfc868f343fc536438c908d3db4525f0f26076b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c03672da34a90c36e099a1da99ca7e903b83d603273f1d05af4b3bca47009f59393ba58165ad0d39fe51fa083c8a84429e4c4cf303170e727a255a4270a2d137", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4720c1a12686d70a17350ccf4db787529a718ea2547ce7770f27b5cca79896a1524643049a9cc9463dd4b6c40d4b65a0494ac021f5afbc7ad82c3caa57c07844", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5eadd449cad3b9f47cf2ecf3621f7a231e0138b4aa8e92eff825b3672eaa37dca9339a26c1434506f332db8940adde10d07aa471300a4dce61a62af751470a6e"} 04:52:09 INFO - Running post-run listener: copy_logs_to_upload_dir 04:52:09 INFO - Copying logs to upload dir... 04:52:09 INFO - mkdir: /builds/slave/test/build/upload/logs 04:52:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.754587 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-03-27 04:52:07.804889) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 04:52:07.808593) ========= 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=51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8d9e5a0921c86606d8a16f072693617b839386e96e3358ba59d3541a5ec1880a8890ebccdc57f9f032292903bfc868f343fc536438c908d3db4525f0f26076b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c03672da34a90c36e099a1da99ca7e903b83d603273f1d05af4b3bca47009f59393ba58165ad0d39fe51fa083c8a84429e4c4cf303170e727a255a4270a2d137", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4720c1a12686d70a17350ccf4db787529a718ea2547ce7770f27b5cca79896a1524643049a9cc9463dd4b6c40d4b65a0494ac021f5afbc7ad82c3caa57c07844", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5eadd449cad3b9f47cf2ecf3621f7a231e0138b4aa8e92eff825b3672eaa37dca9339a26c1434506f332db8940adde10d07aa471300a4dce61a62af751470a6e"} build_url:https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011482 build_url: 'https://queue.taskcluster.net/v1/task/NHWnFCYqQ9O1R46PMmJ_dQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8d9e5a0921c86606d8a16f072693617b839386e96e3358ba59d3541a5ec1880a8890ebccdc57f9f032292903bfc868f343fc536438c908d3db4525f0f26076b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c03672da34a90c36e099a1da99ca7e903b83d603273f1d05af4b3bca47009f59393ba58165ad0d39fe51fa083c8a84429e4c4cf303170e727a255a4270a2d137", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4720c1a12686d70a17350ccf4db787529a718ea2547ce7770f27b5cca79896a1524643049a9cc9463dd4b6c40d4b65a0494ac021f5afbc7ad82c3caa57c07844", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5eadd449cad3b9f47cf2ecf3621f7a231e0138b4aa8e92eff825b3672eaa37dca9339a26c1434506f332db8940adde10d07aa471300a4dce61a62af751470a6e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 04:52:07.834483) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 04:52:07.834812) ========= 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=51fc86400edbde9650d2781a000001d0-1490614243.647958-1798506206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 04:52:07.921811) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 04:52:07.922350) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 04:52:07.922856) ========= ========= Total master_lag: 0.67 =========