builder: graphics_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-026 starttime: 1483773481.23 results: success (0) revision: c9e24b5d23ece9fec19ef17c402db2e06c040c9c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-06 23:18:01.233502) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-06 23:18:01.233916) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-06 23:18:01.234201) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-06 23:18:01.274061) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 23:18:01.274320) ========= 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=41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-06 23:18:01-- 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% 66.7M=0s 2017-01-06 23:18:01 (66.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117765 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 23:18:01.405751) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 23:18:01.406114) ========= 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=41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014962 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 23:18:01.455442) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 23:18:01.455736) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev c9e24b5d23ece9fec19ef17c402db2e06c040c9c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/graphics --rev c9e24b5d23ece9fec19ef17c402db2e06c040c9c --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=41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-06 23:18:01,650 truncating revision to first 12 chars 2017-01-06 23:18:01,650 Setting DEBUG logging. 2017-01-06 23:18:01,650 attempt 1/10 2017-01-06 23:18:01,651 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/c9e24b5d23ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-06 23:18:01,960 unpacking tar archive at: graphics-c9e24b5d23ec/testing/mozharness/ program finished with exit code 0 elapsedTime=0.611851 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 23:18:02.080184) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-06 23:18:02.080467) ========= script_repo_revision: c9e24b5d23ece9fec19ef17c402db2e06c040c9c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-06 23:18:02.080850) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-06 23:18:02.081135) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-06 23:18:02.088549) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-01-06 23:18:02.088814) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:18:02 INFO - MultiFileLogger online at 20170106 23:18:02 in /builds/slave/test 23:18:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 23:18:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:18:02 INFO - {'append_to_log': False, 23:18:02 INFO - 'base_work_dir': '/builds/slave/test', 23:18:02 INFO - 'blob_upload_branch': 'Graphics', 23:18:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:18:02 INFO - 'branch': 'Graphics', 23:18:02 INFO - 'buildbot_json_path': 'buildprops.json', 23:18:02 INFO - 'config_files': ('talos/linux_config.py',), 23:18:02 INFO - 'default_actions': ('clobber', 23:18:02 INFO - 'read-buildbot-config', 23:18:02 INFO - 'download-and-extract', 23:18:02 INFO - 'populate-webroot', 23:18:02 INFO - 'create-virtualenv', 23:18:02 INFO - 'install', 23:18:02 INFO - 'run-tests'), 23:18:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:18:02 INFO - 'download_minidump_stackwalk': True, 23:18:02 INFO - 'download_symbols': 'ondemand', 23:18:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:18:02 INFO - 'tooltool.py': '/tools/tooltool.py', 23:18:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:18:02 INFO - '/tools/misc-python/virtualenv.py')}, 23:18:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:18:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:18:02 INFO - 'installer_path': 'installer.exe', 23:18:02 INFO - 'log_level': 'info', 23:18:02 INFO - 'log_name': 'talos', 23:18:02 INFO - 'log_to_console': True, 23:18:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:18:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:18:02 INFO - 'opt_config_files': (), 23:18:02 INFO - 'pip_index': False, 23:18:02 INFO - 'sps_profile': False, 23:18:02 INFO - 'sps_profile_interval': 0, 23:18:02 INFO - 'suite': 'dromaeojs-e10s', 23:18:02 INFO - 'system_bits': '32', 23:18:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:18:02 INFO - 'title': 'talos-linux64-ix-026', 23:18:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:18:02 INFO - 'use_talos_json': True, 23:18:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:18:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:18:02 INFO - 'work_dir': 'build'} 23:18:02 INFO - [mozharness: 2017-01-07 07:18:02.377878Z] Running clobber step. 23:18:02 INFO - Running pre-action listener: _resource_record_pre_action 23:18:02 INFO - Running main action method: clobber 23:18:02 INFO - rmtree: /builds/slave/test/build 23:18:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:18:03 INFO - Running post-action listener: _resource_record_post_action 23:18:03 INFO - [mozharness: 2017-01-07 07:18:03.356490Z] Finished clobber step (success) 23:18:03 INFO - [mozharness: 2017-01-07 07:18:03.356589Z] Running read-buildbot-config step. 23:18:03 INFO - Running pre-action listener: _resource_record_pre_action 23:18:03 INFO - Running main action method: read_buildbot_config 23:18:03 INFO - Using buildbot properties: 23:18:03 INFO - { 23:18:03 INFO - "project": "", 23:18:03 INFO - "product": "firefox", 23:18:03 INFO - "who": "mchang@mozilla.com", 23:18:03 INFO - "installer_path": "public/build/target.tar.bz2", 23:18:03 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs-e10s", 23:18:03 INFO - "repository": "https://hg.mozilla.org/projects/graphics/", 23:18:03 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs-e10s", 23:18:03 INFO - "stage_platform": "linux64", 23:18:03 INFO - "basedir": "/builds/slave/test", 23:18:03 INFO - "buildnumber": 31, 23:18:03 INFO - "platform": "ubuntu64_hw", 23:18:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:18:03 INFO - "slavebuilddir": "test", 23:18:03 INFO - "taskId": "EzvIoP5oSn6xm1UBPM5Z1w", 23:18:03 INFO - "branch": "graphics", 23:18:03 INFO - "script_repo_revision": "default", 23:18:03 INFO - "revision": "c9e24b5d23ece9fec19ef17c402db2e06c040c9c", 23:18:03 INFO - "slavename": "talos-linux64-ix-026", 23:18:03 INFO - "repo_path": "projects/graphics" 23:18:03 INFO - } 23:18:03 INFO - Finding installer, test and symbols from parent task. 23:18:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EzvIoP5oSn6xm1UBPM5Z1w'}, attempt #1 23:18:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EzvIoP5oSn6xm1UBPM5Z1w'}, attempt #1 23:18:04 INFO - Task dependencies: HvcOkj5IQXee8d4uiGgpuw 23:18:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HvcOkj5IQXee8d4uiGgpuw'}, attempt #1 23:18:04 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HvcOkj5IQXee8d4uiGgpuw/artifacts/public/build/target.tar.bz2 23:18:04 INFO - Set test_url: https://queue.taskcluster.net/v1/task/HvcOkj5IQXee8d4uiGgpuw/artifacts/public/build/test_packages.json 23:18:04 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HvcOkj5IQXee8d4uiGgpuw/artifacts/public/build/target.crashreporter-symbols.zip 23:18:04 INFO - Running post-action listener: _resource_record_post_action 23:18:04 INFO - [mozharness: 2017-01-07 07:18:04.762726Z] Finished read-buildbot-config step (success) 23:18:04 INFO - [mozharness: 2017-01-07 07:18:04.762943Z] Running download-and-extract step. 23:18:04 INFO - Running pre-action listener: _resource_record_pre_action 23:18:04 INFO - Running main action method: download_and_extract 23:18:04 INFO - mkdir: /builds/slave/test/build/tests 23:18:04 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')]} 23:18:04 INFO - trying https://queue.taskcluster.net/v1/task/HvcOkj5IQXee8d4uiGgpuw/artifacts/public/build/target.test_packages.json 23:18:04 INFO - Downloading https://queue.taskcluster.net/v1/task/HvcOkj5IQXee8d4uiGgpuw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 23:18:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HvcOkj5IQXee8d4uiGgpuw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 23:18:05 INFO - Downloaded 896 bytes. 23:18:05 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 23:18:05 INFO - Using the following test package requirements: 23:18:05 INFO - {u'common': [u'target.common.tests.zip'], 23:18:05 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 23:18:05 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 23:18:05 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 23:18:05 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 23:18:05 INFO - u'mozbase': [u'target.common.tests.zip'], 23:18:05 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 23:18:05 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 23:18:05 INFO - u'web-platform': [u'target.common.tests.zip', 23:18:05 INFO - u'target.web-platform.tests.zip'], 23:18:05 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 23:18:05 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 23:18:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HvcOkj5IQXee8d4uiGgpuw/artifacts/public/build/target.common.tests.zip 23:18:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HvcOkj5IQXee8d4uiGgpuw/artifacts/public/build/target.common.tests.zip'}, attempt #1 23:18:05 INFO - Fetch https://queue.taskcluster.net/v1/task/HvcOkj5IQXee8d4uiGgpuw/artifacts/public/build/target.common.tests.zip into memory 23:18:06 INFO - Expected file size: 20246889 23:18:06 INFO - Obtained file size: 20246889 23:18:10 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 23:18:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HvcOkj5IQXee8d4uiGgpuw/artifacts/public/build/target.common.tests.zip 23:18:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HvcOkj5IQXee8d4uiGgpuw/artifacts/public/build/target.common.tests.zip'}, attempt #1 23:18:10 INFO - Fetch https://queue.taskcluster.net/v1/task/HvcOkj5IQXee8d4uiGgpuw/artifacts/public/build/target.common.tests.zip into memory 23:18:11 INFO - Expected file size: 20246889 23:18:11 INFO - Obtained file size: 20246889 23:18:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HvcOkj5IQXee8d4uiGgpuw/artifacts/public/build/target.talos.tests.zip 23:18:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HvcOkj5IQXee8d4uiGgpuw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 23:18:15 INFO - Fetch https://queue.taskcluster.net/v1/task/HvcOkj5IQXee8d4uiGgpuw/artifacts/public/build/target.talos.tests.zip into memory 23:18:16 INFO - Expected file size: 14403730 23:18:16 INFO - Obtained file size: 14403730 23:18:16 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')]} 23:18:16 INFO - trying https://queue.taskcluster.net/v1/task/HvcOkj5IQXee8d4uiGgpuw/artifacts/public/build/target.tar.bz2 23:18:16 INFO - Downloading https://queue.taskcluster.net/v1/task/HvcOkj5IQXee8d4uiGgpuw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 23:18:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HvcOkj5IQXee8d4uiGgpuw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 23:18:17 INFO - Downloaded 55959605 bytes. 23:18:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HvcOkj5IQXee8d4uiGgpuw/artifacts/public/build/target.tar.bz2 23:18:17 INFO - mkdir: /builds/slave/test/properties 23:18:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:18:17 INFO - Writing to file /builds/slave/test/properties/build_url 23:18:17 INFO - Contents: 23:18:17 INFO - build_url:https://queue.taskcluster.net/v1/task/HvcOkj5IQXee8d4uiGgpuw/artifacts/public/build/target.tar.bz2 23:18:17 INFO - Running post-action listener: _resource_record_post_action 23:18:17 INFO - Running post-action listener: set_extra_try_arguments 23:18:17 INFO - [mozharness: 2017-01-07 07:18:17.845652Z] Finished download-and-extract step (success) 23:18:17 INFO - [mozharness: 2017-01-07 07:18:17.845787Z] Running populate-webroot step. 23:18:17 INFO - Running pre-action listener: _resource_record_pre_action 23:18:17 INFO - Running main action method: populate_webroot 23:18:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:18:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:18:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:18:17 INFO - '--tppagecycles', 23:18:17 INFO - '7'], 23:18:17 INFO - 'tests': ['tsvgm']}}, 23:18:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:18:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:18:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:18:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:18:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:18:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:18:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 23:18:17 INFO - 'talos_options': ['--disable-e10s'], 23:18:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:18:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 23:18:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:18:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 23:18:17 INFO - 'talos_options': ['--disable-e10s'], 23:18:17 INFO - 'tests': ['damp', 'tps']}, 23:18:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 23:18:17 INFO - 'tests': ['damp', 'tps']}, 23:18:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:18:17 INFO - 'tests': ['dromaeo_dom']}, 23:18:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:18:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:18:17 INFO - 'tests': ['basic_compositor_video']}, 23:18:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:18:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:18:17 INFO - 'tests': ['a11yr', 23:18:17 INFO - 'ts_paint', 23:18:17 INFO - 'tpaint', 23:18:17 INFO - 'sessionrestore', 23:18:17 INFO - 'sessionrestore_no_auto_restore', 23:18:17 INFO - 'tabpaint']}, 23:18:17 INFO - 'other-e10s': {'tests': ['a11yr', 23:18:17 INFO - 'ts_paint', 23:18:17 INFO - 'tpaint', 23:18:17 INFO - 'sessionrestore', 23:18:17 INFO - 'sessionrestore_no_auto_restore', 23:18:17 INFO - 'tabpaint']}, 23:18:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:18:17 INFO - 'ts_paint', 23:18:17 INFO - 'tpaint', 23:18:17 INFO - 'sessionrestore', 23:18:17 INFO - 'sessionrestore_no_auto_restore', 23:18:17 INFO - 'tabpaint']}, 23:18:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:18:17 INFO - 'ts_paint', 23:18:17 INFO - 'tpaint', 23:18:17 INFO - 'sessionrestore', 23:18:17 INFO - 'sessionrestore_no_auto_restore', 23:18:17 INFO - 'tabpaint']}, 23:18:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:18:17 INFO - 'tests': ['a11yr', 23:18:17 INFO - 'ts_paint', 23:18:17 INFO - 'tpaint', 23:18:17 INFO - 'sessionrestore', 23:18:17 INFO - 'sessionrestore_no_auto_restore', 23:18:17 INFO - 'tabpaint']}, 23:18:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:18:17 INFO - 'tests': ['a11yr', 23:18:17 INFO - 'ts_paint', 23:18:17 INFO - 'tpaint', 23:18:17 INFO - 'sessionrestore', 23:18:17 INFO - 'sessionrestore_no_auto_restore', 23:18:17 INFO - 'tabpaint']}, 23:18:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:18:17 INFO - 'tests': ['tsvgx', 23:18:17 INFO - 'tsvgr_opacity', 23:18:17 INFO - 'tart', 23:18:17 INFO - 'tscrollx', 23:18:17 INFO - 'cart', 23:18:17 INFO - 'tsvg_static']}, 23:18:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:18:17 INFO - 'tsvgr_opacity', 23:18:17 INFO - 'tart', 23:18:17 INFO - 'tscrollx', 23:18:17 INFO - 'cart', 23:18:17 INFO - 'tsvg_static']}, 23:18:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 23:18:17 INFO - 'talos_options': ['--disable-e10s'], 23:18:17 INFO - 'tests': ['tp5o']}, 23:18:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 23:18:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 23:18:17 INFO - 'talos_options': ['--disable-e10s', 23:18:17 INFO - '--xperf_path', 23:18:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:18:17 INFO - 'tests': ['tp5n']}, 23:18:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 23:18:17 INFO - 'talos_options': ['--xperf_path', 23:18:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:18:17 INFO - 'tests': ['tp5n']}}, 23:18:17 INFO - 'talos.zip': {'path': '', 23:18:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:18:17 INFO - Running post-action listener: _resource_record_post_action 23:18:17 INFO - [mozharness: 2017-01-07 07:18:17.864799Z] Finished populate-webroot step (success) 23:18:17 INFO - [mozharness: 2017-01-07 07:18:17.864931Z] Running create-virtualenv step. 23:18:17 INFO - Running pre-action listener: _resource_record_pre_action 23:18:17 INFO - Running main action method: create_virtualenv 23:18:17 INFO - Creating virtualenv /builds/slave/test/build/venv 23:18:17 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 23:18:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:18:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:18:17 INFO - Using real prefix '/usr' 23:18:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:18:18 INFO - Installing distribute.............................................................................................................................................................................................done. 23:18:20 INFO - Installing pip.................done. 23:18:20 INFO - Return code: 0 23:18:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:18:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:18:20 INFO - Reading from file tmpfile_stdout 23:18:20 INFO - Output received: 23:18:20 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) 23:18:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:18:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe3f0>, '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 0x2cbecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbf1a0>, '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': '41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157', '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 23:18:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:18:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:18:20 INFO - Using env: {'DISPLAY': ':0', 23:18:20 INFO - 'HOME': '/home/cltbld', 23:18:20 INFO - 'LANG': 'en_US.UTF-8', 23:18:20 INFO - 'LANGUAGE': 'en_US:en', 23:18:20 INFO - 'LOGNAME': 'cltbld', 23:18:20 INFO - 'MAIL': '/var/mail/cltbld', 23:18:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:20 INFO - 'MOZ_NO_REMOTE': '1', 23:18:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:20 INFO - 'NO_EM_RESTART': '1', 23:18:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:20 INFO - 'PWD': '/builds/slave/test', 23:18:20 INFO - 'SHELL': '/bin/bash', 23:18:20 INFO - 'SHLVL': '1', 23:18:20 INFO - 'TERM': 'linux', 23:18:20 INFO - 'TMOUT': '86400', 23:18:20 INFO - 'USER': 'cltbld', 23:18:20 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157', 23:18:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:20 INFO - '_': '/tools/buildbot/bin/python'} 23:18:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:20 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 23:18:20 INFO - Cleaning up... 23:18:20 INFO - Return code: 0 23:18:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:18:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x294f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe3f0>, '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 0x2cbecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbf1a0>, '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': '41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157', '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 23:18:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:18:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:18:20 INFO - Using env: {'DISPLAY': ':0', 23:18:20 INFO - 'HOME': '/home/cltbld', 23:18:20 INFO - 'LANG': 'en_US.UTF-8', 23:18:20 INFO - 'LANGUAGE': 'en_US:en', 23:18:20 INFO - 'LOGNAME': 'cltbld', 23:18:20 INFO - 'MAIL': '/var/mail/cltbld', 23:18:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:20 INFO - 'MOZ_NO_REMOTE': '1', 23:18:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:20 INFO - 'NO_EM_RESTART': '1', 23:18:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:20 INFO - 'PWD': '/builds/slave/test', 23:18:20 INFO - 'SHELL': '/bin/bash', 23:18:20 INFO - 'SHLVL': '1', 23:18:20 INFO - 'TERM': 'linux', 23:18:20 INFO - 'TMOUT': '86400', 23:18:20 INFO - 'USER': 'cltbld', 23:18:20 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157', 23:18:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:20 INFO - '_': '/tools/buildbot/bin/python'} 23:18:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:21 INFO - Downloading/unpacking psutil>=3.1.1 23:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:18:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:18:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:18:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:18:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:18:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:18:23 INFO - Installing collected packages: psutil 23:18:23 INFO - Running setup.py install for psutil 23:18:23 INFO - building 'psutil._psutil_linux' extension 23:18:23 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 23:18:23 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 23:18:23 INFO - building 'psutil._psutil_posix' extension 23:18:23 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 23:18:23 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 23:18:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:18:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:18:23 INFO - Successfully installed psutil 23:18:23 INFO - Cleaning up... 23:18:23 INFO - Return code: 0 23:18:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:18: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')]} 23:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18: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')]} 23:18:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe3f0>, '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 0x2cbecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbf1a0>, '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': '41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157', '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 23:18: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:18: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 mozsystemmonitor==0.3 23:18:23 INFO - Using env: {'DISPLAY': ':0', 23:18:23 INFO - 'HOME': '/home/cltbld', 23:18:23 INFO - 'LANG': 'en_US.UTF-8', 23:18:23 INFO - 'LANGUAGE': 'en_US:en', 23:18:23 INFO - 'LOGNAME': 'cltbld', 23:18:23 INFO - 'MAIL': '/var/mail/cltbld', 23:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:23 INFO - 'MOZ_NO_REMOTE': '1', 23:18:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:23 INFO - 'NO_EM_RESTART': '1', 23:18:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:23 INFO - 'PWD': '/builds/slave/test', 23:18:23 INFO - 'SHELL': '/bin/bash', 23:18:23 INFO - 'SHLVL': '1', 23:18:23 INFO - 'TERM': 'linux', 23:18:23 INFO - 'TMOUT': '86400', 23:18:23 INFO - 'USER': 'cltbld', 23:18:23 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157', 23:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:23 INFO - '_': '/tools/buildbot/bin/python'} 23:18:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:18:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:18:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:18:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:18:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:18:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:18:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:18:25 INFO - Installing collected packages: mozsystemmonitor 23:18:25 INFO - Running setup.py install for mozsystemmonitor 23:18:26 INFO - Successfully installed mozsystemmonitor 23:18:26 INFO - Cleaning up... 23:18:26 INFO - Return code: 0 23:18:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe3f0>, '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 0x2cbecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbf1a0>, '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': '41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157', '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 23:18:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:18:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:18:26 INFO - Using env: {'DISPLAY': ':0', 23:18:26 INFO - 'HOME': '/home/cltbld', 23:18:26 INFO - 'LANG': 'en_US.UTF-8', 23:18:26 INFO - 'LANGUAGE': 'en_US:en', 23:18:26 INFO - 'LOGNAME': 'cltbld', 23:18:26 INFO - 'MAIL': '/var/mail/cltbld', 23:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:26 INFO - 'MOZ_NO_REMOTE': '1', 23:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:26 INFO - 'NO_EM_RESTART': '1', 23:18:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:26 INFO - 'PWD': '/builds/slave/test', 23:18:26 INFO - 'SHELL': '/bin/bash', 23:18:26 INFO - 'SHLVL': '1', 23:18:26 INFO - 'TERM': 'linux', 23:18:26 INFO - 'TMOUT': '86400', 23:18:26 INFO - 'USER': 'cltbld', 23:18:26 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157', 23:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:26 INFO - '_': '/tools/buildbot/bin/python'} 23:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:26 INFO - Downloading/unpacking jsonschema==2.5.1 23:18:26 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 23:18:26 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 23:18:26 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 23:18:26 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 23:18:26 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 23:18:26 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 23:18:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:18:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:18:28 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 23:18:28 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 23:18:28 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 23:18:28 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 23:18:28 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 23:18:28 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 23:18:28 INFO - Downloading functools32-3.2.3-2.tar.gz 23:18:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:18:28 INFO - warning: no files found matching '*.txt' 23:18:28 INFO - no previously-included directories found matching 'build' 23:18:28 INFO - no previously-included directories found matching 'dist' 23:18:28 INFO - no previously-included directories found matching '.git*' 23:18:28 INFO - Installing collected packages: jsonschema, functools32 23:18:28 INFO - Running setup.py install for functools32 23:18:28 INFO - warning: no files found matching '*.txt' 23:18:28 INFO - no previously-included directories found matching 'build' 23:18:28 INFO - no previously-included directories found matching 'dist' 23:18:28 INFO - no previously-included directories found matching '.git*' 23:18:28 INFO - Successfully installed jsonschema functools32 23:18:28 INFO - Cleaning up... 23:18:28 INFO - Return code: 0 23:18:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:18:28 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')]} 23:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:28 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')]} 23:18:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:28 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 0x294f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe3f0>, '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 0x2cbecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbf1a0>, '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': '41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157', '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 23:18:28 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 23:18:28 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 23:18:28 INFO - Using env: {'DISPLAY': ':0', 23:18:28 INFO - 'HOME': '/home/cltbld', 23:18:28 INFO - 'LANG': 'en_US.UTF-8', 23:18:28 INFO - 'LANGUAGE': 'en_US:en', 23:18:28 INFO - 'LOGNAME': 'cltbld', 23:18:28 INFO - 'MAIL': '/var/mail/cltbld', 23:18:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:28 INFO - 'MOZ_NO_REMOTE': '1', 23:18:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:28 INFO - 'NO_EM_RESTART': '1', 23:18:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:28 INFO - 'PWD': '/builds/slave/test', 23:18:28 INFO - 'SHELL': '/bin/bash', 23:18:28 INFO - 'SHLVL': '1', 23:18:28 INFO - 'TERM': 'linux', 23:18:28 INFO - 'TMOUT': '86400', 23:18:28 INFO - 'USER': 'cltbld', 23:18:28 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157', 23:18:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:28 INFO - '_': '/tools/buildbot/bin/python'} 23:18:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:18:29 INFO - Cleaning up... 23:18:29 INFO - Return code: 0 23:18:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:18:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe3f0>, '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 0x2cbecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbf1a0>, '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': '41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157', '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 23:18:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:18:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:18:29 INFO - Using env: {'DISPLAY': ':0', 23:18:29 INFO - 'HOME': '/home/cltbld', 23:18:29 INFO - 'LANG': 'en_US.UTF-8', 23:18:29 INFO - 'LANGUAGE': 'en_US:en', 23:18:29 INFO - 'LOGNAME': 'cltbld', 23:18:29 INFO - 'MAIL': '/var/mail/cltbld', 23:18:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:29 INFO - 'MOZ_NO_REMOTE': '1', 23:18:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:29 INFO - 'NO_EM_RESTART': '1', 23:18:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:29 INFO - 'PWD': '/builds/slave/test', 23:18:29 INFO - 'SHELL': '/bin/bash', 23:18:29 INFO - 'SHLVL': '1', 23:18:29 INFO - 'TERM': 'linux', 23:18:29 INFO - 'TMOUT': '86400', 23:18:29 INFO - 'USER': 'cltbld', 23:18:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157', 23:18:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:29 INFO - '_': '/tools/buildbot/bin/python'} 23:18:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:29 INFO - Downloading/unpacking blobuploader==1.2.4 23:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:18:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:18:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:18:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:18:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:18:31 INFO - Downloading blobuploader-1.2.4.tar.gz 23:18:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:18:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:18: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 23:18: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 23:18: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 23:18: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 23:18: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 23:18: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 23:18:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:18:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:18: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 23:18: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 23:18: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 23:18: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 23:18: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 23:18: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 23:18:32 INFO - Downloading docopt-0.6.1.tar.gz 23:18:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:18:32 INFO - Installing collected packages: blobuploader, requests, docopt 23:18:32 INFO - Running setup.py install for blobuploader 23:18:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:18:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:18:32 INFO - Running setup.py install for requests 23:18:32 INFO - Running setup.py install for docopt 23:18:32 INFO - Successfully installed blobuploader requests docopt 23:18:32 INFO - Cleaning up... 23:18:32 INFO - Return code: 0 23:18:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:32 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 0x294f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe3f0>, '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 0x2cbecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbf1a0>, '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': '41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157', '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 23:18:32 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 23:18:32 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 23:18:32 INFO - Using env: {'DISPLAY': ':0', 23:18:32 INFO - 'HOME': '/home/cltbld', 23:18:32 INFO - 'LANG': 'en_US.UTF-8', 23:18:32 INFO - 'LANGUAGE': 'en_US:en', 23:18:32 INFO - 'LOGNAME': 'cltbld', 23:18:32 INFO - 'MAIL': '/var/mail/cltbld', 23:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:32 INFO - 'MOZ_NO_REMOTE': '1', 23:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:32 INFO - 'NO_EM_RESTART': '1', 23:18:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:32 INFO - 'PWD': '/builds/slave/test', 23:18:32 INFO - 'SHELL': '/bin/bash', 23:18:32 INFO - 'SHLVL': '1', 23:18:32 INFO - 'TERM': 'linux', 23:18:32 INFO - 'TMOUT': '86400', 23:18:32 INFO - 'USER': 'cltbld', 23:18:32 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157', 23:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:32 INFO - '_': '/tools/buildbot/bin/python'} 23:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:18:32 INFO - Running setup.py (path:/tmp/pip-i6YXAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:18:32 INFO - Running setup.py (path:/tmp/pip-OfdFOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:18:33 INFO - Running setup.py (path:/tmp/pip-TXi_Ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:18:33 INFO - Running setup.py (path:/tmp/pip-e1srsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:18:33 INFO - Running setup.py (path:/tmp/pip-05cXLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:18:33 INFO - Running setup.py (path:/tmp/pip-wWuqBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:18:33 INFO - Running setup.py (path:/tmp/pip-h2AvAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:18:33 INFO - Running setup.py (path:/tmp/pip-PrluRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:18:33 INFO - Running setup.py (path:/tmp/pip-PZu_vA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:18:33 INFO - Running setup.py (path:/tmp/pip-1PZ02G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:18:33 INFO - Running setup.py (path:/tmp/pip-d3b8fx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:18:33 INFO - Running setup.py (path:/tmp/pip-D73yQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:18:33 INFO - Running setup.py (path:/tmp/pip-XuED46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:18:33 INFO - Running setup.py (path:/tmp/pip-3UV3Ok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:18:33 INFO - Running setup.py (path:/tmp/pip-PfSfOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:18:33 INFO - Running setup.py (path:/tmp/pip-cs1tT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:18:34 INFO - Running setup.py (path:/tmp/pip-Vvfw26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:18:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:18:34 INFO - Running setup.py install for manifestparser 23:18:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:18:34 INFO - Running setup.py install for mozcrash 23:18:34 INFO - Running setup.py install for mozdebug 23:18:34 INFO - Running setup.py install for mozdevice 23:18:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:18:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:18:34 INFO - Running setup.py install for mozfile 23:18:34 INFO - Running setup.py install for mozhttpd 23:18:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:18:34 INFO - Running setup.py install for mozinfo 23:18:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:18:34 INFO - Running setup.py install for mozInstall 23:18:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:18:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:18:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:18:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:18:34 INFO - Running setup.py install for mozleak 23:18:35 INFO - Running setup.py install for mozlog 23:18:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:18:35 INFO - Running setup.py install for moznetwork 23:18:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:18:35 INFO - Running setup.py install for mozprocess 23:18:35 INFO - Running setup.py install for mozprofile 23:18:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:18:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:18:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:18:35 INFO - Running setup.py install for mozrunner 23:18:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:18:35 INFO - Running setup.py install for mozscreenshot 23:18:35 INFO - Running setup.py install for moztest 23:18:35 INFO - Running setup.py install for mozversion 23:18:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:18:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:18:35 INFO - Cleaning up... 23:18:35 INFO - Return code: 0 23:18:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:35 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 0x294f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe3f0>, '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 0x2cbecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbf1a0>, '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': '41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157', '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 23:18:35 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 23:18:35 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 23:18:35 INFO - Using env: {'DISPLAY': ':0', 23:18:35 INFO - 'HOME': '/home/cltbld', 23:18:35 INFO - 'LANG': 'en_US.UTF-8', 23:18:35 INFO - 'LANGUAGE': 'en_US:en', 23:18:35 INFO - 'LOGNAME': 'cltbld', 23:18:35 INFO - 'MAIL': '/var/mail/cltbld', 23:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:35 INFO - 'MOZ_NO_REMOTE': '1', 23:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:35 INFO - 'NO_EM_RESTART': '1', 23:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:35 INFO - 'PWD': '/builds/slave/test', 23:18:35 INFO - 'SHELL': '/bin/bash', 23:18:35 INFO - 'SHLVL': '1', 23:18:35 INFO - 'TERM': 'linux', 23:18:35 INFO - 'TMOUT': '86400', 23:18:35 INFO - 'USER': 'cltbld', 23:18:35 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157', 23:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:35 INFO - '_': '/tools/buildbot/bin/python'} 23:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:18:36 INFO - Running setup.py (path:/tmp/pip-XfKyS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:18:36 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)) 23:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:18:36 INFO - Running setup.py (path:/tmp/pip-QLJ8i0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:18:36 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)) 23:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:18:36 INFO - Running setup.py (path:/tmp/pip-RklMpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:18:36 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)) 23:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:18:36 INFO - Running setup.py (path:/tmp/pip-NEtDfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:18:36 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)) 23:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:18:36 INFO - Running setup.py (path:/tmp/pip-HtMsT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:18:36 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)) 23:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:18:36 INFO - Running setup.py (path:/tmp/pip-AG17vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:18:36 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)) 23:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:18:36 INFO - Running setup.py (path:/tmp/pip-dT8neA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:18:36 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)) 23:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:18:36 INFO - Running setup.py (path:/tmp/pip-5_wbvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:18:36 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)) 23:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:18:36 INFO - Running setup.py (path:/tmp/pip-Rjf6vK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:18:36 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)) 23:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:18:36 INFO - Running setup.py (path:/tmp/pip-hUpEGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:18:36 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)) 23:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:18:36 INFO - Running setup.py (path:/tmp/pip-IWBhv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:18:36 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)) 23:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:18:36 INFO - Running setup.py (path:/tmp/pip-OH0H_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:18:37 INFO - Running setup.py (path:/tmp/pip-s49fT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:18:37 INFO - Running setup.py (path:/tmp/pip-IH9dc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:18:37 INFO - Running setup.py (path:/tmp/pip-GwOGkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:18:37 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)) 23:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:18:37 INFO - Running setup.py (path:/tmp/pip-SjTOyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:18:37 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)) 23:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:18:37 INFO - Running setup.py (path:/tmp/pip-EDlRAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:18:37 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)) 23:18:37 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)) 23:18:37 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)) 23:18:37 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)) 23:18:37 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)) 23:18:37 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)) 23:18:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:18:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:18:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:18:39 INFO - Downloading blessings-1.6.tar.gz 23:18:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:18:39 INFO - Installing collected packages: blessings 23:18:39 INFO - Running setup.py install for blessings 23:18:39 INFO - Successfully installed blessings 23:18:39 INFO - Cleaning up... 23:18:39 INFO - Return code: 0 23:18:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:18:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:18:39 INFO - Reading from file tmpfile_stdout 23:18:39 INFO - Current package versions: 23:18:39 INFO - argparse == 1.2.1 23:18:39 INFO - blessings == 1.6 23:18:39 INFO - blobuploader == 1.2.4 23:18:39 INFO - docopt == 0.6.1 23:18:39 INFO - functools32 == 3.2.3-2 23:18:39 INFO - jsonschema == 2.5.1 23:18:39 INFO - manifestparser == 1.1 23:18:39 INFO - mozInstall == 1.12 23:18:39 INFO - mozcrash == 1.0 23:18:39 INFO - mozdebug == 0.1 23:18:39 INFO - mozdevice == 0.49 23:18:39 INFO - mozfile == 1.2 23:18:39 INFO - mozhttpd == 0.7 23:18:39 INFO - mozinfo == 0.9 23:18:39 INFO - mozleak == 0.1 23:18:39 INFO - mozlog == 3.4 23:18:39 INFO - moznetwork == 0.27 23:18:39 INFO - mozprocess == 0.23 23:18:39 INFO - mozprofile == 0.28 23:18:39 INFO - mozrunner == 6.13 23:18:39 INFO - mozscreenshot == 0.1 23:18:39 INFO - mozsystemmonitor == 0.3 23:18:39 INFO - moztest == 0.8 23:18:39 INFO - mozversion == 1.4 23:18:39 INFO - psutil == 3.1.1 23:18:39 INFO - requests == 1.2.3 23:18:39 INFO - wsgiref == 0.1.2 23:18:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:39 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 0x294f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe3f0>, '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 0x2cbecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbf1a0>, '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': '41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157', '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 23:18:39 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 23:18:39 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 23:18:39 INFO - Using env: {'DISPLAY': ':0', 23:18:39 INFO - 'HOME': '/home/cltbld', 23:18:39 INFO - 'LANG': 'en_US.UTF-8', 23:18:39 INFO - 'LANGUAGE': 'en_US:en', 23:18:39 INFO - 'LOGNAME': 'cltbld', 23:18:39 INFO - 'MAIL': '/var/mail/cltbld', 23:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:39 INFO - 'MOZ_NO_REMOTE': '1', 23:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:39 INFO - 'NO_EM_RESTART': '1', 23:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:39 INFO - 'PWD': '/builds/slave/test', 23:18:39 INFO - 'SHELL': '/bin/bash', 23:18:39 INFO - 'SHLVL': '1', 23:18:39 INFO - 'TERM': 'linux', 23:18:39 INFO - 'TMOUT': '86400', 23:18:39 INFO - 'USER': 'cltbld', 23:18:39 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157', 23:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:39 INFO - '_': '/tools/buildbot/bin/python'} 23:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:18:40 INFO - Cleaning up... 23:18:40 INFO - Return code: 0 23:18:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:18:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x294f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe3f0>, '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 0x2cbecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbf1a0>, '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': '41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157', '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 23:18:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:18:40 INFO - Using env: {'DISPLAY': ':0', 23:18:40 INFO - 'HOME': '/home/cltbld', 23:18:40 INFO - 'LANG': 'en_US.UTF-8', 23:18:40 INFO - 'LANGUAGE': 'en_US:en', 23:18:40 INFO - 'LOGNAME': 'cltbld', 23:18:40 INFO - 'MAIL': '/var/mail/cltbld', 23:18:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:40 INFO - 'MOZ_NO_REMOTE': '1', 23:18:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:40 INFO - 'NO_EM_RESTART': '1', 23:18:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:40 INFO - 'PWD': '/builds/slave/test', 23:18:40 INFO - 'SHELL': '/bin/bash', 23:18:40 INFO - 'SHLVL': '1', 23:18:40 INFO - 'TERM': 'linux', 23:18:40 INFO - 'TMOUT': '86400', 23:18:40 INFO - 'USER': 'cltbld', 23:18:40 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157', 23:18:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:40 INFO - '_': '/tools/buildbot/bin/python'} 23:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:18:40 INFO - Cleaning up... 23:18:40 INFO - Return code: 0 23:18:40 INFO - Running post-action listener: _resource_record_post_action 23:18:40 INFO - Running post-action listener: _start_resource_monitoring 23:18:40 INFO - Starting resource monitoring. 23:18:40 INFO - [mozharness: 2017-01-07 07:18:40.349399Z] Finished create-virtualenv step (success) 23:18:40 INFO - [mozharness: 2017-01-07 07:18:40.349915Z] Running install step. 23:18:40 INFO - Running pre-action listener: _resource_record_pre_action 23:18:40 INFO - Running main action method: install 23:18:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:18:40 INFO - Reading from file tmpfile_stdout 23:18:40 INFO - Detecting whether we're running mozinstall >=1.0... 23:18:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:18:40 INFO - Reading from file tmpfile_stdout 23:18:40 INFO - Output received: 23:18:40 INFO - Usage: mozinstall [options] installer 23:18:40 INFO - Options: 23:18:40 INFO - -h, --help show this help message and exit 23:18:40 INFO - -d DEST, --destination=DEST 23:18:40 INFO - Directory to install application into. [default: 23:18:40 INFO - "/builds/slave/test"] 23:18:40 INFO - --app=APP Application being installed. [default: firefox] 23:18:40 INFO - mkdir: /builds/slave/test/build/application 23:18:40 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'] 23:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 23:18:56 INFO - Reading from file tmpfile_stdout 23:18:56 INFO - Output received: 23:18:56 INFO - /builds/slave/test/build/application/firefox/firefox 23:18:56 INFO - Running post-action listener: _resource_record_post_action 23:18:56 INFO - [mozharness: 2017-01-07 07:18:56.749877Z] Finished install step (success) 23:18:56 INFO - [mozharness: 2017-01-07 07:18:56.750159Z] Running run-tests step. 23:18:56 INFO - Running pre-action listener: _resource_record_pre_action 23:18:56 INFO - Running main action method: run_tests 23:18:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:18:56 INFO - Python 2.7.3 23:18:56 INFO - Return code: 0 23:18:56 INFO - grabbing minidump binary from tooltool 23:18:56 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')]} 23:18:56 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 0x2cbe3f0>, '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 0x2cbecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbf1a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:18:56 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 23:18:56 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 23:18:56 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 23:18:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:18:56 INFO - Return code: 0 23:18:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:18:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:18:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:18:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:18:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:18:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HvcOkj5IQXee8d4uiGgpuw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 23:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HvcOkj5IQXee8d4uiGgpuw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 23:18:56 INFO - Using env: {'DISPLAY': ':0', 23:18:56 INFO - 'HOME': '/home/cltbld', 23:18:56 INFO - 'LANG': 'en_US.UTF-8', 23:18:56 INFO - 'LANGUAGE': 'en_US:en', 23:18:56 INFO - 'LOGNAME': 'cltbld', 23:18:56 INFO - 'MAIL': '/var/mail/cltbld', 23:18:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:18:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:56 INFO - 'MOZ_NO_REMOTE': '1', 23:18:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:56 INFO - 'NO_EM_RESTART': '1', 23:18:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:56 INFO - 'PWD': '/builds/slave/test', 23:18:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:18:56 INFO - 'SHELL': '/bin/bash', 23:18:56 INFO - 'SHLVL': '1', 23:18:56 INFO - 'TERM': 'linux', 23:18:56 INFO - 'TMOUT': '86400', 23:18:56 INFO - 'USER': 'cltbld', 23:18:56 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157', 23:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:56 INFO - '_': '/tools/buildbot/bin/python'} 23:18:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HvcOkj5IQXee8d4uiGgpuw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 23:18:57 INFO - mozversion application_buildid: 20170107064119 23:18:57 INFO - mozversion application_changeset: c9e24b5d23ece9fec19ef17c402db2e06c040c9c 23:18:57 INFO - mozversion application_display_name: Nightly 23:18:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:18:57 INFO - mozversion application_name: Firefox 23:18:57 INFO - mozversion application_remotingname: firefox 23:18:57 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 23:18:57 INFO - mozversion application_vendor: Mozilla 23:18:57 INFO - mozversion application_version: 53.0a1 23:18:57 INFO - mozversion platform_buildid: 20170107064119 23:18:57 INFO - mozversion platform_changeset: c9e24b5d23ece9fec19ef17c402db2e06c040c9c 23:18:57 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 23:18:57 INFO - mozversion platform_version: 53.0a1 23:18:57 INFO - using testdate: 1483773537 23:18:57 INFO - actual date: 1483773537 23:18:57 INFO - starting webserver on 'localhost:57783' 23:18:57 INFO - SUITE-START | Running 2 tests 23:18:57 INFO - TEST-START | dromaeo_css 23:18:57 INFO - operating with platform_type : linux_ 23:18:57 INFO - Initialising browser for dromaeo_css test... 23:18:57 INFO - TEST-INFO | started process 5643 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpddGx52/profile http://localhost:57783/getInfo.html) 23:18:57 INFO - PROCESS | 5643 | 1483773537518 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 23:19:01 INFO - PROCESS | 5643 | __metrics Screen width/height:1600/1200 23:19:01 INFO - PROCESS | 5643 | colorDepth:24 23:19:01 INFO - PROCESS | 5643 | Browser inner width/height: 1024/697 23:19:01 INFO - PROCESS | 5643 | __metrics 23:19:02 ERROR - PROCESS | 5643 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 23:19:02 INFO - TEST-INFO | 5643: exit 0 23:19:02 INFO - Browser initialized. 23:19:02 INFO - Running cycle 1/1 for dromaeo_css test... 23:19:02 INFO - TEST-INFO | started process 5766 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpddGx52/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:19:14 INFO - PROCESS | 5766 | RSS: Main: 158527488 23:19:14 INFO - PROCESS | 5766 | 23:22:18 INFO - PROCESS | 5766 | Cycle 1(1): loaded http://localhost:57783/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57783/tests/dromaeo/cssquery-ext.html) 23:22:19 INFO - PROCESS | 5766 | RSS: Main: 167960576 23:22:19 INFO - PROCESS | 5766 | 23:24:03 INFO - PROCESS | 5766 | ************************* 23:24:03 INFO - PROCESS | 5766 | A coding exception was thrown and uncaught in a Task. 23:24:03 INFO - PROCESS | 5766 | 23:24:03 INFO - PROCESS | 5766 | Full message: ReferenceError: fetch is not defined 23:24:03 INFO - PROCESS | 5766 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 23:24:03 INFO - PROCESS | 5766 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 23:24:03 INFO - PROCESS | 5766 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 23:24:03 INFO - PROCESS | 5766 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 23:24:03 INFO - PROCESS | 5766 | TaskImpl@resource://gre/modules/Task.jsm:277:3 23:24:03 INFO - PROCESS | 5766 | asyncFunction@resource://gre/modules/Task.jsm:252:14 23:24:03 INFO - PROCESS | 5766 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 23:24:03 INFO - PROCESS | 5766 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 23:24:03 INFO - PROCESS | 5766 | TaskImpl@resource://gre/modules/Task.jsm:277:3 23:24:03 INFO - PROCESS | 5766 | asyncFunction@resource://gre/modules/Task.jsm:252:14 23:24:03 INFO - PROCESS | 5766 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 23:24:03 INFO - PROCESS | 5766 | 23:24:03 INFO - PROCESS | 5766 | ************************* 23:25:21 INFO - PROCESS | 5766 | Cycle 1(1): loaded http://localhost:57783/tests/dromaeo/cssquery-ext.html (next: http://localhost:57783/tests/dromaeo/cssquery-jquery.html) 23:25:22 INFO - PROCESS | 5766 | RSS: Main: 162869248 23:25:22 INFO - PROCESS | 5766 | 23:28:24 INFO - PROCESS | 5766 | Cycle 1(1): loaded http://localhost:57783/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57783/tests/dromaeo/cssquery-mootools.html) 23:28:25 INFO - PROCESS | 5766 | RSS: Main: 168615936 23:28:25 INFO - PROCESS | 5766 | 23:31:27 INFO - PROCESS | 5766 | Cycle 1(1): loaded http://localhost:57783/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57783/tests/dromaeo/cssquery-prototype.html) 23:31:27 INFO - PROCESS | 5766 | RSS: Main: 163491840 23:31:27 INFO - PROCESS | 5766 | 23:34:30 INFO - PROCESS | 5766 | Cycle 1(1): loaded http://localhost:57783/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57783/tests/dromaeo/cssquery-yui.html) 23:34:31 INFO - PROCESS | 5766 | RSS: Main: 166768640 23:34:31 INFO - PROCESS | 5766 | 23:37:34 INFO - PROCESS | 5766 | Cycle 1(1): loaded http://localhost:57783/tests/dromaeo/cssquery-yui.html (next: http://localhost:57783/tests/dromaeo/cssquery-dojo.html) 23:37:34 INFO - PROCESS | 5766 | RSS: Main: 167174144 23:37:34 INFO - PROCESS | 5766 | 23:37:34 INFO - PROCESS | 5766 | __start_tp_report 23:37:34 INFO - PROCESS | 5766 | _x_x_mozilla_page_load 23:37:34 INFO - PROCESS | 5766 | _x_x_mozilla_page_load_details 23:37:34 INFO - PROCESS | 5766 | |i|pagename|runs| 23:37:34 INFO - PROCESS | 5766 | |0;dojo.html;2540.720520742719;2548.9490210195795;2564.46146309275;2568.1140006697683;2602.908898188564;4530.7281563106235;4642.675012749109;4652.06958608278;4685.25035994241;4695.201815691332;4554.31685247213;4587.105514424688;4612.884677883055;4645.954660201453;4651.860444186671;4243.893902652443;4266.0614664773775;4306.7631280279575;4341.826326946934;4396.406485124515;4251.914961700764;4310.3965444837595;4330.285502892019;4347.3261644445165;4356.324769660708;4164.416981622575;4179.832806687728;4184.7070705050655;4259.148170365939;4301.677374196916;4227.3447615619625;4229.048464095585;4236.385724070024;4238.173556156551;4242.745435273893;4183.769892655902;4204.726692764991;4213.410122582841;4219.746815191098;4220.683448741357;4618.35343051973;4630.814767409333;4642.257238841769;4644.605208557243;4681.391419115527;4916.262560615901;4920;4925.3350797642215;4929.679570827885;4960.082384758831;4877.219644856841;4886.975565122188;4931.80272789088;4959.107360675077;5015.523525265094;4618.145643055978;4629.444466663955;4632.768361581908;4668.36977008103;4687.460941991714;5012.273220383024;5026.421961474404;5035.395752509649;5052.8484145475695;5057.418396884405;4726.692764970266;4767.213409787346;4821.0839940411915;4844.128056949783;4893.290472881412;4873.098476781806;4894.26586012094;4895.461499235082;4903.754812259373;4904.190808516555;4877.317175595419;4895.461499235082;4936.185529387611;4961.032598643302;4977.1538838397555;4889.144399730033;4901.289313049588;4903.607711383081;4917.680350777188;4932.950670493321;4107.568705285962;4151.647109995684;4196.034911970203;4200.180964711852;4243.236217480821;3647.325244829715;3663.139162296858;3675.6691897729334;3679.521662183899;3705.444183372516;4291.69958102936;4303.33298338758;4321.956780432219;4326.048269380732;4329.328954012133;4994.101061808909;5008.6744361616375;5013.548780609763;5023.6985780853265;5028.195488721787;4233.1956928183545;4263.637590804817;4264.829406823755;4279.593438623326;4337.7614231217585;4476.7090139140855;4477.19410506112;4486.506484286726;4490;4491.573300536444;4651.2557990721325;4654;4654.301854721819;4654.930176047362;4663.044075964419;4935.309056732132;4955.934474088089;4967;4976.576990955809;4981.501849814989;4618.722876627413;4700.858974230779;4706.435227772689;4731.408573928259;4747.430308363018;4855.490173531728;4868.780904859361;4882.4629290777275;4940.160172770566;4943.184374578298;4900.803967841246;4921.975390123026;4971.776270067928;4995.900081998267;5074.162763144188;4882.780274887709;4885.755712214446;4893.584045356185;4898.510148985073;4906.656534042583;4871.780769865435;4880.804767809248;4887.560119589254;4888.5111488850835;4920.286558449076;4602.355670206241;4641.327007583949;4655.30170474418;4721.055788842176;4727.456342520517;4863.465018847854;4870.269459581091;4877.707337559757;4907.533784290486;4917.827876024322;4704.741239231875;4730.905381892274;4754.263089221176;4762.3570817939135;4772.164871147605 23:37:34 INFO - PROCESS | 5766 | |1;ext.html;507.89080347725235;526.2527211359869;527.575301881985;529.4202847881571;545.1114683066605;37764.43353349699;39709.43341515726;39872;39885.80057099714;44332.55667443325;40885.79557102211;41191.794041029825;41210;41229.79385103078;41301.380479292835;7679.1936846631;7864.174261702525;7868.370530357586;7872.173421790687;7873.527588344689;9553.426794392359;9827.4103553787;9875.407475551454;10074.748131296703;10088.142507886838;9822.754431139207;9938.254630902675;9960.651377201799;9963;9969.850452243221;9879.753006174904;9888.555015024342;9934.652287169987;9937.602495900155;9946.104850563484;9727.854082188773;9798.804023919552;9812.411255324632;9824.459654718987;9832.90167098327;36002.45996310058;36136.63863361359;36139.638603613894;36233.09417264589;36273;3684.7420680552373;3726.38592431526;3750.474933509284;3758.4926034985474;3791.146991926822;25104.39769026346;25416.237512874643;25467;25491.74508254912;25877.223683289532;3544.543125108829;3552.982235088834;3574.3744844652083;3578.5526809148855;3621.203335266237;240564;243560;245738;246085;246177;49193;49501.01995920195;49521.25718114231;49541.25688114681;49641.50358496369;50903.23645145326;51143;51362.74318628383;51468.48531514712;51513.22730159051;13723.1079979801;14214.28928553589;14217.715645687029;14224;14228.573142805732;9200.585973631203;9283.535823208813;10835.51240194193;10976.560937562408;11125.276857004268;18773.93103861977;19339;19582.216711331672;19817.900910495355;19849;7383.704651813975;7605.619719014027;7641.159472458025;7650.502717323468;7720.3051725344985;820.2699597358355;821.2690705272313;827.9586020698941;835.8035861572525;839.5886015852188;27370.726292737218;28386.574201386997;28471.430571388457;28616.713832861406;28821.855890720413;979.3438396274371;983.1692220074026;997.3816233935007;1015.8628585140912;1123.2867129372744;13508.392122354519;15347.693046139015;15466.613334666497;15541.222938853012;15606.45377411808;372263;373926;377097;380727;380751;52177;52283.47716522862;52654;52817.7359113202;53025.2046219307;1212.4180393411211;1242.5340497313507;1273.1024627637494;1273.891719203878;1277.584784944878;26336.8683156583;27198;27673.72326276792;28154.01460948857;28232.43535129327;43394;43625;43630;43734.56265437432;43747.56252437435;301530;303281;303398;303449;304601;23591.29226123219;24175;24185.15351962673;39674.421162624334;40534;36518.08704782402;36892.446613301356;37045;37496.81251593724;37908;32329;33100.66899331072;33292.50061249132;35742.4638630426;35746;32562.511562327058;32761.836190818893;32785.836070819496;33063.33873322472;33868.49197261994;33268.667313327525;33613.327733444705;33916.152096197795;34008;38905.2218955625;34816.30367392689;36499.087522812144;38989.805050974566;39354.21291574095;39535.406968896066;29610.555841662823;30448.238794030327;30675;30704;30804.53793193149 23:37:34 INFO - PROCESS | 5766 | |2;jquery.html;372.40415335463246;380.8804005708233;383.9001859516526;390.9960900390995;397.41778294798115;16301.75547366789;18249.996250206234;18409.631807363843;18682.813171868293;18742.531436714056;17177.82822171778;18354.632907341846;18601.7209741854;18773.81226187741;18797.530061748465;5141.5886729061585;5220.347456567929;5238.7642556084875;5274.736263186845;5277.656952298088;5023.673461225027;5227.895442091156;5228.764705588239;5251.264822924793;5259.158534634459;5215.869603259911;5218.112920803454;5225.8954820903555;5231.503007214308;5235.371755389358;5062.443131255559;5210.687358758468;5237.921431178535;5251.028559716465;5253.080710875582;4689.460712018127;4702.717836929795;4702.8118875244945;4705.1530724469585;4710.905781884378;21352.359429216995;21405;21464.24875129363;21498.785012149834;21539.56920861574;2262.1856131792542;2303.57383883982;2311.5839148953182;2346.9530609387716;2373.2642880707035;12665.873341266562;13511.58128396514;13588.184708917497;13935.651608709763;14142.292885355793;1703.633718750462;1754.1930711872553;1781.6080462298273;1793.3543924187281;1822.1071674879213;62250.68874655598;70085;70332.94500582495;71834;73339;9657.420554766737;9922.553485093189;9966.152877005536;10142.543585538668;10170.237232207466;13621.659458513419;13653.38559764813;13654.86345136536;13670.726585468235;13685.589432317047;6853.897191542131;7082.575045497287;7108.4668649851465;7251.274872512812;7270.854582908312;6548.770793022221;6551.574147680385;6761.72953081881;6789.0834737310815;6811.4210292124735;6352.428281454691;6417.614943103429;6475.352464753487;6491.383318584727;6590.439812615981;1782.5008997480468;1782.97325540117;1822.2346614421974;1839.7700287464068;1843.3363988963963;385.43918598439205;395.3141299844767;396.98015099244924;863.5725315968635;865.9956700216585;10304.433256170983;10523.21075919309;10710.785784284426;10798.406087665096;10978;410.51559160190664;410.83155906078366;423.9809208585621;918.7014220378404;953.9952300238455;9559.187469065208;9981;9996.450195239331;10076.798464030824;10093.949530252448;531419;534043;538075;538860;546055;88182;91502.54248728714;91862.54068729613;92510.53744731368;93261.06738932659;919.7102912582515;953.1897886796306;977.53567055648;998.286225348879;1004.9799004019878;16506.38782813849;16909.746353804458;16968.40610578624;17010.149492525077;17329.56676083108;40922.79538602288;41539;41552;42173.789131054145;42829.78585107055;57962;58798.412015879294;59563;59682.40317596769;60005.39994599998;7812.57030863308;7984.760457186294;8162.18378162179;8170.264676179172;8197.79505512367;10150.593976240867;11999.40002999864;12259.264444133381;12713.300768457824;12731.363431828186;10741.516631751747;10814.989543792171;10911.890881091087;10971.559268098585;11006.394648294101;9949.452780097165;10713.037224957578;10907.509162087566;10956.178286628376;11384.203105782515;9723.611055557698;10477.057064864199;10497.790044199226;10571.682849514527;11311;7903.881441778493;8129.309008734087;8166.754997350089;8214.26071653554;8273.917260827555;8242.17578242171;10453.843192352273;10951.50718217698;10980.670579882617;11203.60787372438 23:37:34 INFO - PROCESS | 5766 | |3;mootools.html;1318.7889937609984;1321.6629759411348;1329.9601011969642;1337.2711872029736;1346.252829679528;6128.387161283869;6310.085037669547;6464.25661048979;6817.420519255869;6842.931570684292;6585.967070164643;6721.5630983986;6760.323967603237;6919.169699636038;6950.4092152167;2070.2443608083017;2110.2086717480943;2115.2596591193114;2117.4388786971463;2120.183729264229;2059.5685998231233;2086.6765651324067;2113;2126.9361919142452;2155.051777218019;2126.5321629241544;2145;2150.6021386043553;2161.1787520742173;2163.9783602163934;2042.673172292426;2044.8568600197991;2058.1355830551206;2063.3087915548385;2089.5298557824444;2050.8002818351283;2087.488565301496;2098.0907374289477;2119.8940052997286;2121.0455295117104;6905.274946130634;6908.171019477644;6949.861002779967;6971.442284617218;6977.581345119309;4213.978930105361;4304.3113101903855;4312.892177695551;4316.740995540246;4325.178216138924;2684.4899469101006;2818.1686402511104;2848.9145325640266;2886.2495751104652;2898.956515652246;1134.8014097532982;1161.1088389909066;1170.7599942011866;1202.4949521201117;1232.969175770604;8521.701740439055;8691.95654021726;8722.215000649909;8733.606987685569;8745.825083498294;3575.213453040327;3731.5708693500596;3749.1189570450924;3817.751846129993;3920.8039598019986;7178.748743794046;7203.89194162088;7219.602921839244;7289.562626242442;7294.088238970129;4226.154769046203;4318.179545886272;4321.891952701145;4325.632321252666;4335.848245311399;3839.5968423315708;3911.941320880189;3979.1444839359096;3990.700697447703;4007.579204183519;3035.924101897426;3048.4512787697986;3137.8117312961294;3163.066895265902;3193.9680603194133;836.8995720513456;863.0808189278398;917.7200953709183;921.6912334368062;926.4395041000098;821.8233079887733;825.7564018614523;839.8236370362292;859;860.6901515454431;4753.4295884493395;4773.880652983634;4815.085133824632;4997.350344455198;5088.185890257541;929.7117893453051;934.9205317547949;942.6512190489426;948.7296120605595;956.7273327101742;3353.6814002670194;3414.709749671306;3419.675130862564;3429.5713035870517;3471.3057388522398;7842.9215707842195;8022.558759268296;8048.315893149031;8094.31198348147;8138.3082437993435;8139.674413023531;8156.34749220061;8157.71447999329;8162.7143049992965;8178;6290.402411770874;6396.584222025554;6521.576097553644;6553.803385898431;6616.669166541654;4633.142868569325;4675.251959686434;4760.309755085563;4894.486078961801;4970.726610036482;7467.813304667427;7491.10106787189;7558.58427786477;7618.69525218985;7678.884816727642;7466.440016998856;7488.251174882468;7496.887546686695;7508.62456877143;7642.579658118634;5720;5775.711214439178;5781.682007489629;5782.017057100387;5792.189093526826;6451.0968464415955;6476.838079048061;6487.9026814598765;6499.707513162014;6536.7712130075215;5744.396838331915;5817.534597232296;5851.414858514285;5861.736221870111;5899.410058994238;5818.8254352369495;5865.648061116347;5877.853053673522;5880.588358815013;6013.188219590299;5495.230667706604;5604.943950560442;5606.495415412633;5613.101903695389;5619.915701264566;4291.2275790358035;4295.935560966525;4368.388425620352;4395.1429471252795;4451.109778044469;4278.336857787048;4391.253486907297;4396.230659634615;4422.425084738963;4423.955760442354 23:37:34 INFO - PROCESS | 5766 | |4;prototype.html;348.9441689329708;355.3266559869048;358.6413586413586;361.38023290057544;362.84760400631734;4855.834599696074;4919.114559379314;4919.87700307492;4927.926081108786;4930.827421040264;4885.364902562662;4887;4887.780049897754;4893.559579637832;4893.584045356149;3730.3098926698513;3816.351220292543;3820.923581528368;3886.5919078496777;3916.8824935251987;3912.8043597820138;3918.04008018036;3922.7450215735885;3924.1955399143108;3930.960690393088;3847.3844184930417;3857.9421308680253;3880.9223815523674;3882.1365744442683;3886.805659717017;3564.8592450415877;3765.4163604641326;3883.533975922879;3906.3241679449666;3928.2339943710986;3306.5866766654167;3311.1391038330207;3316.363491024617;3322.4185767490835;3332.5334453176574;4713.054341036852;4714.0772720913255;4727.7163370197895;4728.810847566093;4751.619870410394;4292.527821939584;4294.63495602871;4326.480822301344;4333.090051089275;4333.913321733579;4984.451710311862;5075.771590278447;5088.974555127238;5101.948980510185;5124.795008199668;3608.4767708682357;3619.69232615228;3627.5646922369483;3629.5644522657185;3634.963650363489;5286.920696189561;5302.958361030992;5309.283246761676;5323.760430780624;5333.573314134821;3607.8917632471066;3645.927081458356;3687.1703866629796;3707.3882809336696;3736.831842567091;3771.453139294787;3773.4528493368307;3779.7543159695083;3797.2595343907674;3799.8980295714487;4299.839043458249;4313.676474264443;4340.913181736348;4343.565643435694;4375.824967001285;4868.488808675109;5152.793888244429;5160.948390516121;5171.9482805171465;5198.428172900978;1267.6246272793937;1277.444311724403;1280.9807852882213;1293.0560690695656;1293.7283170534106;836.4103307168432;873.6461732998146;873.7069137676275;878.9692360767342;884.3058199313637;4369.628581570539;4407.449068866392;4441.378207051015;4462.910741785211;4465.24090904547;5232.816851410258;5239.633225674243;5270.341207349082;5312.468753124734;5316.441773613792;4495.730256184639;4497.370368148397;4498.212812757754;4525.167307240573;4529.660275479352;2593.8054645901634;2687.8900063450096;2692.367293685982;2708.3635345694142;2726.9727302727115;4815.807367705253;4820.662553621213;4824.734639594856;4827.493113223131;4828.758562071883;5086.491350864884;5259.501736675125;5263.184206448007;5270.262163297141;5285.445028272053;4741.193997020446;4742.430908291027;4762.261624624653;4776.689515181502;4788.712677239377;5108.540231379194;5112.667676601009;5127.308163214342;5138.794448222029;5140.46025167367;4761.880962971583;5037.219231019198;5042.109209046607;5053.36832895888;5058.570021548209;4767.6662633615315;4771.95228047715;4792.9281060784815;4804.231322988445;4805.351277577623;3562.305350456636;3571.4821350904494;3585.5299327275693;3592.3533763922746;3598.4242521196484;5099.92350114756;5124.540934869023;5143.948560514347;5161.948380516147;5162.5869930406225;4828.806847726051;5076.238564215249;5095.745212739274;5122.385313762373;5126.871828204325;5099.184130539096;5105.974470127626;5120.718360490208;5141.25451809493;5147.794088236578;4860.927086093782;5067.2652465391575;5072.322566139519;5073.34046573943;5073.6407570479905;5030.220315851049;5123.538881500683;5130.743462826918;5162.767675454688;5175.197844334134;4997.775989684701;5012.724300163526;5018.04657115147;5018.121828679893;5023.673461225008 23:37:34 INFO - PROCESS | 5766 | |5;yui.html;663.6681659170415;672.6401375264235;735.9411247100229;764.228129589115;785.7681983814774;13134.671633209162;13159.736805263889;13271.336433178327;13382.263975481344;13700.49294577597;13095.214287142779;13133.277669728184;13337.199768013901;13373.331333433314;13381.39783709733;811.1766556944706;823.8393513264916;823.8887750153713;824.2499325613693;825.0676735289115;772.2702046565997;804.6580203413555;806.0971711682923;807.8949736534272;812.2324403438753;854.8888644476209;854.9273311768507;855.6149732620346;857.3312816003496;858.2147335188296;847.643989524395;850.1583432401909;853.8505761491714;854.1543871567135;854.6111519258723;614.4776939601303;620.3703241210176;622.909678096678;625.7559551774812;626.677261210477;13970.580882573538;14156.575302740934;14263.358148883326;14364.784528232085;14410.567682969528;12063.517459301618;13194.802077968838;13637.045406821526;13721;13908;11444.599439019594;12214.511419543207;12250.571230006906;12275.324857132855;12336.568220112344;4064.2074795414906;4077.938830917539;4078.7552746835286;4098.139390727951;4136.21411931732;64084.679576602284;64932;65507.3449265506;67011.66494167499;67293.3270667292;9768.462734549526;9794.069563391466;10006.799864002825;10053.04496072872;10213.74465638365;18213.63572728538;18367.540811479554;18369.448916532525;18416.63166736658;18456.07719614014;6352;6400.647964361911;6637.568558043712;6655.168103987002;6729.461643068543;3506.736994725406;3557.665567518188;3569.5359603251413;3577.284543091392;3679.7424180307657;2633.1310667479684;2656.375751698349;2660.1620489546117;2681.034827462112;2689.9240303878214;479.31218701163243;480.0447110250646;482.9275608658729;489.40781654198105;490.21565495208097;581.7324030945813;600.5855959388008;606.1665210335789;606.4693393280879;613.8434699151687;7978.920210797934;8077.7576672699915;8111.634976426075;8340.374471914509;8428.410011299273;530.0723733466434;547.5017733862167;550.4468009650276;573.8135106090538;630.9369063093745;3761.7178711596193;4134.131832315187;4144.8808821617995;4184.100418410057;4243.490781106287;59480;59926.70036649789;61447.69276153591;63359.36640633535;63490;53811.461885380646;54046;54136.729316353165;55628.16557751637;56506.7174664124;47775.283370749465;48468.2729759061;48868.266975995386;49532;50210.49789502131;7445;7781.883271751041;7889.250521200477;7926.608776631242;7934.56359900211;34289.828550857084;34382;34506.48240276448;34973;35638.465423018155;40526.79736601298;41914;44507.33239001353;44638.10723785441;45614.54385456103;9606.471644059644;9638.325317227727;9764;9827.31208815376;10036.046575575308;10169.389836609827;10203.296126526624;10282.383057016305;10332.151047392683;10465.529051192867;9809.705708828747;10229.130523905551;10230.48847557634;10303.94848025785;10647.094996925349;9641.37331073478;9730.17293530058;9827.754306142404;9874;9882.11061004513;8932.50871202064;10716.57133714674;10737.677869663923;11404.600838970597;11469.0251328638;9289.224559019573;9702.75743106428;9760.414375137514;9936.503174841084;10436.947815260875;8913.37606367548;9078.319126065704;9526.095020972996;9592.808143837225;9681.080297371738 23:37:34 INFO - PROCESS | 5766 | __end_tp_report 23:37:34 INFO - PROCESS | 5766 | __start_cc_report 23:37:34 INFO - PROCESS | 5766 | _x_x_mozilla_cycle_collect,322 23:37:34 INFO - PROCESS | 5766 | __end_cc_report 23:37:34 INFO - PROCESS | 5766 | __startTimestamp1483774654619__endTimestamp 23:37:34 INFO - PROCESS | 5766 | 23:37:34 INFO - PROCESS | 5766 | ------- Summary: start ------- 23:37:34 INFO - PROCESS | 5766 | Number of tests: 6 23:37:34 INFO - PROCESS | 5766 | 23:37:34 INFO - PROCESS | 5766 | [#0] dojo.html Cycles:165 Average:4577.61 Median:4687.46 stddev:480.26 (10.2%) stddev-sans-first:454.38 23:37:34 INFO - PROCESS | 5766 | Values: 2540.7 2548.9 2564.5 2568.1 2602.9 4530.7 4642.7 4652.1 4685.3 4695.2 4554.3 4587.1 4612.9 4646.0 4651.9 4243.9 4266.1 4306.8 4341.8 4396.4 4251.9 4310.4 4330.3 4347.3 4356.3 4164.4 4179.8 4184.7 4259.1 4301.7 4227.3 4229.0 4236.4 4238.2 4242.7 4183.8 4204.7 4213.4 4219.7 4220.7 4618.4 4630.8 4642.3 4644.6 4681.4 4916.3 4920.0 4925.3 4929.7 4960.1 4877.2 4887.0 4931.8 4959.1 5015.5 4618.1 4629.4 4632.8 4668.4 4687.5 5012.3 5026.4 5035.4 5052.8 5057.4 4726.7 4767.2 4821.1 4844.1 4893.3 4873.1 4894.3 4895.5 4903.8 4904.2 4877.3 4895.5 4936.2 4961.0 4977.2 4889.1 4901.3 4903.6 4917.7 4933.0 4107.6 4151.6 4196.0 4200.2 4243.2 3647.3 3663.1 3675.7 3679.5 3705.4 4291.7 4303.3 4322.0 4326.0 4329.3 4994.1 5008.7 5013.5 5023.7 5028.2 4233.2 4263.6 4264.8 4279.6 4337.8 4476.7 4477.2 4486.5 4490.0 4491.6 4651.3 4654.0 4654.3 4654.9 4663.0 4935.3 4955.9 4967.0 4976.6 4981.5 4618.7 4700.9 4706.4 4731.4 4747.4 4855.5 4868.8 4882.5 4940.2 4943.2 4900.8 4922.0 4971.8 4995.9 5074.2 4882.8 4885.8 4893.6 4898.5 4906.7 4871.8 4880.8 4887.6 4888.5 4920.3 4602.4 4641.3 4655.3 4721.1 4727.5 4863.5 4870.3 4877.7 4907.5 4917.8 4704.7 4730.9 4754.3 4762.4 4772.2 23:37:34 INFO - PROCESS | 5766 | 23:37:34 INFO - PROCESS | 5766 | [#1] ext.html Cycles:180 Average:46753.62 Median:187994.69 stddev:82109.27 (43.7%) stddev-sans-first:82266.19 23:37:34 INFO - PROCESS | 5766 | Values: 507.9 526.3 527.6 529.4 545.1 37764.4 39709.4 39872.0 39885.8 44332.6 40885.8 41191.8 41210.0 41229.8 41301.4 7679.2 7864.2 7868.4 7872.2 7873.5 9553.4 9827.4 9875.4 10074.7 10088.1 9822.8 9938.3 9960.7 9963.0 9969.9 9879.8 9888.6 9934.7 9937.6 9946.1 9727.9 9798.8 9812.4 9824.5 9832.9 36002.5 36136.6 36139.6 36233.1 36273.0 3684.7 3726.4 3750.5 3758.5 3791.1 25104.4 25416.2 25467.0 25491.7 25877.2 3544.5 3553.0 3574.4 3578.6 3621.2 240564.0 243560.0 245738.0 246085.0 246177.0 49193.0 49501.0 49521.3 49541.3 49641.5 50903.2 51143.0 51362.7 51468.5 51513.2 13723.1 14214.3 14217.7 14224.0 14228.6 9200.6 9283.5 10835.5 10976.6 11125.3 18773.9 19339.0 19582.2 19817.9 19849.0 7383.7 7605.6 7641.2 7650.5 7720.3 820.3 821.3 828.0 835.8 839.6 27370.7 28386.6 28471.4 28616.7 28821.9 979.3 983.2 997.4 1015.9 1123.3 13508.4 15347.7 15466.6 15541.2 15606.5 372263.0 373926.0 377097.0 380727.0 380751.0 52177.0 52283.5 52654.0 52817.7 53025.2 1212.4 1242.5 1273.1 1273.9 1277.6 26336.9 27198.0 27673.7 28154.0 28232.4 43394.0 43625.0 43630.0 43734.6 43747.6 301530.0 303281.0 303398.0 303449.0 304601.0 23591.3 24175.0 24185.2 39674.4 40534.0 36518.1 36892.4 37045.0 37496.8 37908.0 32329.0 33100.7 33292.5 35742.5 35746.0 32562.5 32761.8 32785.8 33063.3 33868.5 33268.7 33613.3 33916.2 34008.0 38905.2 34816.3 36499.1 38989.8 39354.2 39535.4 29610.6 30448.2 30675.0 30704.0 30804.5 23:37:34 INFO - PROCESS | 5766 | 23:37:34 INFO - PROCESS | 5766 | [#2] jquery.html Cycles:180 Average:29371.38 Median:21298.89 stddev:88384.42 (415.0%) stddev-sans-first:88605.53 23:37:34 INFO - PROCESS | 5766 | Values: 372.4 380.9 383.9 391.0 397.4 16301.8 18250.0 18409.6 18682.8 18742.5 17177.8 18354.6 18601.7 18773.8 18797.5 5141.6 5220.3 5238.8 5274.7 5277.7 5023.7 5227.9 5228.8 5251.3 5259.2 5215.9 5218.1 5225.9 5231.5 5235.4 5062.4 5210.7 5237.9 5251.0 5253.1 4689.5 4702.7 4702.8 4705.2 4710.9 21352.4 21405.0 21464.2 21498.8 21539.6 2262.2 2303.6 2311.6 2347.0 2373.3 12665.9 13511.6 13588.2 13935.7 14142.3 1703.6 1754.2 1781.6 1793.4 1822.1 62250.7 70085.0 70332.9 71834.0 73339.0 9657.4 9922.6 9966.2 10142.5 10170.2 13621.7 13653.4 13654.9 13670.7 13685.6 6853.9 7082.6 7108.5 7251.3 7270.9 6548.8 6551.6 6761.7 6789.1 6811.4 6352.4 6417.6 6475.4 6491.4 6590.4 1782.5 1783.0 1822.2 1839.8 1843.3 385.4 395.3 397.0 863.6 866.0 10304.4 10523.2 10710.8 10798.4 10978.0 410.5 410.8 424.0 918.7 954.0 9559.2 9981.0 9996.5 10076.8 10093.9 531419.0 534043.0 538075.0 538860.0 546055.0 88182.0 91502.5 91862.5 92510.5 93261.1 919.7 953.2 977.5 998.3 1005.0 16506.4 16909.7 16968.4 17010.1 17329.6 40922.8 41539.0 41552.0 42173.8 42829.8 57962.0 58798.4 59563.0 59682.4 60005.4 7812.6 7984.8 8162.2 8170.3 8197.8 10150.6 11999.4 12259.3 12713.3 12731.4 10741.5 10815.0 10911.9 10971.6 11006.4 9949.5 10713.0 10907.5 10956.2 11384.2 9723.6 10477.1 10497.8 10571.7 11311.0 7903.9 8129.3 8166.8 8214.3 8273.9 8242.2 10453.8 10951.5 10980.7 11203.6 23:37:34 INFO - PROCESS | 5766 | 23:37:34 INFO - PROCESS | 5766 | [#3] mootools.html Cycles:180 Average:4535.39 Median:5550.09 stddev:2334.23 (42.1%) stddev-sans-first:2328.26 23:37:34 INFO - PROCESS | 5766 | Values: 1318.8 1321.7 1330.0 1337.3 1346.3 6128.4 6310.1 6464.3 6817.4 6842.9 6586.0 6721.6 6760.3 6919.2 6950.4 2070.2 2110.2 2115.3 2117.4 2120.2 2059.6 2086.7 2113.0 2126.9 2155.1 2126.5 2145.0 2150.6 2161.2 2164.0 2042.7 2044.9 2058.1 2063.3 2089.5 2050.8 2087.5 2098.1 2119.9 2121.0 6905.3 6908.2 6949.9 6971.4 6977.6 4214.0 4304.3 4312.9 4316.7 4325.2 2684.5 2818.2 2848.9 2886.2 2899.0 1134.8 1161.1 1170.8 1202.5 1233.0 8521.7 8692.0 8722.2 8733.6 8745.8 3575.2 3731.6 3749.1 3817.8 3920.8 7178.7 7203.9 7219.6 7289.6 7294.1 4226.2 4318.2 4321.9 4325.6 4335.8 3839.6 3911.9 3979.1 3990.7 4007.6 3035.9 3048.5 3137.8 3163.1 3194.0 836.9 863.1 917.7 921.7 926.4 821.8 825.8 839.8 859.0 860.7 4753.4 4773.9 4815.1 4997.4 5088.2 929.7 934.9 942.7 948.7 956.7 3353.7 3414.7 3419.7 3429.6 3471.3 7842.9 8022.6 8048.3 8094.3 8138.3 8139.7 8156.3 8157.7 8162.7 8178.0 6290.4 6396.6 6521.6 6553.8 6616.7 4633.1 4675.3 4760.3 4894.5 4970.7 7467.8 7491.1 7558.6 7618.7 7678.9 7466.4 7488.3 7496.9 7508.6 7642.6 5720.0 5775.7 5781.7 5782.0 5792.2 6451.1 6476.8 6487.9 6499.7 6536.8 5744.4 5817.5 5851.4 5861.7 5899.4 5818.8 5865.6 5877.9 5880.6 6013.2 5495.2 5604.9 5606.5 5613.1 5619.9 4291.2 4295.9 4368.4 4395.1 4451.1 4278.3 4391.3 4396.2 4422.4 4424.0 23:37:34 INFO - PROCESS | 5766 | 23:37:34 INFO - PROCESS | 5766 | [#4] prototype.html Cycles:180 Average:4214.01 Median:4774.32 stddev:1215.05 (25.4%) stddev-sans-first:1183.32 23:37:34 INFO - PROCESS | 5766 | Values: 348.9 355.3 358.6 361.4 362.8 4855.8 4919.1 4919.9 4927.9 4930.8 4885.4 4887.0 4887.8 4893.6 4893.6 3730.3 3816.4 3820.9 3886.6 3916.9 3912.8 3918.0 3922.7 3924.2 3931.0 3847.4 3857.9 3880.9 3882.1 3886.8 3564.9 3765.4 3883.5 3906.3 3928.2 3306.6 3311.1 3316.4 3322.4 3332.5 4713.1 4714.1 4727.7 4728.8 4751.6 4292.5 4294.6 4326.5 4333.1 4333.9 4984.5 5075.8 5089.0 5101.9 5124.8 3608.5 3619.7 3627.6 3629.6 3635.0 5286.9 5303.0 5309.3 5323.8 5333.6 3607.9 3645.9 3687.2 3707.4 3736.8 3771.5 3773.5 3779.8 3797.3 3799.9 4299.8 4313.7 4340.9 4343.6 4375.8 4868.5 5152.8 5160.9 5171.9 5198.4 1267.6 1277.4 1281.0 1293.1 1293.7 836.4 873.6 873.7 879.0 884.3 4369.6 4407.4 4441.4 4462.9 4465.2 5232.8 5239.6 5270.3 5312.5 5316.4 4495.7 4497.4 4498.2 4525.2 4529.7 2593.8 2687.9 2692.4 2708.4 2727.0 4815.8 4820.7 4824.7 4827.5 4828.8 5086.5 5259.5 5263.2 5270.3 5285.4 4741.2 4742.4 4762.3 4776.7 4788.7 5108.5 5112.7 5127.3 5138.8 5140.5 4761.9 5037.2 5042.1 5053.4 5058.6 4767.7 4772.0 4792.9 4804.2 4805.4 3562.3 3571.5 3585.5 3592.4 3598.4 5099.9 5124.5 5143.9 5161.9 5162.6 4828.8 5076.2 5095.7 5122.4 5126.9 5099.2 5106.0 5120.7 5141.3 5147.8 4860.9 5067.3 5072.3 5073.3 5073.6 5030.2 5123.5 5130.7 5162.8 5175.2 4997.8 5012.7 5018.0 5018.1 5023.7 23:37:34 INFO - PROCESS | 5766 | 23:37:34 INFO - PROCESS | 5766 | [#5] yui.html Cycles:180 Average:14363.88 Median:54091.36 stddev:17876.76 (33.0%) stddev-sans-first:17897.31 23:37:34 INFO - PROCESS | 5766 | Values: 663.7 672.6 735.9 764.2 785.8 13134.7 13159.7 13271.3 13382.3 13700.5 13095.2 13133.3 13337.2 13373.3 13381.4 811.2 823.8 823.9 824.2 825.1 772.3 804.7 806.1 807.9 812.2 854.9 854.9 855.6 857.3 858.2 847.6 850.2 853.9 854.2 854.6 614.5 620.4 622.9 625.8 626.7 13970.6 14156.6 14263.4 14364.8 14410.6 12063.5 13194.8 13637.0 13721.0 13908.0 11444.6 12214.5 12250.6 12275.3 12336.6 4064.2 4077.9 4078.8 4098.1 4136.2 64084.7 64932.0 65507.3 67011.7 67293.3 9768.5 9794.1 10006.8 10053.0 10213.7 18213.6 18367.5 18369.4 18416.6 18456.1 6352.0 6400.6 6637.6 6655.2 6729.5 3506.7 3557.7 3569.5 3577.3 3679.7 2633.1 2656.4 2660.2 2681.0 2689.9 479.3 480.0 482.9 489.4 490.2 581.7 600.6 606.2 606.5 613.8 7978.9 8077.8 8111.6 8340.4 8428.4 530.1 547.5 550.4 573.8 630.9 3761.7 4134.1 4144.9 4184.1 4243.5 59480.0 59926.7 61447.7 63359.4 63490.0 53811.5 54046.0 54136.7 55628.2 56506.7 47775.3 48468.3 48868.3 49532.0 50210.5 7445.0 7781.9 7889.3 7926.6 7934.6 34289.8 34382.0 34506.5 34973.0 35638.5 40526.8 41914.0 44507.3 44638.1 45614.5 9606.5 9638.3 9764.0 9827.3 10036.0 10169.4 10203.3 10282.4 10332.2 10465.5 9809.7 10229.1 10230.5 10303.9 10647.1 9641.4 9730.2 9827.8 9874.0 9882.1 8932.5 10716.6 10737.7 11404.6 11469.0 9289.2 9702.8 9760.4 9936.5 10436.9 8913.4 9078.3 9526.1 9592.8 9681.1 23:37:34 INFO - PROCESS | 5766 | -------- Summary: end -------- 23:37:34 INFO - PROCESS | 5766 | 23:37:35 INFO - TEST-INFO | 5766: exit 0 23:37:35 INFO - TEST-OK | dromaeo_css | took 1118431ms 23:37:35 INFO - TEST-START | kraken 23:37:35 INFO - operating with platform_type : linux_ 23:37:35 INFO - Initialising browser for kraken test... 23:37:35 INFO - TEST-INFO | started process 6114 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo8QqlF/profile http://localhost:57783/getInfo.html) 23:37:35 INFO - PROCESS | 6114 | 1483774655965 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 23:37:39 INFO - PROCESS | 6114 | __metrics Screen width/height:1600/1200 23:37:39 INFO - PROCESS | 6114 | colorDepth:24 23:37:39 INFO - PROCESS | 6114 | Browser inner width/height: 1024/697 23:37:39 INFO - PROCESS | 6114 | __metrics 23:37:40 ERROR - PROCESS | 6114 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 23:37:41 INFO - TEST-INFO | 6114: exit 0 23:37:41 INFO - Browser initialized. 23:37:41 INFO - Running cycle 1/1 for kraken test... 23:37:41 INFO - TEST-INFO | started process 6236 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo8QqlF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:37:53 INFO - PROCESS | 6236 | RSS: Main: 159178752 23:37:53 INFO - PROCESS | 6236 | 23:37:56 INFO - PROCESS | 6236 | Cycle 1(1): loaded http://localhost:57783/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57783/tests/kraken/driver.html?testName=audio-beat-detection) 23:37:57 INFO - PROCESS | 6236 | RSS: Main: 164851712 23:37:57 INFO - PROCESS | 6236 | 23:37:59 INFO - PROCESS | 6236 | Cycle 1(1): loaded http://localhost:57783/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57783/tests/kraken/driver.html?testName=audio-dft) 23:38:00 INFO - PROCESS | 6236 | RSS: Main: 164036608 23:38:00 INFO - PROCESS | 6236 | 23:38:03 INFO - PROCESS | 6236 | Cycle 1(1): loaded http://localhost:57783/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57783/tests/kraken/driver.html?testName=audio-fft) 23:38:03 INFO - PROCESS | 6236 | RSS: Main: 160317440 23:38:03 INFO - PROCESS | 6236 | 23:38:06 INFO - PROCESS | 6236 | Cycle 1(1): loaded http://localhost:57783/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57783/tests/kraken/driver.html?testName=audio-oscillator) 23:38:06 INFO - PROCESS | 6236 | RSS: Main: 161427456 23:38:06 INFO - PROCESS | 6236 | 23:38:08 INFO - PROCESS | 6236 | Cycle 1(1): loaded http://localhost:57783/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57783/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:38:09 INFO - PROCESS | 6236 | RSS: Main: 161222656 23:38:09 INFO - PROCESS | 6236 | 23:38:12 INFO - PROCESS | 6236 | Cycle 1(1): loaded http://localhost:57783/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57783/tests/kraken/driver.html?testName=imaging-darkroom) 23:38:13 INFO - PROCESS | 6236 | RSS: Main: 166539264 23:38:13 INFO - PROCESS | 6236 | 23:38:16 INFO - PROCESS | 6236 | Cycle 1(1): loaded http://localhost:57783/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57783/tests/kraken/driver.html?testName=imaging-desaturate) 23:38:17 INFO - PROCESS | 6236 | RSS: Main: 162877440 23:38:17 INFO - PROCESS | 6236 | 23:38:20 INFO - PROCESS | 6236 | Cycle 1(1): loaded http://localhost:57783/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57783/tests/kraken/driver.html?testName=json-parse-financial) 23:38:21 INFO - PROCESS | 6236 | RSS: Main: 164057088 23:38:21 INFO - PROCESS | 6236 | 23:38:22 INFO - PROCESS | 6236 | Cycle 1(1): loaded http://localhost:57783/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57783/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:38:23 INFO - PROCESS | 6236 | RSS: Main: 163901440 23:38:23 INFO - PROCESS | 6236 | 23:38:25 INFO - PROCESS | 6236 | Cycle 1(1): loaded http://localhost:57783/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57783/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:38:25 INFO - PROCESS | 6236 | RSS: Main: 163835904 23:38:25 INFO - PROCESS | 6236 | 23:38:28 INFO - PROCESS | 6236 | Cycle 1(1): loaded http://localhost:57783/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57783/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:38:28 INFO - PROCESS | 6236 | RSS: Main: 164950016 23:38:28 INFO - PROCESS | 6236 | 23:38:31 INFO - PROCESS | 6236 | Cycle 1(1): loaded http://localhost:57783/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57783/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:38:32 INFO - PROCESS | 6236 | RSS: Main: 164675584 23:38:32 INFO - PROCESS | 6236 | 23:38:35 INFO - PROCESS | 6236 | Cycle 1(1): loaded http://localhost:57783/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57783/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:38:36 INFO - PROCESS | 6236 | RSS: Main: 164237312 23:38:36 INFO - PROCESS | 6236 | 23:38:37 INFO - PROCESS | 6236 | Cycle 1(1): loaded http://localhost:57783/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57783/tests/kraken/driver.html?testName=ai-astar) 23:38:38 INFO - PROCESS | 6236 | RSS: Main: 166223872 23:38:38 INFO - PROCESS | 6236 | 23:38:38 INFO - PROCESS | 6236 | __start_tp_report 23:38:38 INFO - PROCESS | 6236 | _x_x_mozilla_page_load 23:38:38 INFO - PROCESS | 6236 | _x_x_mozilla_page_load_details 23:38:38 INFO - PROCESS | 6236 | |i|pagename|runs| 23:38:38 INFO - PROCESS | 6236 | |0;ai-astar;107;120;118;118;119;124;115;117;115;116 23:38:38 INFO - PROCESS | 6236 | |1;audio-beat-detection;157;125;123;174;125;124;126;129;147;127 23:38:38 INFO - PROCESS | 6236 | |2;audio-dft;165;166;165;168;162;165;164;164;166;168 23:38:38 INFO - PROCESS | 6236 | |3;audio-fft;76;76;77;107;77;81;78;78;92;76 23:38:38 INFO - PROCESS | 6236 | |4;audio-oscillator;85;85;102;85;86;85;97;85;85;115 23:38:38 INFO - PROCESS | 6236 | |5;imaging-gaussian-blur;118;118;119;118;117;124;119;118;120;118 23:38:38 INFO - PROCESS | 6236 | |6;imaging-darkroom;150;150;150;151;150;151;151;150;150;153 23:38:38 INFO - PROCESS | 6236 | |7;imaging-desaturate;96;96;96;96;97;95;96;96;96;96 23:38:38 INFO - PROCESS | 6236 | |8;json-parse-financial;64;64;68;66;65;68;66;65;67;64 23:38:38 INFO - PROCESS | 6236 | |9;json-stringify-tinderbox;68;67;68;67;68;68;67;69;67;67 23:38:38 INFO - PROCESS | 6236 | |10;stanford-crypto-aes;91;91;85;86;86;86;85;94;84;84 23:38:38 INFO - PROCESS | 6236 | |11;stanford-crypto-ccm;136;150;147;134;145;133;134;147;182;161 23:38:38 INFO - PROCESS | 6236 | |12;stanford-crypto-pbkdf2;181;190;178;192;186;192;184;181;181;179 23:38:38 INFO - PROCESS | 6236 | |13;stanford-crypto-sha256-iterative;71;69;70;69;72;68;69;69;70;68 23:38:38 INFO - PROCESS | 6236 | __end_tp_report 23:38:38 INFO - PROCESS | 6236 | __start_cc_report 23:38:38 INFO - PROCESS | 6236 | _x_x_mozilla_cycle_collect,833 23:38:38 INFO - PROCESS | 6236 | __end_cc_report 23:38:38 INFO - PROCESS | 6236 | __startTimestamp1483774718146__endTimestamp 23:38:38 INFO - PROCESS | 6236 | 23:38:38 INFO - PROCESS | 6236 | ------- Summary: start ------- 23:38:38 INFO - PROCESS | 6236 | Number of tests: 14 23:38:38 INFO - PROCESS | 6236 | 23:38:38 INFO - PROCESS | 6236 | [#0] ai-astar Cycles:10 Average:116.90 Median:118.00 stddev:4.38 (3.7%) stddev-sans-first:2.83 23:38:38 INFO - PROCESS | 6236 | Values: 107.0 120.0 118.0 118.0 119.0 124.0 115.0 117.0 115.0 116.0 23:38:38 INFO - PROCESS | 6236 | 23:38:38 INFO - PROCESS | 6236 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:128.00 stddev:17.61 (13.8%) stddev-sans-first:16.90 23:38:38 INFO - PROCESS | 6236 | Values: 157.0 125.0 123.0 174.0 125.0 124.0 126.0 129.0 147.0 127.0 23:38:38 INFO - PROCESS | 6236 | 23:38:38 INFO - PROCESS | 6236 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.50 stddev:1.83 (1.1%) stddev-sans-first:1.94 23:38:38 INFO - PROCESS | 6236 | Values: 165.0 166.0 165.0 168.0 162.0 165.0 164.0 164.0 166.0 168.0 23:38:38 INFO - PROCESS | 6236 | 23:38:38 INFO - PROCESS | 6236 | [#3] audio-fft Cycles:10 Average:81.80 Median:77.50 stddev:10.09 (13.0%) stddev-sans-first:10.48 23:38:38 INFO - PROCESS | 6236 | Values: 76.0 76.0 77.0 107.0 77.0 81.0 78.0 78.0 92.0 76.0 23:38:38 INFO - PROCESS | 6236 | 23:38:38 INFO - PROCESS | 6236 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:85.00 stddev:10.40 (12.2%) stddev-sans-first:10.81 23:38:38 INFO - PROCESS | 6236 | Values: 85.0 85.0 102.0 85.0 86.0 85.0 97.0 85.0 85.0 115.0 23:38:38 INFO - PROCESS | 6236 | 23:38:38 INFO - PROCESS | 6236 | [#5] imaging-gaussian-blur Cycles:10 Average:118.90 Median:118.50 stddev:1.97 (1.7%) stddev-sans-first:2.06 23:38:38 INFO - PROCESS | 6236 | Values: 118.0 118.0 119.0 118.0 117.0 124.0 119.0 118.0 120.0 118.0 23:38:38 INFO - PROCESS | 6236 | 23:38:38 INFO - PROCESS | 6236 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:150.50 stddev:0.97 (0.6%) stddev-sans-first:1.00 23:38:38 INFO - PROCESS | 6236 | Values: 150.0 150.0 150.0 151.0 150.0 151.0 151.0 150.0 150.0 153.0 23:38:38 INFO - PROCESS | 6236 | 23:38:38 INFO - PROCESS | 6236 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 23:38:38 INFO - PROCESS | 6236 | Values: 96.0 96.0 96.0 96.0 97.0 95.0 96.0 96.0 96.0 96.0 23:38:38 INFO - PROCESS | 6236 | 23:38:38 INFO - PROCESS | 6236 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:66.00 stddev:1.57 (2.4%) stddev-sans-first:1.54 23:38:38 INFO - PROCESS | 6236 | Values: 64.0 64.0 68.0 66.0 65.0 68.0 66.0 65.0 67.0 64.0 23:38:38 INFO - PROCESS | 6236 | 23:38:38 INFO - PROCESS | 6236 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 23:38:38 INFO - PROCESS | 6236 | Values: 68.0 67.0 68.0 67.0 68.0 68.0 67.0 69.0 67.0 67.0 23:38:38 INFO - PROCESS | 6236 | 23:38:38 INFO - PROCESS | 6236 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:86.00 stddev:3.49 (4.1%) stddev-sans-first:3.42 23:38:38 INFO - PROCESS | 6236 | Values: 91.0 91.0 85.0 86.0 86.0 86.0 85.0 94.0 84.0 84.0 23:38:38 INFO - PROCESS | 6236 | 23:38:38 INFO - PROCESS | 6236 | [#11] stanford-crypto-ccm Cycles:10 Average:146.90 Median:147.00 stddev:15.23 (10.4%) stddev-sans-first:15.64 23:38:38 INFO - PROCESS | 6236 | Values: 136.0 150.0 147.0 134.0 145.0 133.0 134.0 147.0 182.0 161.0 23:38:38 INFO - PROCESS | 6236 | 23:38:38 INFO - PROCESS | 6236 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.40 Median:185.00 stddev:5.32 (2.9%) stddev-sans-first:5.49 23:38:38 INFO - PROCESS | 6236 | Values: 181.0 190.0 178.0 192.0 186.0 192.0 184.0 181.0 181.0 179.0 23:38:38 INFO - PROCESS | 6236 | 23:38:38 INFO - PROCESS | 6236 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.50 stddev:1.27 (1.8%) stddev-sans-first:1.22 23:38:38 INFO - PROCESS | 6236 | Values: 71.0 69.0 70.0 69.0 72.0 68.0 69.0 69.0 70.0 68.0 23:38:38 INFO - PROCESS | 6236 | -------- Summary: end -------- 23:38:38 INFO - PROCESS | 6236 | 23:38:39 INFO - TEST-INFO | 6236: exit 0 23:38:39 INFO - TEST-OK | kraken | took 63873ms 23:38:39 INFO - SUITE-END | took 1182s 23:38:39 INFO - Completed test suite (00:19:42) 23:38:39 INFO - javascript benchmark 23:38:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6291.820841408053, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2540.720520742719, 2548.9490210195795, 2564.46146309275, 2568.1140006697683, 2602.908898188564, 4530.7281563106235, 4642.675012749109, 4652.06958608278, 4685.25035994241, 4695.201815691332, 4554.31685247213, 4587.105514424688, 4612.884677883055, 4645.954660201453, 4651.860444186671, 4243.893902652443, 4266.0614664773775, 4306.7631280279575, 4341.826326946934, 4396.406485124515, 4251.914961700764, 4310.3965444837595, 4330.285502892019, 4347.3261644445165, 4356.324769660708, 4164.416981622575, 4179.832806687728, 4184.7070705050655, 4259.148170365939, 4301.677374196916, 4227.3447615619625, 4229.048464095585, 4236.385724070024, 4238.173556156551, 4242.745435273893, 4183.769892655902, 4204.726692764991, 4213.410122582841, 4219.746815191098, 4220.683448741357, 4618.35343051973, 4630.814767409333, 4642.257238841769, 4644.605208557243, 4681.391419115527, 4916.262560615901, 4920.0, 4925.3350797642215, 4929.679570827885, 4960.082384758831, 4877.219644856841, 4886.975565122188, 4931.80272789088, 4959.107360675077, 5015.523525265094, 4618.145643055978, 4629.444466663955, 4632.768361581908, 4668.36977008103, 4687.460941991714, 5012.273220383024, 5026.421961474404, 5035.395752509649, 5052.8484145475695, 5057.418396884405, 4726.692764970266, 4767.213409787346, 4821.0839940411915, 4844.128056949783, 4893.290472881412, 4873.098476781806, 4894.26586012094, 4895.461499235082, 4903.754812259373, 4904.190808516555, 4877.317175595419, 4895.461499235082, 4936.185529387611, 4961.032598643302, 4977.1538838397555, 4889.144399730033, 4901.289313049588, 4903.607711383081, 4917.680350777188, 4932.950670493321, 4107.568705285962, 4151.647109995684, 4196.034911970203, 4200.180964711852, 4243.236217480821, 3647.325244829715, 3663.139162296858, 3675.6691897729334, 3679.521662183899, 3705.444183372516, 4291.69958102936, 4303.33298338758, 4321.956780432219, 4326.048269380732, 4329.328954012133, 4994.101061808909, 5008.6744361616375, 5013.548780609763, 5023.6985780853265, 5028.195488721787, 4233.1956928183545, 4263.637590804817, 4264.829406823755, 4279.593438623326, 4337.7614231217585, 4476.7090139140855, 4477.19410506112, 4486.506484286726, 4490.0, 4491.573300536444, 4651.2557990721325, 4654.0, 4654.301854721819, 4654.930176047362, 4663.044075964419, 4935.309056732132, 4955.934474088089, 4967.0, 4976.576990955809, 4981.501849814989, 4618.722876627413, 4700.858974230779, 4706.435227772689, 4731.408573928259, 4747.430308363018, 4855.490173531728, 4868.780904859361, 4882.4629290777275, 4940.160172770566, 4943.184374578298, 4900.803967841246, 4921.975390123026, 4971.776270067928, 4995.900081998267, 5074.162763144188, 4882.780274887709, 4885.755712214446, 4893.584045356185, 4898.510148985073, 4906.656534042583, 4871.780769865435, 4880.804767809248, 4887.560119589254, 4888.5111488850835, 4920.286558449076, 4602.355670206241, 4641.327007583949, 4655.30170474418, 4721.055788842176, 4727.456342520517, 4863.465018847854, 4870.269459581091, 4877.707337559757, 4907.533784290486, 4917.827876024322, 4704.741239231875, 4730.905381892274, 4754.263089221176, 4762.3570817939135, 4772.164871147605], "value": 4546.582116585335, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.89080347725235, 526.2527211359869, 527.575301881985, 529.4202847881571, 545.1114683066605, 37764.43353349699, 39709.43341515726, 39872.0, 39885.80057099714, 44332.55667443325, 40885.79557102211, 41191.794041029825, 41210.0, 41229.79385103078, 41301.380479292835, 7679.1936846631, 7864.174261702525, 7868.370530357586, 7872.173421790687, 7873.527588344689, 9553.426794392359, 9827.4103553787, 9875.407475551454, 10074.748131296703, 10088.142507886838, 9822.754431139207, 9938.254630902675, 9960.651377201799, 9963.0, 9969.850452243221, 9879.753006174904, 9888.555015024342, 9934.652287169987, 9937.602495900155, 9946.104850563484, 9727.854082188773, 9798.804023919552, 9812.411255324632, 9824.459654718987, 9832.90167098327, 36002.45996310058, 36136.63863361359, 36139.638603613894, 36233.09417264589, 36273.0, 3684.7420680552373, 3726.38592431526, 3750.474933509284, 3758.4926034985474, 3791.146991926822, 25104.39769026346, 25416.237512874643, 25467.0, 25491.74508254912, 25877.223683289532, 3544.543125108829, 3552.982235088834, 3574.3744844652083, 3578.5526809148855, 3621.203335266237, 240564.0, 243560.0, 245738.0, 246085.0, 246177.0, 49193.0, 49501.01995920195, 49521.25718114231, 49541.25688114681, 49641.50358496369, 50903.23645145326, 51143.0, 51362.74318628383, 51468.48531514712, 51513.22730159051, 13723.1079979801, 14214.28928553589, 14217.715645687029, 14224.0, 14228.573142805732, 9200.585973631203, 9283.535823208813, 10835.51240194193, 10976.560937562408, 11125.276857004268, 18773.93103861977, 19339.0, 19582.216711331672, 19817.900910495355, 19849.0, 7383.704651813975, 7605.619719014027, 7641.159472458025, 7650.502717323468, 7720.3051725344985, 820.2699597358355, 821.2690705272313, 827.9586020698941, 835.8035861572525, 839.5886015852188, 27370.726292737218, 28386.574201386997, 28471.430571388457, 28616.713832861406, 28821.855890720413, 979.3438396274371, 983.1692220074026, 997.3816233935007, 1015.8628585140912, 1123.2867129372744, 13508.392122354519, 15347.693046139015, 15466.613334666497, 15541.222938853012, 15606.45377411808, 372263.0, 373926.0, 377097.0, 380727.0, 380751.0, 52177.0, 52283.47716522862, 52654.0, 52817.7359113202, 53025.2046219307, 1212.4180393411211, 1242.5340497313507, 1273.1024627637494, 1273.891719203878, 1277.584784944878, 26336.8683156583, 27198.0, 27673.72326276792, 28154.01460948857, 28232.43535129327, 43394.0, 43625.0, 43630.0, 43734.56265437432, 43747.56252437435, 301530.0, 303281.0, 303398.0, 303449.0, 304601.0, 23591.29226123219, 24175.0, 24185.15351962673, 39674.421162624334, 40534.0, 36518.08704782402, 36892.446613301356, 37045.0, 37496.81251593724, 37908.0, 32329.0, 33100.66899331072, 33292.50061249132, 35742.4638630426, 35746.0, 32562.511562327058, 32761.836190818893, 32785.836070819496, 33063.33873322472, 33868.49197261994, 33268.667313327525, 33613.327733444705, 33916.152096197795, 34008.0, 38905.2218955625, 34816.30367392689, 36499.087522812144, 38989.805050974566, 39354.21291574095, 39535.406968896066, 29610.555841662823, 30448.238794030327, 30675.0, 30704.0, 30804.53793193149], "value": 18075.068389141816, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.40415335463246, 380.8804005708233, 383.9001859516526, 390.9960900390995, 397.41778294798115, 16301.75547366789, 18249.996250206234, 18409.631807363843, 18682.813171868293, 18742.531436714056, 17177.82822171778, 18354.632907341846, 18601.7209741854, 18773.81226187741, 18797.530061748465, 5141.5886729061585, 5220.347456567929, 5238.7642556084875, 5274.736263186845, 5277.656952298088, 5023.673461225027, 5227.895442091156, 5228.764705588239, 5251.264822924793, 5259.158534634459, 5215.869603259911, 5218.112920803454, 5225.8954820903555, 5231.503007214308, 5235.371755389358, 5062.443131255559, 5210.687358758468, 5237.921431178535, 5251.028559716465, 5253.080710875582, 4689.460712018127, 4702.717836929795, 4702.8118875244945, 4705.1530724469585, 4710.905781884378, 21352.359429216995, 21405.0, 21464.24875129363, 21498.785012149834, 21539.56920861574, 2262.1856131792542, 2303.57383883982, 2311.5839148953182, 2346.9530609387716, 2373.2642880707035, 12665.873341266562, 13511.58128396514, 13588.184708917497, 13935.651608709763, 14142.292885355793, 1703.633718750462, 1754.1930711872553, 1781.6080462298273, 1793.3543924187281, 1822.1071674879213, 62250.68874655598, 70085.0, 70332.94500582495, 71834.0, 73339.0, 9657.420554766737, 9922.553485093189, 9966.152877005536, 10142.543585538668, 10170.237232207466, 13621.659458513419, 13653.38559764813, 13654.86345136536, 13670.726585468235, 13685.589432317047, 6853.897191542131, 7082.575045497287, 7108.4668649851465, 7251.274872512812, 7270.854582908312, 6548.770793022221, 6551.574147680385, 6761.72953081881, 6789.0834737310815, 6811.4210292124735, 6352.428281454691, 6417.614943103429, 6475.352464753487, 6491.383318584727, 6590.439812615981, 1782.5008997480468, 1782.97325540117, 1822.2346614421974, 1839.7700287464068, 1843.3363988963963, 385.43918598439205, 395.3141299844767, 396.98015099244924, 863.5725315968635, 865.9956700216585, 10304.433256170983, 10523.21075919309, 10710.785784284426, 10798.406087665096, 10978.0, 410.51559160190664, 410.83155906078366, 423.9809208585621, 918.7014220378404, 953.9952300238455, 9559.187469065208, 9981.0, 9996.450195239331, 10076.798464030824, 10093.949530252448, 531419.0, 534043.0, 538075.0, 538860.0, 546055.0, 88182.0, 91502.54248728714, 91862.54068729613, 92510.53744731368, 93261.06738932659, 919.7102912582515, 953.1897886796306, 977.53567055648, 998.286225348879, 1004.9799004019878, 16506.38782813849, 16909.746353804458, 16968.40610578624, 17010.149492525077, 17329.56676083108, 40922.79538602288, 41539.0, 41552.0, 42173.789131054145, 42829.78585107055, 57962.0, 58798.412015879294, 59563.0, 59682.40317596769, 60005.39994599998, 7812.57030863308, 7984.760457186294, 8162.18378162179, 8170.264676179172, 8197.79505512367, 10150.593976240867, 11999.40002999864, 12259.264444133381, 12713.300768457824, 12731.363431828186, 10741.516631751747, 10814.989543792171, 10911.890881091087, 10971.559268098585, 11006.394648294101, 9949.452780097165, 10713.037224957578, 10907.509162087566, 10956.178286628376, 11384.203105782515, 9723.611055557698, 10477.057064864199, 10497.790044199226, 10571.682849514527, 11311.0, 7903.881441778493, 8129.309008734087, 8166.754997350089, 8214.26071653554, 8273.917260827555, 8242.17578242171, 10453.843192352273, 10951.50718217698, 10980.670579882617, 11203.60787372438], "value": 8435.550360635805, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1318.7889937609984, 1321.6629759411348, 1329.9601011969642, 1337.2711872029736, 1346.252829679528, 6128.387161283869, 6310.085037669547, 6464.25661048979, 6817.420519255869, 6842.931570684292, 6585.967070164643, 6721.5630983986, 6760.323967603237, 6919.169699636038, 6950.4092152167, 2070.2443608083017, 2110.2086717480943, 2115.2596591193114, 2117.4388786971463, 2120.183729264229, 2059.5685998231233, 2086.6765651324067, 2113.0, 2126.9361919142452, 2155.051777218019, 2126.5321629241544, 2145.0, 2150.6021386043553, 2161.1787520742173, 2163.9783602163934, 2042.673172292426, 2044.8568600197991, 2058.1355830551206, 2063.3087915548385, 2089.5298557824444, 2050.8002818351283, 2087.488565301496, 2098.0907374289477, 2119.8940052997286, 2121.0455295117104, 6905.274946130634, 6908.171019477644, 6949.861002779967, 6971.442284617218, 6977.581345119309, 4213.978930105361, 4304.3113101903855, 4312.892177695551, 4316.740995540246, 4325.178216138924, 2684.4899469101006, 2818.1686402511104, 2848.9145325640266, 2886.2495751104652, 2898.956515652246, 1134.8014097532982, 1161.1088389909066, 1170.7599942011866, 1202.4949521201117, 1232.969175770604, 8521.701740439055, 8691.95654021726, 8722.215000649909, 8733.606987685569, 8745.825083498294, 3575.213453040327, 3731.5708693500596, 3749.1189570450924, 3817.751846129993, 3920.8039598019986, 7178.748743794046, 7203.89194162088, 7219.602921839244, 7289.562626242442, 7294.088238970129, 4226.154769046203, 4318.179545886272, 4321.891952701145, 4325.632321252666, 4335.848245311399, 3839.5968423315708, 3911.941320880189, 3979.1444839359096, 3990.700697447703, 4007.579204183519, 3035.924101897426, 3048.4512787697986, 3137.8117312961294, 3163.066895265902, 3193.9680603194133, 836.8995720513456, 863.0808189278398, 917.7200953709183, 921.6912334368062, 926.4395041000098, 821.8233079887733, 825.7564018614523, 839.8236370362292, 859.0, 860.6901515454431, 4753.4295884493395, 4773.880652983634, 4815.085133824632, 4997.350344455198, 5088.185890257541, 929.7117893453051, 934.9205317547949, 942.6512190489426, 948.7296120605595, 956.7273327101742, 3353.6814002670194, 3414.709749671306, 3419.675130862564, 3429.5713035870517, 3471.3057388522398, 7842.9215707842195, 8022.558759268296, 8048.315893149031, 8094.31198348147, 8138.3082437993435, 8139.674413023531, 8156.34749220061, 8157.71447999329, 8162.7143049992965, 8178.0, 6290.402411770874, 6396.584222025554, 6521.576097553644, 6553.803385898431, 6616.669166541654, 4633.142868569325, 4675.251959686434, 4760.309755085563, 4894.486078961801, 4970.726610036482, 7467.813304667427, 7491.10106787189, 7558.58427786477, 7618.69525218985, 7678.884816727642, 7466.440016998856, 7488.251174882468, 7496.887546686695, 7508.62456877143, 7642.579658118634, 5720.0, 5775.711214439178, 5781.682007489629, 5782.017057100387, 5792.189093526826, 6451.0968464415955, 6476.838079048061, 6487.9026814598765, 6499.707513162014, 6536.7712130075215, 5744.396838331915, 5817.534597232296, 5851.414858514285, 5861.736221870111, 5899.410058994238, 5818.8254352369495, 5865.648061116347, 5877.853053673522, 5880.588358815013, 6013.188219590299, 5495.230667706604, 5604.943950560442, 5606.495415412633, 5613.101903695389, 5619.915701264566, 4291.2275790358035, 4295.935560966525, 4368.388425620352, 4395.1429471252795, 4451.109778044469, 4278.336857787048, 4391.253486907297, 4396.230659634615, 4422.425084738963, 4423.955760442354], "value": 3771.45854948659, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.9441689329708, 355.3266559869048, 358.6413586413586, 361.38023290057544, 362.84760400631734, 4855.834599696074, 4919.114559379314, 4919.87700307492, 4927.926081108786, 4930.827421040264, 4885.364902562662, 4887.0, 4887.780049897754, 4893.559579637832, 4893.584045356149, 3730.3098926698513, 3816.351220292543, 3820.923581528368, 3886.5919078496777, 3916.8824935251987, 3912.8043597820138, 3918.04008018036, 3922.7450215735885, 3924.1955399143108, 3930.960690393088, 3847.3844184930417, 3857.9421308680253, 3880.9223815523674, 3882.1365744442683, 3886.805659717017, 3564.8592450415877, 3765.4163604641326, 3883.533975922879, 3906.3241679449666, 3928.2339943710986, 3306.5866766654167, 3311.1391038330207, 3316.363491024617, 3322.4185767490835, 3332.5334453176574, 4713.054341036852, 4714.0772720913255, 4727.7163370197895, 4728.810847566093, 4751.619870410394, 4292.527821939584, 4294.63495602871, 4326.480822301344, 4333.090051089275, 4333.913321733579, 4984.451710311862, 5075.771590278447, 5088.974555127238, 5101.948980510185, 5124.795008199668, 3608.4767708682357, 3619.69232615228, 3627.5646922369483, 3629.5644522657185, 3634.963650363489, 5286.920696189561, 5302.958361030992, 5309.283246761676, 5323.760430780624, 5333.573314134821, 3607.8917632471066, 3645.927081458356, 3687.1703866629796, 3707.3882809336696, 3736.831842567091, 3771.453139294787, 3773.4528493368307, 3779.7543159695083, 3797.2595343907674, 3799.8980295714487, 4299.839043458249, 4313.676474264443, 4340.913181736348, 4343.565643435694, 4375.824967001285, 4868.488808675109, 5152.793888244429, 5160.948390516121, 5171.9482805171465, 5198.428172900978, 1267.6246272793937, 1277.444311724403, 1280.9807852882213, 1293.0560690695656, 1293.7283170534106, 836.4103307168432, 873.6461732998146, 873.7069137676275, 878.9692360767342, 884.3058199313637, 4369.628581570539, 4407.449068866392, 4441.378207051015, 4462.910741785211, 4465.24090904547, 5232.816851410258, 5239.633225674243, 5270.341207349082, 5312.468753124734, 5316.441773613792, 4495.730256184639, 4497.370368148397, 4498.212812757754, 4525.167307240573, 4529.660275479352, 2593.8054645901634, 2687.8900063450096, 2692.367293685982, 2708.3635345694142, 2726.9727302727115, 4815.807367705253, 4820.662553621213, 4824.734639594856, 4827.493113223131, 4828.758562071883, 5086.491350864884, 5259.501736675125, 5263.184206448007, 5270.262163297141, 5285.445028272053, 4741.193997020446, 4742.430908291027, 4762.261624624653, 4776.689515181502, 4788.712677239377, 5108.540231379194, 5112.667676601009, 5127.308163214342, 5138.794448222029, 5140.46025167367, 4761.880962971583, 5037.219231019198, 5042.109209046607, 5053.36832895888, 5058.570021548209, 4767.6662633615315, 4771.95228047715, 4792.9281060784815, 4804.231322988445, 4805.351277577623, 3562.305350456636, 3571.4821350904494, 3585.5299327275693, 3592.3533763922746, 3598.4242521196484, 5099.92350114756, 5124.540934869023, 5143.948560514347, 5161.948380516147, 5162.5869930406225, 4828.806847726051, 5076.238564215249, 5095.745212739274, 5122.385313762373, 5126.871828204325, 5099.184130539096, 5105.974470127626, 5120.718360490208, 5141.25451809493, 5147.794088236578, 4860.927086093782, 5067.2652465391575, 5072.322566139519, 5073.34046573943, 5073.6407570479905, 5030.220315851049, 5123.538881500683, 5130.743462826918, 5162.767675454688, 5175.197844334134, 4997.775989684701, 5012.724300163526, 5018.04657115147, 5018.121828679893, 5023.673461225008], "value": 3842.3586986892356, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.6681659170415, 672.6401375264235, 735.9411247100229, 764.228129589115, 785.7681983814774, 13134.671633209162, 13159.736805263889, 13271.336433178327, 13382.263975481344, 13700.49294577597, 13095.214287142779, 13133.277669728184, 13337.199768013901, 13373.331333433314, 13381.39783709733, 811.1766556944706, 823.8393513264916, 823.8887750153713, 824.2499325613693, 825.0676735289115, 772.2702046565997, 804.6580203413555, 806.0971711682923, 807.8949736534272, 812.2324403438753, 854.8888644476209, 854.9273311768507, 855.6149732620346, 857.3312816003496, 858.2147335188296, 847.643989524395, 850.1583432401909, 853.8505761491714, 854.1543871567135, 854.6111519258723, 614.4776939601303, 620.3703241210176, 622.909678096678, 625.7559551774812, 626.677261210477, 13970.580882573538, 14156.575302740934, 14263.358148883326, 14364.784528232085, 14410.567682969528, 12063.517459301618, 13194.802077968838, 13637.045406821526, 13721.0, 13908.0, 11444.599439019594, 12214.511419543207, 12250.571230006906, 12275.324857132855, 12336.568220112344, 4064.2074795414906, 4077.938830917539, 4078.7552746835286, 4098.139390727951, 4136.21411931732, 64084.679576602284, 64932.0, 65507.3449265506, 67011.66494167499, 67293.3270667292, 9768.462734549526, 9794.069563391466, 10006.799864002825, 10053.04496072872, 10213.74465638365, 18213.63572728538, 18367.540811479554, 18369.448916532525, 18416.63166736658, 18456.07719614014, 6352.0, 6400.647964361911, 6637.568558043712, 6655.168103987002, 6729.461643068543, 3506.736994725406, 3557.665567518188, 3569.5359603251413, 3577.284543091392, 3679.7424180307657, 2633.1310667479684, 2656.375751698349, 2660.1620489546117, 2681.034827462112, 2689.9240303878214, 479.31218701163243, 480.0447110250646, 482.9275608658729, 489.40781654198105, 490.21565495208097, 581.7324030945813, 600.5855959388008, 606.1665210335789, 606.4693393280879, 613.8434699151687, 7978.920210797934, 8077.7576672699915, 8111.634976426075, 8340.374471914509, 8428.410011299273, 530.0723733466434, 547.5017733862167, 550.4468009650276, 573.8135106090538, 630.9369063093745, 3761.7178711596193, 4134.131832315187, 4144.8808821617995, 4184.100418410057, 4243.490781106287, 59480.0, 59926.70036649789, 61447.69276153591, 63359.36640633535, 63490.0, 53811.461885380646, 54046.0, 54136.729316353165, 55628.16557751637, 56506.7174664124, 47775.283370749465, 48468.2729759061, 48868.266975995386, 49532.0, 50210.49789502131, 7445.0, 7781.883271751041, 7889.250521200477, 7926.608776631242, 7934.56359900211, 34289.828550857084, 34382.0, 34506.48240276448, 34973.0, 35638.465423018155, 40526.79736601298, 41914.0, 44507.33239001353, 44638.10723785441, 45614.54385456103, 9606.471644059644, 9638.325317227727, 9764.0, 9827.31208815376, 10036.046575575308, 10169.389836609827, 10203.296126526624, 10282.383057016305, 10332.151047392683, 10465.529051192867, 9809.705708828747, 10229.130523905551, 10230.48847557634, 10303.94848025785, 10647.094996925349, 9641.37331073478, 9730.17293530058, 9827.754306142404, 9874.0, 9882.11061004513, 8932.50871202064, 10716.57133714674, 10737.677869663923, 11404.600838970597, 11469.0251328638, 9289.224559019573, 9702.75743106428, 9760.414375137514, 9936.503174841084, 10436.947815260875, 8913.37606367548, 9078.319126065704, 9526.095020972996, 9592.808143837225, 9681.080297371738], "value": 6174.716910144981, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1577.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 120.0, 118.0, 118.0, 119.0, 124.0, 115.0, 117.0, 115.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 123.0, 174.0, 125.0, 124.0, 126.0, 129.0, 147.0, 127.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 165.0, 168.0, 162.0, 165.0, 164.0, 164.0, 166.0, 168.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 107.0, 77.0, 81.0, 78.0, 78.0, 92.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 102.0, 85.0, 86.0, 85.0, 97.0, 85.0, 85.0, 115.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 118.0, 117.0, 124.0, 119.0, 118.0, 120.0, 118.0], "value": 118.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 151.0, 150.0, 151.0, 151.0, 150.0, 150.0, 153.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 68.0, 66.0, 65.0, 68.0, 66.0, 65.0, 67.0, 64.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 67.0, 68.0, 68.0, 67.0, 69.0, 67.0, 67.0], "value": 67.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 85.0, 86.0, 86.0, 86.0, 85.0, 94.0, 84.0, 84.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 150.0, 147.0, 134.0, 145.0, 133.0, 134.0, 147.0, 182.0, 161.0], "value": 146.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 190.0, 178.0, 192.0, 186.0, 192.0, 184.0, 181.0, 181.0, 179.0], "value": 184.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 70.0, 69.0, 72.0, 68.0, 69.0, 69.0, 70.0, 68.0], "value": 69.5, "unit": "score"}]}]} 23:38:39 INFO - Return code: 0 23:38:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:38:39 ERROR - # TBPL SUCCESS # 23:38:39 INFO - Running post-action listener: _resource_record_post_action 23:38:39 INFO - [mozharness: 2017-01-07 07:38:39.951923Z] Finished run-tests step (success) 23:38:39 INFO - Running post-run listener: _resource_record_post_run 23:38:40 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 399564800; Read time: 16; Write time: 255028 23:38:40 INFO - TinderboxPrint: CPU usage
13.5% 23:38:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 23:38:40 INFO - TinderboxPrint: I/O write bytes / time
399,564,800 / 255,028 23:38:40 INFO - TinderboxPrint: CPU idle
8,277.6 (86.5%) 23:38:40 INFO - TinderboxPrint: CPU user
1,231.2 (12.9%) 23:38:40 INFO - TinderboxPrint: Swap in / out
0 / 0 23:38:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115949568; Read time: 0; Write time: 80412 23:38:40 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 282681344; Read time: 0; Write time: 174588 23:38:40 INFO - Running post-run listener: _upload_blobber_files 23:38:40 INFO - Blob upload gear active. 23:38:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:38:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:38:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:38:40 INFO - (blobuploader) - INFO - Open directory for files ... 23:38:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:38:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:38:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:38:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:38:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:38:41 INFO - (blobuploader) - INFO - Done attempting. 23:38:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:38:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:38:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:38:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:38:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:38:42 INFO - (blobuploader) - INFO - Done attempting. 23:38:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:38:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:38:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:38:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:38:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:38:46 INFO - (blobuploader) - INFO - Done attempting. 23:38:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 23:38:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:38:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:38:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 23:38:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:38:47 INFO - (blobuploader) - INFO - Done attempting. 23:38:47 INFO - (blobuploader) - INFO - Iteration through files over. 23:38:47 INFO - Return code: 0 23:38:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:38:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:38:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/69e9728b913815f000297719bee04d3e0361a799c213ad89d74f3609c6d8f743af78a5d0f0838f535aefe6e122cce806aac09b029e554947451f00f2279dab5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a22ba7ede114d27815cc1cec1dd5dae773ddf1f17ca2550e404b03584b58b42d679b1212c04571699925c285d7a773865ac5578f6d4d2193bfe0a4322155b48b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ba8ece2fd321b069d8ef55c5422fb268411eb0062e65c2b99a9552a63ed63f1c454471fd8a3f42c8343ec7c0a53df0e96ffce3ea4617ea6ac218955632d15c81", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/715f06b280749200a724c0b2410e2bf7c27a9fe154abcb833eea3ec51af4ae12413505ed6bb37d947ceb85e81e2ca1adbf4c009b8e6b4e02eee2338781d46aae"} 23:38:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:38:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:38:47 INFO - Contents: 23:38:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/69e9728b913815f000297719bee04d3e0361a799c213ad89d74f3609c6d8f743af78a5d0f0838f535aefe6e122cce806aac09b029e554947451f00f2279dab5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a22ba7ede114d27815cc1cec1dd5dae773ddf1f17ca2550e404b03584b58b42d679b1212c04571699925c285d7a773865ac5578f6d4d2193bfe0a4322155b48b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ba8ece2fd321b069d8ef55c5422fb268411eb0062e65c2b99a9552a63ed63f1c454471fd8a3f42c8343ec7c0a53df0e96ffce3ea4617ea6ac218955632d15c81", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/715f06b280749200a724c0b2410e2bf7c27a9fe154abcb833eea3ec51af4ae12413505ed6bb37d947ceb85e81e2ca1adbf4c009b8e6b4e02eee2338781d46aae"} 23:38:47 INFO - Running post-run listener: copy_logs_to_upload_dir 23:38:47 INFO - Copying logs to upload dir... 23:38:47 INFO - mkdir: /builds/slave/test/build/upload/logs 23:38:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.615957 ========= master_lag: 0.42 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-01-06 23:38:48.121575) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-06 23:38:48.126406) ========= 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=41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157 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/Graphics/sha512/69e9728b913815f000297719bee04d3e0361a799c213ad89d74f3609c6d8f743af78a5d0f0838f535aefe6e122cce806aac09b029e554947451f00f2279dab5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a22ba7ede114d27815cc1cec1dd5dae773ddf1f17ca2550e404b03584b58b42d679b1212c04571699925c285d7a773865ac5578f6d4d2193bfe0a4322155b48b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ba8ece2fd321b069d8ef55c5422fb268411eb0062e65c2b99a9552a63ed63f1c454471fd8a3f42c8343ec7c0a53df0e96ffce3ea4617ea6ac218955632d15c81", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/715f06b280749200a724c0b2410e2bf7c27a9fe154abcb833eea3ec51af4ae12413505ed6bb37d947ceb85e81e2ca1adbf4c009b8e6b4e02eee2338781d46aae"} build_url:https://queue.taskcluster.net/v1/task/HvcOkj5IQXee8d4uiGgpuw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011786 build_url: 'https://queue.taskcluster.net/v1/task/HvcOkj5IQXee8d4uiGgpuw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/69e9728b913815f000297719bee04d3e0361a799c213ad89d74f3609c6d8f743af78a5d0f0838f535aefe6e122cce806aac09b029e554947451f00f2279dab5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a22ba7ede114d27815cc1cec1dd5dae773ddf1f17ca2550e404b03584b58b42d679b1212c04571699925c285d7a773865ac5578f6d4d2193bfe0a4322155b48b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ba8ece2fd321b069d8ef55c5422fb268411eb0062e65c2b99a9552a63ed63f1c454471fd8a3f42c8343ec7c0a53df0e96ffce3ea4617ea6ac218955632d15c81", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/715f06b280749200a724c0b2410e2bf7c27a9fe154abcb833eea3ec51af4ae12413505ed6bb37d947ceb85e81e2ca1adbf4c009b8e6b4e02eee2338781d46aae"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-06 23:38:48.159325) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 23:38:48.159680) ========= 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=41bf3e9aed84707956354da8000001c5-1483771369.773257-1189753157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 23:38:48.208456) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-06 23:38:48.208731) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-06 23:38:48.208992) ========= ========= Total master_lag: 0.54 =========