builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-030 starttime: 1485953568.52 results: success (0) revision: 9e7b1041929fccc06f6fad91cf66b9edcdfc0129 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-01 04:52:48.517348) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-01 04:52:48.517811) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-01 04:52:48.518131) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-01 04:52:48.537889) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 04:52:48.538191) ========= 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=3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-01 04:52:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2017-02-01 04:52:48 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.305506 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 04:52:48.857295) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 04:52:48.857639) ========= 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=3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019059 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 04:52:48.910224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-01 04:52:48.911026) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9e7b1041929fccc06f6fad91cf66b9edcdfc0129 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 9e7b1041929fccc06f6fad91cf66b9edcdfc0129 --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=3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-01 04:52:49,082 truncating revision to first 12 chars 2017-02-01 04:52:49,082 Setting DEBUG logging. 2017-02-01 04:52:49,082 attempt 1/10 2017-02-01 04:52:49,082 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9e7b1041929f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-01 04:52:50,057 unpacking tar archive at: mozilla-central-9e7b1041929f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.311870 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-01 04:52:50.240009) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-01 04:52:50.240622) ========= script_repo_revision: 9e7b1041929fccc06f6fad91cf66b9edcdfc0129 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-01 04:52:50.241350) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-01 04:52:50.241928) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-01 04:52:50.254179) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-02-01 04:52:50.254511) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:52:50 INFO - MultiFileLogger online at 20170201 04:52:50 in /builds/slave/test 04:52:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:52:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:52:50 INFO - {'append_to_log': False, 04:52:50 INFO - 'base_work_dir': '/builds/slave/test', 04:52:50 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:52:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:52:50 INFO - 'branch': 'Firefox-Non-PGO', 04:52:50 INFO - 'buildbot_json_path': 'buildprops.json', 04:52:50 INFO - 'config_files': ('talos/linux_config.py',), 04:52:50 INFO - 'default_actions': ('clobber', 04:52:50 INFO - 'read-buildbot-config', 04:52:50 INFO - 'download-and-extract', 04:52:50 INFO - 'populate-webroot', 04:52:50 INFO - 'create-virtualenv', 04:52:50 INFO - 'install', 04:52:50 INFO - 'run-tests'), 04:52:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:52:50 INFO - 'download_minidump_stackwalk': True, 04:52:50 INFO - 'download_symbols': 'ondemand', 04:52:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:52:50 INFO - 'tooltool.py': '/tools/tooltool.py', 04:52:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:52:50 INFO - '/tools/misc-python/virtualenv.py')}, 04:52:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:52:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:52:50 INFO - 'installer_path': 'installer.exe', 04:52:50 INFO - 'log_level': 'info', 04:52:50 INFO - 'log_name': 'talos', 04:52:50 INFO - 'log_to_console': True, 04:52:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:52:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:52:50 INFO - 'opt_config_files': (), 04:52:50 INFO - 'pip_index': False, 04:52:50 INFO - 'sps_profile': False, 04:52:50 INFO - 'sps_profile_interval': 0, 04:52:50 INFO - 'suite': 'dromaeojs', 04:52:50 INFO - 'system_bits': '32', 04:52:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:52:50 INFO - 'title': 'talos-linux64-ix-030', 04:52:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:52:50 INFO - 'use_talos_json': True, 04:52:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:52:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:52:50 INFO - 'work_dir': 'build'} 04:52:50 INFO - [mozharness: 2017-02-01 12:52:50.520171Z] Running clobber step. 04:52:50 INFO - Running pre-action listener: _resource_record_pre_action 04:52:50 INFO - Running main action method: clobber 04:52:50 INFO - rmtree: /builds/slave/test/build 04:52:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:52:50 INFO - Running post-action listener: _resource_record_post_action 04:52:50 INFO - [mozharness: 2017-02-01 12:52:50.981225Z] Finished clobber step (success) 04:52:50 INFO - [mozharness: 2017-02-01 12:52:50.981343Z] Running read-buildbot-config step. 04:52:50 INFO - Running pre-action listener: _resource_record_pre_action 04:52:50 INFO - Running main action method: read_buildbot_config 04:52:50 INFO - Using buildbot properties: 04:52:50 INFO - { 04:52:50 INFO - "project": "", 04:52:50 INFO - "product": "firefox", 04:52:50 INFO - "who": "cbook@mozilla.com", 04:52:50 INFO - "installer_path": "public/build/target.tar.bz2", 04:52:50 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:52:50 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:52:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:52:50 INFO - "stage_platform": "linux64", 04:52:50 INFO - "basedir": "/builds/slave/test", 04:52:50 INFO - "buildnumber": 952, 04:52:50 INFO - "platform": "ubuntu64_hw", 04:52:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:52:50 INFO - "slavebuilddir": "test", 04:52:50 INFO - "taskId": "JyNIajHhTti09mDvoEPV7Q", 04:52:50 INFO - "branch": "mozilla-central", 04:52:50 INFO - "script_repo_revision": "production", 04:52:50 INFO - "revision": "9e7b1041929fccc06f6fad91cf66b9edcdfc0129", 04:52:50 INFO - "slavename": "talos-linux64-ix-030", 04:52:50 INFO - "repo_path": "mozilla-central" 04:52:50 INFO - } 04:52:50 INFO - Finding installer, test and symbols from parent task. 04:52:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JyNIajHhTti09mDvoEPV7Q'}, attempt #1 04:52:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JyNIajHhTti09mDvoEPV7Q'}, attempt #1 04:52:51 INFO - Task dependencies: VnnkjD7MTYqEJ8m5I6V2zg 04:52:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VnnkjD7MTYqEJ8m5I6V2zg'}, attempt #1 04:52:52 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VnnkjD7MTYqEJ8m5I6V2zg/artifacts/public/build/target.tar.bz2 04:52:52 INFO - Set test_url: https://queue.taskcluster.net/v1/task/VnnkjD7MTYqEJ8m5I6V2zg/artifacts/public/build/test_packages.json 04:52:52 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VnnkjD7MTYqEJ8m5I6V2zg/artifacts/public/build/target.crashreporter-symbols.zip 04:52:52 INFO - Running post-action listener: _resource_record_post_action 04:52:52 INFO - [mozharness: 2017-02-01 12:52:52.381683Z] Finished read-buildbot-config step (success) 04:52:52 INFO - [mozharness: 2017-02-01 12:52:52.381899Z] Running download-and-extract step. 04:52:52 INFO - Running pre-action listener: _resource_record_pre_action 04:52:52 INFO - Running main action method: download_and_extract 04:52:52 INFO - mkdir: /builds/slave/test/build/tests 04:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:52 INFO - trying https://queue.taskcluster.net/v1/task/VnnkjD7MTYqEJ8m5I6V2zg/artifacts/public/build/target.test_packages.json 04:52:52 INFO - Downloading https://queue.taskcluster.net/v1/task/VnnkjD7MTYqEJ8m5I6V2zg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:52:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VnnkjD7MTYqEJ8m5I6V2zg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:52:52 INFO - Downloaded 896 bytes. 04:52:52 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:52:52 INFO - Using the following test package requirements: 04:52:52 INFO - {u'common': [u'target.common.tests.zip'], 04:52:52 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:52:52 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:52:52 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:52:52 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:52:52 INFO - u'mozbase': [u'target.common.tests.zip'], 04:52:52 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:52:52 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:52:52 INFO - u'web-platform': [u'target.common.tests.zip', 04:52:52 INFO - u'target.web-platform.tests.zip'], 04:52:52 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:52:52 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:52:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VnnkjD7MTYqEJ8m5I6V2zg/artifacts/public/build/target.common.tests.zip 04:52:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VnnkjD7MTYqEJ8m5I6V2zg/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:52:52 INFO - Fetch https://queue.taskcluster.net/v1/task/VnnkjD7MTYqEJ8m5I6V2zg/artifacts/public/build/target.common.tests.zip into memory 04:52:54 INFO - Expected file size: 20363869 04:52:54 INFO - Obtained file size: 20363869 04:52:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:52:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VnnkjD7MTYqEJ8m5I6V2zg/artifacts/public/build/target.common.tests.zip 04:52:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VnnkjD7MTYqEJ8m5I6V2zg/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:52:58 INFO - Fetch https://queue.taskcluster.net/v1/task/VnnkjD7MTYqEJ8m5I6V2zg/artifacts/public/build/target.common.tests.zip into memory 04:52:58 INFO - Expected file size: 20363869 04:52:58 INFO - Obtained file size: 20363869 04:53:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VnnkjD7MTYqEJ8m5I6V2zg/artifacts/public/build/target.talos.tests.zip 04:53:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VnnkjD7MTYqEJ8m5I6V2zg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:53:03 INFO - Fetch https://queue.taskcluster.net/v1/task/VnnkjD7MTYqEJ8m5I6V2zg/artifacts/public/build/target.talos.tests.zip into memory 04:53:04 INFO - Expected file size: 14403454 04:53:04 INFO - Obtained file size: 14403454 04:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:05 INFO - trying https://queue.taskcluster.net/v1/task/VnnkjD7MTYqEJ8m5I6V2zg/artifacts/public/build/target.tar.bz2 04:53:05 INFO - Downloading https://queue.taskcluster.net/v1/task/VnnkjD7MTYqEJ8m5I6V2zg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:53:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VnnkjD7MTYqEJ8m5I6V2zg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:53:08 INFO - Downloaded 56174107 bytes. 04:53:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VnnkjD7MTYqEJ8m5I6V2zg/artifacts/public/build/target.tar.bz2 04:53:08 INFO - mkdir: /builds/slave/test/properties 04:53:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:53:08 INFO - Writing to file /builds/slave/test/properties/build_url 04:53:08 INFO - Contents: 04:53:08 INFO - build_url:https://queue.taskcluster.net/v1/task/VnnkjD7MTYqEJ8m5I6V2zg/artifacts/public/build/target.tar.bz2 04:53:08 INFO - Running post-action listener: _resource_record_post_action 04:53:08 INFO - Running post-action listener: set_extra_try_arguments 04:53:08 INFO - [mozharness: 2017-02-01 12:53:08.107220Z] Finished download-and-extract step (success) 04:53:08 INFO - [mozharness: 2017-02-01 12:53:08.107445Z] Running populate-webroot step. 04:53:08 INFO - Running pre-action listener: _resource_record_pre_action 04:53:08 INFO - Running main action method: populate_webroot 04:53:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:53:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:53:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:53:08 INFO - '--tppagecycles', 04:53:08 INFO - '7'], 04:53:08 INFO - 'tests': ['tsvgm']}}, 04:53:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:53:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:53:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:53:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:53:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:53:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:53:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:53:08 INFO - 'talos_options': ['--disable-e10s'], 04:53:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:53:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:53:08 INFO - 'talos_options': ['--disable-e10s'], 04:53:08 INFO - 'tests': ['damp', 'tps']}, 04:53:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:53:08 INFO - 'tests': ['damp', 'tps']}, 04:53:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:53:08 INFO - 'tests': ['dromaeo_dom']}, 04:53:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:53:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:53:08 INFO - 'tests': ['basic_compositor_video']}, 04:53:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:53:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:53:08 INFO - 'tests': ['a11yr', 04:53:08 INFO - 'ts_paint', 04:53:08 INFO - 'tpaint', 04:53:08 INFO - 'sessionrestore', 04:53:08 INFO - 'sessionrestore_no_auto_restore', 04:53:08 INFO - 'tabpaint']}, 04:53:08 INFO - 'other-e10s': {'tests': ['a11yr', 04:53:08 INFO - 'ts_paint', 04:53:08 INFO - 'tpaint', 04:53:08 INFO - 'sessionrestore', 04:53:08 INFO - 'sessionrestore_no_auto_restore', 04:53:08 INFO - 'tabpaint']}, 04:53:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:53:08 INFO - 'ts_paint', 04:53:08 INFO - 'tpaint', 04:53:08 INFO - 'sessionrestore', 04:53:08 INFO - 'sessionrestore_no_auto_restore', 04:53:08 INFO - 'tabpaint']}, 04:53:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:53:08 INFO - 'ts_paint', 04:53:08 INFO - 'tpaint', 04:53:08 INFO - 'sessionrestore', 04:53:08 INFO - 'sessionrestore_no_auto_restore', 04:53:08 INFO - 'tabpaint']}, 04:53:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:53:08 INFO - 'tests': ['a11yr', 04:53:08 INFO - 'ts_paint', 04:53:08 INFO - 'tpaint', 04:53:08 INFO - 'sessionrestore', 04:53:08 INFO - 'sessionrestore_no_auto_restore', 04:53:08 INFO - 'tabpaint']}, 04:53:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:53:08 INFO - 'tests': ['a11yr', 04:53:08 INFO - 'ts_paint', 04:53:08 INFO - 'tpaint', 04:53:08 INFO - 'sessionrestore', 04:53:08 INFO - 'sessionrestore_no_auto_restore', 04:53:08 INFO - 'tabpaint']}, 04:53:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:53:08 INFO - 'tests': ['tsvgx', 04:53:08 INFO - 'tsvgr_opacity', 04:53:08 INFO - 'tart', 04:53:08 INFO - 'tscrollx', 04:53:08 INFO - 'cart', 04:53:08 INFO - 'tsvg_static']}, 04:53:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:53:08 INFO - 'tsvgr_opacity', 04:53:08 INFO - 'tart', 04:53:08 INFO - 'tscrollx', 04:53:08 INFO - 'cart', 04:53:08 INFO - 'tsvg_static']}, 04:53:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:53:08 INFO - 'talos_options': ['--disable-e10s'], 04:53:08 INFO - 'tests': ['tp5o']}, 04:53:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:53:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:53:08 INFO - 'talos_options': ['--disable-e10s', 04:53:08 INFO - '--xperf_path', 04:53:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:08 INFO - 'tests': ['tp5n']}, 04:53:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:53:08 INFO - 'talos_options': ['--xperf_path', 04:53:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:08 INFO - 'tests': ['tp5n']}}, 04:53:08 INFO - 'talos.zip': {'path': '', 04:53:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:53:08 INFO - Running post-action listener: _resource_record_post_action 04:53:08 INFO - [mozharness: 2017-02-01 12:53:08.126644Z] Finished populate-webroot step (success) 04:53:08 INFO - [mozharness: 2017-02-01 12:53:08.126737Z] Running create-virtualenv step. 04:53:08 INFO - Running pre-action listener: _resource_record_pre_action 04:53:08 INFO - Running main action method: create_virtualenv 04:53:08 INFO - Creating virtualenv /builds/slave/test/build/venv 04:53:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:53:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:53:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:53:08 INFO - Using real prefix '/usr' 04:53:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:53:08 INFO - Installing distribute.............................................................................................................................................................................................done. 04:53:10 INFO - Installing pip.................done. 04:53:10 INFO - Return code: 0 04:53:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:53:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:53:10 INFO - Reading from file tmpfile_stdout 04:53:10 INFO - Output received: 04:53:10 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:53:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:10 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 0xf591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1354850>, '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 0x12c96d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c9b60>, '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': '3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:53:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:53:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:53:10 INFO - Using env: {'DISPLAY': ':0', 04:53:10 INFO - 'HOME': '/home/cltbld', 04:53:10 INFO - 'LANG': 'en_US.UTF-8', 04:53:10 INFO - 'LANGUAGE': 'en_US:en', 04:53:10 INFO - 'LOGNAME': 'cltbld', 04:53:10 INFO - 'MAIL': '/var/mail/cltbld', 04:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:10 INFO - 'MOZ_NO_REMOTE': '1', 04:53:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:10 INFO - 'NO_EM_RESTART': '1', 04:53:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:10 INFO - 'PWD': '/builds/slave/test', 04:53:10 INFO - 'SHELL': '/bin/bash', 04:53:10 INFO - 'SHLVL': '1', 04:53:10 INFO - 'TERM': 'linux', 04:53:10 INFO - 'TMOUT': '86400', 04:53:10 INFO - 'USER': 'cltbld', 04:53:10 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854', 04:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:10 INFO - '_': '/tools/buildbot/bin/python'} 04:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:53:11 INFO - Cleaning up... 04:53:11 INFO - Return code: 0 04:53:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:11 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 0xf591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1354850>, '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 0x12c96d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c9b60>, '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': '3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:53:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:53:11 INFO - Using env: {'DISPLAY': ':0', 04:53:11 INFO - 'HOME': '/home/cltbld', 04:53:11 INFO - 'LANG': 'en_US.UTF-8', 04:53:11 INFO - 'LANGUAGE': 'en_US:en', 04:53:11 INFO - 'LOGNAME': 'cltbld', 04:53:11 INFO - 'MAIL': '/var/mail/cltbld', 04:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:11 INFO - 'MOZ_NO_REMOTE': '1', 04:53:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:11 INFO - 'NO_EM_RESTART': '1', 04:53:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:11 INFO - 'PWD': '/builds/slave/test', 04:53:11 INFO - 'SHELL': '/bin/bash', 04:53:11 INFO - 'SHLVL': '1', 04:53:11 INFO - 'TERM': 'linux', 04:53:11 INFO - 'TMOUT': '86400', 04:53:11 INFO - 'USER': 'cltbld', 04:53:11 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854', 04:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:11 INFO - '_': '/tools/buildbot/bin/python'} 04:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:11 INFO - Downloading/unpacking psutil>=3.1.1 04:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:53:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:13 INFO - Installing collected packages: psutil 04:53:13 INFO - Running setup.py install for psutil 04:53:13 INFO - building 'psutil._psutil_linux' extension 04:53:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:53:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:53:13 INFO - building 'psutil._psutil_posix' extension 04:53:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:53:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:53:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:13 INFO - Successfully installed psutil 04:53:13 INFO - Cleaning up... 04:53:14 INFO - Return code: 0 04:53:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:14 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 0xf591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1354850>, '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 0x12c96d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c9b60>, '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': '3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:53:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:53:14 INFO - Using env: {'DISPLAY': ':0', 04:53:14 INFO - 'HOME': '/home/cltbld', 04:53:14 INFO - 'LANG': 'en_US.UTF-8', 04:53:14 INFO - 'LANGUAGE': 'en_US:en', 04:53:14 INFO - 'LOGNAME': 'cltbld', 04:53:14 INFO - 'MAIL': '/var/mail/cltbld', 04:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:14 INFO - 'MOZ_NO_REMOTE': '1', 04:53:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:14 INFO - 'NO_EM_RESTART': '1', 04:53:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:14 INFO - 'PWD': '/builds/slave/test', 04:53:14 INFO - 'SHELL': '/bin/bash', 04:53:14 INFO - 'SHLVL': '1', 04:53:14 INFO - 'TERM': 'linux', 04:53:14 INFO - 'TMOUT': '86400', 04:53:14 INFO - 'USER': 'cltbld', 04:53:14 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854', 04:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:14 INFO - '_': '/tools/buildbot/bin/python'} 04:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:53:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:53:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:53:16 INFO - Installing collected packages: mozsystemmonitor 04:53:16 INFO - Running setup.py install for mozsystemmonitor 04:53:16 INFO - Successfully installed mozsystemmonitor 04:53:16 INFO - Cleaning up... 04:53:16 INFO - Return code: 0 04:53:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:16 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 0xf591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1354850>, '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 0x12c96d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c9b60>, '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': '3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:53:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:53:16 INFO - Using env: {'DISPLAY': ':0', 04:53:16 INFO - 'HOME': '/home/cltbld', 04:53:16 INFO - 'LANG': 'en_US.UTF-8', 04:53:16 INFO - 'LANGUAGE': 'en_US:en', 04:53:16 INFO - 'LOGNAME': 'cltbld', 04:53:16 INFO - 'MAIL': '/var/mail/cltbld', 04:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:16 INFO - 'MOZ_NO_REMOTE': '1', 04:53:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:16 INFO - 'NO_EM_RESTART': '1', 04:53:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:16 INFO - 'PWD': '/builds/slave/test', 04:53:16 INFO - 'SHELL': '/bin/bash', 04:53:16 INFO - 'SHLVL': '1', 04:53:16 INFO - 'TERM': 'linux', 04:53:16 INFO - 'TMOUT': '86400', 04:53:16 INFO - 'USER': 'cltbld', 04:53:16 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854', 04:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:16 INFO - '_': '/tools/buildbot/bin/python'} 04:53:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:16 INFO - Downloading/unpacking jsonschema==2.5.1 04:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:53:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:18 INFO - Downloading functools32-3.2.3-2.tar.gz 04:53:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:53:18 INFO - warning: no files found matching '*.txt' 04:53:18 INFO - no previously-included directories found matching 'build' 04:53:18 INFO - no previously-included directories found matching 'dist' 04:53:18 INFO - no previously-included directories found matching '.git*' 04:53:18 INFO - Installing collected packages: jsonschema, functools32 04:53:19 INFO - Running setup.py install for functools32 04:53:19 INFO - warning: no files found matching '*.txt' 04:53:19 INFO - no previously-included directories found matching 'build' 04:53:19 INFO - no previously-included directories found matching 'dist' 04:53:19 INFO - no previously-included directories found matching '.git*' 04:53:19 INFO - Successfully installed jsonschema functools32 04:53:19 INFO - Cleaning up... 04:53:19 INFO - Return code: 0 04:53:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:19 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 0xf591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1354850>, '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 0x12c96d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c9b60>, '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': '3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:53:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:53:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:53:19 INFO - Using env: {'DISPLAY': ':0', 04:53:19 INFO - 'HOME': '/home/cltbld', 04:53:19 INFO - 'LANG': 'en_US.UTF-8', 04:53:19 INFO - 'LANGUAGE': 'en_US:en', 04:53:19 INFO - 'LOGNAME': 'cltbld', 04:53:19 INFO - 'MAIL': '/var/mail/cltbld', 04:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:19 INFO - 'MOZ_NO_REMOTE': '1', 04:53:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:19 INFO - 'NO_EM_RESTART': '1', 04:53:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:19 INFO - 'PWD': '/builds/slave/test', 04:53:19 INFO - 'SHELL': '/bin/bash', 04:53:19 INFO - 'SHLVL': '1', 04:53:19 INFO - 'TERM': 'linux', 04:53:19 INFO - 'TMOUT': '86400', 04:53:19 INFO - 'USER': 'cltbld', 04:53:19 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854', 04:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:19 INFO - '_': '/tools/buildbot/bin/python'} 04:53:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:53:19 INFO - Cleaning up... 04:53:19 INFO - Return code: 0 04:53:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:19 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 0xf591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1354850>, '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 0x12c96d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c9b60>, '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': '3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:53:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:53:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:53:19 INFO - Using env: {'DISPLAY': ':0', 04:53:19 INFO - 'HOME': '/home/cltbld', 04:53:19 INFO - 'LANG': 'en_US.UTF-8', 04:53:19 INFO - 'LANGUAGE': 'en_US:en', 04:53:19 INFO - 'LOGNAME': 'cltbld', 04:53:19 INFO - 'MAIL': '/var/mail/cltbld', 04:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:19 INFO - 'MOZ_NO_REMOTE': '1', 04:53:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:19 INFO - 'NO_EM_RESTART': '1', 04:53:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:19 INFO - 'PWD': '/builds/slave/test', 04:53:19 INFO - 'SHELL': '/bin/bash', 04:53:19 INFO - 'SHLVL': '1', 04:53:19 INFO - 'TERM': 'linux', 04:53:19 INFO - 'TMOUT': '86400', 04:53:19 INFO - 'USER': 'cltbld', 04:53:19 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854', 04:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:19 INFO - '_': '/tools/buildbot/bin/python'} 04:53:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:19 INFO - Downloading/unpacking blobuploader==1.2.4 04:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:21 INFO - Downloading blobuploader-1.2.4.tar.gz 04:53:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:53:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:53:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:22 INFO - Downloading docopt-0.6.1.tar.gz 04:53:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:53:22 INFO - Installing collected packages: blobuploader, requests, docopt 04:53:22 INFO - Running setup.py install for blobuploader 04:53:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:53:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:53:22 INFO - Running setup.py install for requests 04:53:22 INFO - Running setup.py install for docopt 04:53:22 INFO - Successfully installed blobuploader requests docopt 04:53:22 INFO - Cleaning up... 04:53:23 INFO - Return code: 0 04:53:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:23 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 0xf591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1354850>, '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 0x12c96d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c9b60>, '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': '3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:53:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:53:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:53:23 INFO - Using env: {'DISPLAY': ':0', 04:53:23 INFO - 'HOME': '/home/cltbld', 04:53:23 INFO - 'LANG': 'en_US.UTF-8', 04:53:23 INFO - 'LANGUAGE': 'en_US:en', 04:53:23 INFO - 'LOGNAME': 'cltbld', 04:53:23 INFO - 'MAIL': '/var/mail/cltbld', 04:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:23 INFO - 'MOZ_NO_REMOTE': '1', 04:53:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:23 INFO - 'NO_EM_RESTART': '1', 04:53:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:23 INFO - 'PWD': '/builds/slave/test', 04:53:23 INFO - 'SHELL': '/bin/bash', 04:53:23 INFO - 'SHLVL': '1', 04:53:23 INFO - 'TERM': 'linux', 04:53:23 INFO - 'TMOUT': '86400', 04:53:23 INFO - 'USER': 'cltbld', 04:53:23 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854', 04:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:23 INFO - '_': '/tools/buildbot/bin/python'} 04:53:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:23 INFO - Running setup.py (path:/tmp/pip-Gks0mZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:23 INFO - Running setup.py (path:/tmp/pip-TU02pQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:23 INFO - Running setup.py (path:/tmp/pip-AMR2Vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:23 INFO - Running setup.py (path:/tmp/pip-cJz6P7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:23 INFO - Running setup.py (path:/tmp/pip-Bxi83s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:23 INFO - Running setup.py (path:/tmp/pip-cWLoCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:23 INFO - Running setup.py (path:/tmp/pip-OgdIOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:23 INFO - Running setup.py (path:/tmp/pip-d_sdX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:23 INFO - Running setup.py (path:/tmp/pip-fsTbk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:23 INFO - Running setup.py (path:/tmp/pip-sh65wU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:23 INFO - Running setup.py (path:/tmp/pip-V_tSgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:24 INFO - Running setup.py (path:/tmp/pip-GLZCHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:24 INFO - Running setup.py (path:/tmp/pip-g296So-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:24 INFO - Running setup.py (path:/tmp/pip-Rw8YNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:24 INFO - Running setup.py (path:/tmp/pip-A3KK4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:24 INFO - Running setup.py (path:/tmp/pip-2_Evm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:24 INFO - Running setup.py (path:/tmp/pip-Y5xfsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:53:24 INFO - Running setup.py install for manifestparser 04:53:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:53:24 INFO - Running setup.py install for mozcrash 04:53:24 INFO - Running setup.py install for mozdebug 04:53:24 INFO - Running setup.py install for mozdevice 04:53:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:53:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:53:24 INFO - Running setup.py install for mozfile 04:53:24 INFO - Running setup.py install for mozhttpd 04:53:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:53:25 INFO - Running setup.py install for mozinfo 04:53:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:53:25 INFO - Running setup.py install for mozInstall 04:53:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:53:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:53:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:53:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:53:25 INFO - Running setup.py install for mozleak 04:53:25 INFO - Running setup.py install for mozlog 04:53:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:53:25 INFO - Running setup.py install for moznetwork 04:53:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:53:25 INFO - Running setup.py install for mozprocess 04:53:25 INFO - Running setup.py install for mozprofile 04:53:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:53:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:53:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:53:25 INFO - Running setup.py install for mozrunner 04:53:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:53:25 INFO - Running setup.py install for mozscreenshot 04:53:26 INFO - Running setup.py install for moztest 04:53:26 INFO - Running setup.py install for mozversion 04:53:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:53:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:53:26 INFO - Cleaning up... 04:53:26 INFO - Return code: 0 04:53:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:26 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 0xf591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1354850>, '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 0x12c96d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c9b60>, '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': '3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:53:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:53:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:53:26 INFO - Using env: {'DISPLAY': ':0', 04:53:26 INFO - 'HOME': '/home/cltbld', 04:53:26 INFO - 'LANG': 'en_US.UTF-8', 04:53:26 INFO - 'LANGUAGE': 'en_US:en', 04:53:26 INFO - 'LOGNAME': 'cltbld', 04:53:26 INFO - 'MAIL': '/var/mail/cltbld', 04:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:26 INFO - 'MOZ_NO_REMOTE': '1', 04:53:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:26 INFO - 'NO_EM_RESTART': '1', 04:53:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:26 INFO - 'PWD': '/builds/slave/test', 04:53:26 INFO - 'SHELL': '/bin/bash', 04:53:26 INFO - 'SHLVL': '1', 04:53:26 INFO - 'TERM': 'linux', 04:53:26 INFO - 'TMOUT': '86400', 04:53:26 INFO - 'USER': 'cltbld', 04:53:26 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854', 04:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:26 INFO - '_': '/tools/buildbot/bin/python'} 04:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:26 INFO - Running setup.py (path:/tmp/pip-pcWKm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:26 INFO - Running setup.py (path:/tmp/pip-NJAOIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:26 INFO - Running setup.py (path:/tmp/pip-qemDSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:26 INFO - Running setup.py (path:/tmp/pip-6YSTs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:26 INFO - Running setup.py (path:/tmp/pip-CQNwoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:26 INFO - Running setup.py (path:/tmp/pip-lB2ChP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:26 INFO - Running setup.py (path:/tmp/pip-HI0pmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:26 INFO - Running setup.py (path:/tmp/pip-NoB3xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:27 INFO - Running setup.py (path:/tmp/pip-cd6Uo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:27 INFO - Running setup.py (path:/tmp/pip-y6L50U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:27 INFO - Running setup.py (path:/tmp/pip-fQgZfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:27 INFO - Running setup.py (path:/tmp/pip-VeN8n5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:27 INFO - Running setup.py (path:/tmp/pip-ekh_8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:27 INFO - Running setup.py (path:/tmp/pip-pRj5xe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:27 INFO - Running setup.py (path:/tmp/pip-kaSjLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:27 INFO - Running setup.py (path:/tmp/pip-uZKNOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:27 INFO - Running setup.py (path:/tmp/pip-iKRIL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:53:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:29 INFO - Downloading blessings-1.6.tar.gz 04:53:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:53:29 INFO - Installing collected packages: blessings 04:53:29 INFO - Running setup.py install for blessings 04:53:29 INFO - Successfully installed blessings 04:53:29 INFO - Cleaning up... 04:53:29 INFO - Return code: 0 04:53:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:53:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:30 INFO - Reading from file tmpfile_stdout 04:53:30 INFO - Current package versions: 04:53:30 INFO - argparse == 1.2.1 04:53:30 INFO - blessings == 1.6 04:53:30 INFO - blobuploader == 1.2.4 04:53:30 INFO - docopt == 0.6.1 04:53:30 INFO - functools32 == 3.2.3-2 04:53:30 INFO - jsonschema == 2.5.1 04:53:30 INFO - manifestparser == 1.1 04:53:30 INFO - mozInstall == 1.12 04:53:30 INFO - mozcrash == 1.0 04:53:30 INFO - mozdebug == 0.1 04:53:30 INFO - mozdevice == 0.49 04:53:30 INFO - mozfile == 1.2 04:53:30 INFO - mozhttpd == 0.7 04:53:30 INFO - mozinfo == 0.9 04:53:30 INFO - mozleak == 0.1 04:53:30 INFO - mozlog == 3.4 04:53:30 INFO - moznetwork == 0.27 04:53:30 INFO - mozprocess == 0.24 04:53:30 INFO - mozprofile == 0.28 04:53:30 INFO - mozrunner == 6.13 04:53:30 INFO - mozscreenshot == 0.1 04:53:30 INFO - mozsystemmonitor == 0.3 04:53:30 INFO - moztest == 0.8 04:53:30 INFO - mozversion == 1.4 04:53:30 INFO - psutil == 3.1.1 04:53:30 INFO - requests == 1.2.3 04:53:30 INFO - wsgiref == 0.1.2 04:53:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:30 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 0xf591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1354850>, '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 0x12c96d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c9b60>, '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': '3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:53:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:53:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:53:30 INFO - Using env: {'DISPLAY': ':0', 04:53:30 INFO - 'HOME': '/home/cltbld', 04:53:30 INFO - 'LANG': 'en_US.UTF-8', 04:53:30 INFO - 'LANGUAGE': 'en_US:en', 04:53:30 INFO - 'LOGNAME': 'cltbld', 04:53:30 INFO - 'MAIL': '/var/mail/cltbld', 04:53:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:30 INFO - 'MOZ_NO_REMOTE': '1', 04:53:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:30 INFO - 'NO_EM_RESTART': '1', 04:53:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:30 INFO - 'PWD': '/builds/slave/test', 04:53:30 INFO - 'SHELL': '/bin/bash', 04:53:30 INFO - 'SHLVL': '1', 04:53:30 INFO - 'TERM': 'linux', 04:53:30 INFO - 'TMOUT': '86400', 04:53:30 INFO - 'USER': 'cltbld', 04:53:30 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854', 04:53:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:30 INFO - '_': '/tools/buildbot/bin/python'} 04:53:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:53:30 INFO - Cleaning up... 04:53:30 INFO - Return code: 0 04:53:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1354850>, '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 0x12c96d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c9b60>, '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': '3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:53:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:53:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:53:30 INFO - Using env: {'DISPLAY': ':0', 04:53:30 INFO - 'HOME': '/home/cltbld', 04:53:30 INFO - 'LANG': 'en_US.UTF-8', 04:53:30 INFO - 'LANGUAGE': 'en_US:en', 04:53:30 INFO - 'LOGNAME': 'cltbld', 04:53:30 INFO - 'MAIL': '/var/mail/cltbld', 04:53:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:30 INFO - 'MOZ_NO_REMOTE': '1', 04:53:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:30 INFO - 'NO_EM_RESTART': '1', 04:53:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:30 INFO - 'PWD': '/builds/slave/test', 04:53:30 INFO - 'SHELL': '/bin/bash', 04:53:30 INFO - 'SHLVL': '1', 04:53:30 INFO - 'TERM': 'linux', 04:53:30 INFO - 'TMOUT': '86400', 04:53:30 INFO - 'USER': 'cltbld', 04:53:30 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854', 04:53:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:30 INFO - '_': '/tools/buildbot/bin/python'} 04:53:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:53:30 INFO - Cleaning up... 04:53:30 INFO - Return code: 0 04:53:30 INFO - Running post-action listener: _resource_record_post_action 04:53:30 INFO - Running post-action listener: _start_resource_monitoring 04:53:30 INFO - Starting resource monitoring. 04:53:30 INFO - [mozharness: 2017-02-01 12:53:30.661772Z] Finished create-virtualenv step (success) 04:53:30 INFO - [mozharness: 2017-02-01 12:53:30.662279Z] Running install step. 04:53:30 INFO - Running pre-action listener: _resource_record_pre_action 04:53:30 INFO - Running main action method: install 04:53:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:30 INFO - Reading from file tmpfile_stdout 04:53:30 INFO - Detecting whether we're running mozinstall >=1.0... 04:53:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:53:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:53:30 INFO - Reading from file tmpfile_stdout 04:53:30 INFO - Output received: 04:53:30 INFO - Usage: mozinstall [options] installer 04:53:30 INFO - Options: 04:53:30 INFO - -h, --help show this help message and exit 04:53:30 INFO - -d DEST, --destination=DEST 04:53:30 INFO - Directory to install application into. [default: 04:53:30 INFO - "/builds/slave/test"] 04:53:30 INFO - --app=APP Application being installed. [default: firefox] 04:53:30 INFO - mkdir: /builds/slave/test/build/application 04:53:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:53:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:53:47 INFO - Reading from file tmpfile_stdout 04:53:47 INFO - Output received: 04:53:47 INFO - /builds/slave/test/build/application/firefox/firefox 04:53:47 INFO - Running post-action listener: _resource_record_post_action 04:53:47 INFO - [mozharness: 2017-02-01 12:53:47.180408Z] Finished install step (success) 04:53:47 INFO - [mozharness: 2017-02-01 12:53:47.180680Z] Running run-tests step. 04:53:47 INFO - Running pre-action listener: _resource_record_pre_action 04:53:47 INFO - Running main action method: run_tests 04:53:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:53:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:53:47 INFO - Python 2.7.3 04:53:47 INFO - Return code: 0 04:53:47 INFO - grabbing minidump binary from tooltool 04:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:47 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 0x1354850>, '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 0x12c96d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c9b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:53:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:53:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:53:47 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:53:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:53:47 INFO - Return code: 0 04:53:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:53:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:53:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:53:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:53:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:53:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VnnkjD7MTYqEJ8m5I6V2zg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:53:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VnnkjD7MTYqEJ8m5I6V2zg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:53:47 INFO - Using env: {'DISPLAY': ':0', 04:53:47 INFO - 'HOME': '/home/cltbld', 04:53:47 INFO - 'LANG': 'en_US.UTF-8', 04:53:47 INFO - 'LANGUAGE': 'en_US:en', 04:53:47 INFO - 'LOGNAME': 'cltbld', 04:53:47 INFO - 'MAIL': '/var/mail/cltbld', 04:53:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:53:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:47 INFO - 'MOZ_NO_REMOTE': '1', 04:53:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:53:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:47 INFO - 'NO_EM_RESTART': '1', 04:53:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:47 INFO - 'PWD': '/builds/slave/test', 04:53:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:53:47 INFO - 'SHELL': '/bin/bash', 04:53:47 INFO - 'SHLVL': '1', 04:53:47 INFO - 'TERM': 'linux', 04:53:47 INFO - 'TMOUT': '86400', 04:53:47 INFO - 'USER': 'cltbld', 04:53:47 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854', 04:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:47 INFO - '_': '/tools/buildbot/bin/python'} 04:53:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VnnkjD7MTYqEJ8m5I6V2zg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:53:47 INFO - mozversion application_buildid: 20170201121440 04:53:47 INFO - mozversion application_changeset: 9e7b1041929fccc06f6fad91cf66b9edcdfc0129 04:53:47 INFO - mozversion application_display_name: Nightly 04:53:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:53:47 INFO - mozversion application_name: Firefox 04:53:47 INFO - mozversion application_remotingname: firefox 04:53:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:53:47 INFO - mozversion application_vendor: Mozilla 04:53:47 INFO - mozversion application_version: 54.0a1 04:53:47 INFO - mozversion platform_buildid: 20170201121440 04:53:47 INFO - mozversion platform_changeset: 9e7b1041929fccc06f6fad91cf66b9edcdfc0129 04:53:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:53:47 INFO - mozversion platform_version: 54.0a1 04:53:47 INFO - using testdate: 1485953627 04:53:47 INFO - actual date: 1485953627 04:53:47 INFO - starting webserver on 'localhost:35450' 04:53:47 INFO - SUITE-START | Running 2 tests 04:53:47 INFO - TEST-START | dromaeo_css 04:53:47 INFO - operating with platform_type : linux_ 04:53:47 INFO - Initialising browser for dromaeo_css test... 04:53:47 INFO - TEST-INFO | started process 26128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA3cPxn/profile http://localhost:35450/getInfo.html) 04:53:51 INFO - PROCESS | 26128 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 04:53:51 INFO - PROCESS | 26128 | __metrics Screen width/height:1600/1200 04:53:51 INFO - PROCESS | 26128 | colorDepth:24 04:53:51 INFO - PROCESS | 26128 | Browser inner width/height: 1024/697 04:53:51 INFO - PROCESS | 26128 | __metrics 04:53:52 INFO - PROCESS | 26128 | 1485953632135 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 04:53:52 INFO - PROCESS | 26128 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:53:52 INFO - PROCESS | 26128 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:53:52 INFO - PROCESS | 26128 | console.error: PushService: 04:53:52 INFO - PROCESS | 26128 | stateChangeProcessEnqueue: Error transitioning state 04:53:52 INFO - PROCESS | 26128 | UnknownError 04:53:53 INFO - TEST-INFO | 26128: exit 0 04:53:53 INFO - Browser initialized. 04:53:53 INFO - Running cycle 1/1 for dromaeo_css test... 04:53:53 INFO - TEST-INFO | started process 26208 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA3cPxn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:54:05 INFO - PROCESS | 26208 | RSS: Main: 153501696 04:54:05 INFO - PROCESS | 26208 | 04:57:10 INFO - PROCESS | 26208 | Cycle 1(1): loaded http://localhost:35450/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35450/tests/dromaeo/cssquery-ext.html) 04:57:11 INFO - PROCESS | 26208 | RSS: Main: 266645504 04:57:11 INFO - PROCESS | 26208 | 04:58:55 INFO - PROCESS | 26208 | ************************* 04:58:55 INFO - PROCESS | 26208 | A coding exception was thrown and uncaught in a Task. 04:58:55 INFO - PROCESS | 26208 | 04:58:55 ERROR - PROCESS | 26208 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:58:55 INFO - PROCESS | 26208 | Full stack: 04:58:55 INFO - PROCESS | 26208 | ************************* 05:00:14 INFO - PROCESS | 26208 | Cycle 1(1): loaded http://localhost:35450/tests/dromaeo/cssquery-ext.html (next: http://localhost:35450/tests/dromaeo/cssquery-jquery.html) 05:00:15 INFO - PROCESS | 26208 | RSS: Main: 242868224 05:00:15 INFO - PROCESS | 26208 | 05:03:17 INFO - PROCESS | 26208 | Cycle 1(1): loaded http://localhost:35450/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35450/tests/dromaeo/cssquery-mootools.html) 05:03:18 INFO - PROCESS | 26208 | RSS: Main: 220901376 05:03:18 INFO - PROCESS | 26208 | 05:06:20 INFO - PROCESS | 26208 | Cycle 1(1): loaded http://localhost:35450/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35450/tests/dromaeo/cssquery-prototype.html) 05:06:21 INFO - PROCESS | 26208 | RSS: Main: 185286656 05:06:21 INFO - PROCESS | 26208 | 05:09:24 INFO - PROCESS | 26208 | Cycle 1(1): loaded http://localhost:35450/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35450/tests/dromaeo/cssquery-yui.html) 05:09:24 INFO - PROCESS | 26208 | RSS: Main: 192962560 05:09:24 INFO - PROCESS | 26208 | 05:12:27 INFO - PROCESS | 26208 | Cycle 1(1): loaded http://localhost:35450/tests/dromaeo/cssquery-yui.html (next: http://localhost:35450/tests/dromaeo/cssquery-dojo.html) 05:12:28 INFO - PROCESS | 26208 | RSS: Main: 283676672 05:12:28 INFO - PROCESS | 26208 | 05:12:28 INFO - PROCESS | 26208 | __start_tp_report 05:12:28 INFO - PROCESS | 26208 | _x_x_mozilla_page_load 05:12:28 INFO - PROCESS | 26208 | _x_x_mozilla_page_load_details 05:12:28 INFO - PROCESS | 26208 | |i|pagename|runs| 05:12:28 INFO - PROCESS | 26208 | |0;dojo.html;2514.3588384961836;2539.390546268896;2557.7058638256594;2568.1910198287537;2571.8585477798715;4467.151241264166;4529.207388706971;4549.181147393468;4566.109608626323;4582.0606775611;4500.842470513533;4551.499335073147;4561.6806823522365;4565.543445655433;4567.703099298543;4192.2663533881605;4244.087521182945;4275.230458517465;4276.72201306914;4290.120525292307;4193.853215137471;4285.142971405731;4303.440552728141;4303.870883873473;4345;4249.46881639795;4256.59562341577;4257.03130433055;4275.337322714969;4299.6775241856985;4090.570490098556;4096.508418989711;4204;4286.42133312002;4293.055527783882;4183.811728472196;4214.536400995888;4216.894577635553;4262.744235345889;4267.338562522814;4585.220512512881;4588.1511920294515;4588.541145885418;4611.953880461219;4640.466346370177;4793.544613261734;4840.298156767284;4896.338994235768;4923.18767403378;4932.53140951609;4821.397325334333;4823.03539292143;4855.053264613402;4856.660033797635;4897.265410188465;4548.204064288736;4549.954500454953;4551.431071116111;4562.452505699337;4591;4832.251001094836;4941.925871111936;4942.085714142895;4969.304297398367;4974.452810190876;4677.64917631179;4754.619630429557;4791.5687588117235;4801.01579176268;4856.587190088882;4875.07373599015;4888.877778055577;4891.608671306287;4893.975530122327;4936.777844996912;4728.739919304402;4747.382840230817;4858.271259311061;4859.562639362474;4868.756562171877;4815.783289751969;4845.176320025604;4875.756212189376;4884.1941079722155;4923.187674033744;4218.704690671685;4233.238017156941;4234.894127646772;4238.618524332825;4280.293751531025;3686.170611612419;3689.5756987946193;3706.7405281630026;3712.9071773205887;3713.0717320669833;4129.194807012664;4186.602272784081;4220.725652832556;4251.914961700749;4266.637335826489;4954.083494553519;4967.528084832007;4969.925451118236;4992.90014199714;5002.924956125661;4273.059926816096;4274.807633656431;4275.187714334266;4303.74177549348;4306.354046892929;4305.720128191658;4339.652827773771;4356.869293921251;4425.380446737459;4501.0547784964865;4487.259602165736;4526.343680166292;4530.977345113253;4566.54334566554;4571;4868.853934381833;4870.975645121894;4874.780634871368;4880.92678609814;4920.803167873245;4466.665000124939;4491.797869095833;4535.569120933506;4544.7045942013665;4566.45202575693;4797.880052998703;4823.204171311694;4830.903381932412;4849.393825771778;4872.6832755870755;4910.975445122752;4921.114199444134;4926.605871530341;4926.989967056817;4980.800767969241;4536.795844186953;4706.764661766966;4731.195696731495;4731.432228132646;4781.808727650994;4558.566936141061;4636.559526844944;4660.813567457264;4661.930071048869;4726.858194254178;4626.421697287839;4636.350910872413;4636.652251081115;4641.74470404131;4675.859724208279;4584.060267645192;4626.3523106764405;4641.698289611165;4710.128626204163;4713.175194341045;4626.1441633297945;4626.606738427271;4645.512221216859;4665.136949664323;4713.2223183175765 05:12:28 INFO - PROCESS | 26208 | |1;ext.html;548.7585462396545;568.4486048532924;571.2231365343134;582.1558739827249;605.1769593353042;29754.322111010006;39603.2079358413;41550.37674434878;41568.16863662725;45324.093518129615;40647.18705625893;41067.58932410675;41118.794406027926;41127;41151.38272925909;7818.257265559777;8002.19978002201;8006.119326874039;8013.2387423194705;8014.599270036504;7622.923770762304;7777.688892444296;10306;10465.005824446665;10471.16230701542;10377.740556486073;10441;10448.738781530446;10453.634122805703;10458.372497650127;10328.535215915303;10343.844842327371;10362.585496580128;10363;10441.164706823436;10226.130778883804;10299.845502317472;10334.586616535329;10335.069843714102;10339.483025848678;38469.807650961564;38776.612233877866;38795;38809.80595097006;38813.22373552541;3559.9110022249392;3641.289948460051;3665.5784584772828;3666.7066634669163;3668.156324045458;28984.840836277974;29031;29320.70679293201;29733.851330743208;30693.846530767205;3335.2495688470144;3414.7951122932704;3422.264213194175;3488.89533314001;3553.289342131584;246232;246683;246933;247451.9999999982;248358;47541.76229118832;47734.522654773005;47778.5222147781;47802;47849;58395;58716;58836.7058164715;58838.11742823861;58847.70576147178;13969.72060558783;14405.711885762226;14450.710985780226;14477;14500.564983050524;9133;10585.253433183438;10688.78622427547;10696.839547406795;10700.197485188486;14862.479813206486;16858.494245172664;17142.314307427565;17348.479545613653;17784.555386115193;6109.297430795426;6160.476359509402;6313.431791138728;6327.209098862642;6366.522510811707;806.1776987472745;822.7778499805139;823.8846561481397;831.8253166835033;839.886615306938;26258.343541411235;27686.225427382487;28019.15942521687;28204.294892627437;28398.43203135967;946.6544711180508;960.4728481714108;962.3552220012608;982.3025651787168;993.8211121997965;14753.557393278219;14772.92613536947;14947.850521494645;14996.47512337063;15118.773218401733;327984;329647;331709;331895;332463;49258.26112608314;49537.50462495329;49850.25224621633;49856.252156217684;50002;1149.6493569461227;1209.371127013948;1211.3095535544655;1218.530865616744;1220.7436438348047;25037;26254.868725656248;26818;27172;27424.17727468179;42440.787796060824;42763.35854962116;43006.78496607622;43009;43100.56899430966;265867;267166;268593;268677;268822;31149.844250778602;31628;35025.64974350224;35325;35327.470087949216;35476;41729.79135104305;41812.3728144072;41855.7907210462;41892.1621567573;35152;35171.648283516835;35458.645413545535;35531.64468355283;36050.09874753152;34586;34649.30701385908;34796.30407391889;35343.46984795179;35754.28491430209;34068.1482962918;34177.14557136092;34984.825075874454;35092.12269693278;35156.296874062886;28660;31313.530297046018;31319;31542.211444714067;31652.208694782814;23992.64011039801;23993;24039.51920961536;24157.879210603835;24336.391590210387 05:12:28 INFO - PROCESS | 26208 | |2;jquery.html;382.17122250694536;385.92088621832545;394.6960840153082;399.12591424779737;419.67055861148987;13772.380242889069;13973.371198296076;17016.4044258451;18731.71902421463;18741.62516749664;14505.274736263198;17406.738898916494;17498.475045748648;17782.555436114104;18758.155882985266;5242.8165014224505;5430.131179011359;5439.048166570854;5441.972790136044;5445.074337362638;5437.782488700447;5659.207710920475;5688.459596338341;5778.711064446782;5788.507976821975;3641.927161456769;3757.3236817373;5781.971090144564;6123.632582045091;6391.840203994914;6172.7530898764;6385.361463853624;6388;6394.8721025579225;6398.264199617034;5602.747876345574;5630.634008789457;5635.690037047961;5643.6049476536655;5646.661200327952;12329.568465103679;12464.439100240512;12554.74890502194;12720.173188742701;13004.154729942618;2381.0951838301335;2393.246127469841;2461.323136137559;2462.827602067856;2464.630305454178;9311.906880931172;9568.186704130158;10071;12049.228677404159;13301.600951971359;1732.4657698295462;1746.6419384026372;1749.6238308763677;1755.139981409113;1756.8770186086979;56865;65787.67106164439;79107;79848.60075699643;80527.19472805255;10525.526351314209;10636.840447393295;10677.9466102669;10898.073663738513;10967.945160274307;15162.3176957035;15196.620084497976;15222.238888055554;15241.314140863687;15255.08469491834;6787.117674702257;6914.135733033371;6967.895481567679;7171.748988785367;7228.530145540628;6318.905216421757;6342.23893132827;6541.149650545399;6559.868802623921;6567.967160164264;4554.795034223468;4595.747233902101;4605.631549476034;4674.672772905932;4707.458642256116;1870.532366908273;1881.9059047047592;1924.2303078768605;1966.5683382497348;1986.2154448992567;763.2596381509926;770.8805135204052;777.5490215674895;778.2528772378466;787.2835719495232;17390.786101674872;17500.21249043796;18334.174962126737;18653;18834.81165188358;751.1999720297865;771.4252881603242;793.095870707394;795.3994733975927;801.210807354755;9163.221126204347;9748.512574371252;9921.553530091163;10001.649612341094;10013.64952226683;345564;352229;524005;525543;553273;95262.5236873825;96422;99782.50108749555;101091;102117.48941255246;895.9776005599782;907.9636814527477;938.6996161228342;940.1397721085131;943.8301105801022;16214.51356459308;16665.833341666912;17009.91495042517;17074.2316595751;17412.564685882953;36100.916972490864;38403.807980959915;39150.6084939147;40226.79886600548;40647.39028914628;57278.7136064317;58348.70825645845;58615;58701;60318;6959.582425054513;8255.876161857697;8263.380246481418;8331;8420.536870472182;10768.784624307627;12515.56195533152;12544.623661290176;12625.87374126247;13042.347882606022;10617.89382106169;10706.839397408889;10775.892241077489;11209.495572699085;11214.383208923262;10368;11118.666440006813;11237.887621123684;11281.887181128084;11351.432428378383;10720.62477813304;10955.50700218508;11183.608573699881;11329.320240785579;11508.53965841357;7467.551946883204;7667.88498172539;7691.000169977867;7709.151993280847;7793.064832219943;8393.454425462325;10628.202884783826;10906.34561926287;10995.285306455055;11254.606088786853 05:12:28 INFO - PROCESS | 26208 | |3;mootools.html;1311.259138586699;1316.5326309160255;1318.8285522882024;1324.9801252981206;1332.8667133286672;6886.380225779679;7267.963660181705;7297.598632075234;7311.524750891195;7320.3777678897295;6407.807765767023;6619.271880093186;6898.310168983099;7042.788716338505;7191.784246472601;2064.917403303866;2094.790520947908;2096.9056392462376;2103.905324260404;2104.284543255293;2089.3066394076095;2147.162606583434;2159.75162856272;2159.7948194921537;2162.0486985726307;1820.3719716697717;1873.3068764557133;2025.311394125997;2086.123827992247;2090.341542414142;2076.885771282579;2080.9167633294574;2083.9270625528184;2085.5828834233216;2088.3839267416147;2002.209127394671;2012.4566367080952;2028.9695654565194;2031.6952457131401;2102.9158833646634;7216.314450127229;7253.274672532757;7282.162551306615;7288.9271107289305;7289.271072892721;4415.712978656377;4541.364209010741;4543.273076307775;4546.090781843644;4551.089782043571;2625.5930330798756;2717.9728202717915;2764.5714914188334;2768.3771151490955;2809.9297517562222;990.5344488090586;1020.4693559349171;1034.844773284006;1064.2443864855961;1080.573173596425;9755.02449755026;9755.853662195073;9783.951080244624;9801.509924503745;9809.411435313905;3903.1413089120347;4108.753474791522;4157.542670306264;4162.91674166515;4171.937420938689;8496.575171241537;8498.53258070812;8509.61706723199;8522.27560657351;8531.402801803813;4508.278675411918;4515.458145022619;4529.252673308867;4530.501644819067;4534.478534968455;3523.8590456381457;3608.783472991629;3893.2992061429213;4089.5501494835544;4195.559466256061;3462.186386199241;3465.5148279240925;3599.4060979938017;3602.1534939289245;3611.5124458197806;1161.5179700424399;1198.9460474278678;1201.7115892185811;1205.7528206717602;1217.0385395537426;845.6617353058703;853.300293759124;853.9658413663508;886.1050339157497;886.2821114896955;4890.095332363524;5010.774515146827;5016.197408414636;5070.645054846199;5093.159628661304;539.3931826694968;542.0811724127644;543.4456854008889;543.6248988198131;543.948324909133;3571.0715214044535;3678.4850120983083;3712.331780279522;3744;3862.594427585063;8467.40728149036;8582.356323275655;8726.956365218133;8883.73348799537;8884.422512536665;8684.826303473896;8689.869651955225;8690.78273043179;8698.695545655999;8701.17338852808;6655.966720166368;6746.932530674729;6820.420264277493;6824.078749368771;6870.896936545956;5192.065428222956;5223.92164117531;5274.4198138204;5291.3385826771655;5319.148936170194;7687.500312479671;7858.685652573833;7995.800104997422;8011.158828323175;8029.59852007409;7988;8096.83806323882;8108.580998325388;8151.673933042849;8156.877646835421;5650.717464126695;5798.333191682842;6189.669221117301;6304.968475157595;6314.242290925118;6738.528303018742;6939.653017349214;6967.477439191979;7072.752453664097;7079.787606371817;6176.722047507783;6271.153394291895;6313.873722525615;6349.365063493614;6417;6174.413430724074;6209.285932117684;6226.62640241587;6227.844303892439;6238.095476156022;5561.165825126263;5672.234248376416;5672.404397538364;5675.829725108253;5685.943140568541;4429.844955426544;4433.069055498252;4478.686491945533;4523.502414734311;4528.547145285445;4362.978185109054;4374.5625437456;4421.513633500376;4435.334699795057;4487.057717879282 05:12:28 INFO - PROCESS | 26208 | |4;prototype.html;348.67050637147895;350.4742885671493;360.17519879476004;362.6192497877228;367.6158414456892;4848.418189817226;4854.611631069515;4874.220124780036;4890.435060780552;4915.680480768752;4827.444843842959;4827.7792215580785;4842.782074806633;4862.173430516812;4894.8286809961655;3760.4171353440192;3800.8099595020276;3865.942010869839;3868.516435445569;3871.7676939383587;3861.162045896264;3871.341871881773;3887.9611203888026;3892.3188442022674;3893.805309734502;3830.9042273943096;3834.1373191031935;3850;3859.1702783901455;3866.8646597369097;3726.347889119407;3784.3188226119287;3793.4689143519654;3865.6714179294795;3901.200253947934;3454.7408944329277;3497.8775742849134;3503.4744788281705;3506.929861402783;3516.82415879205;4670.719756814602;4697.530246975275;4705.55297246761;4726.621870250372;4754.405699287589;4307.483102027777;4469.7541635210055;4476.485204201526;4482.327650852399;4483.130796290377;5051.469595692436;5065.746712664389;5094.566961808251;5105.489451054902;5105.897882042375;3845.288621605012;3860.1314704191614;3863.903402414934;3869.729118961674;3870.4000879863383;5026.874328141826;5245.685258884441;5298.576113910916;5303.151495760699;5314.787408503656;3924.9215015699524;3930.469386632768;3934.6458818706456;3936.2717897189114;3945.546262179886;3965.6232657897453;3981.422693709396;3984.4222587724616;4015.5181378234215;4050.7164498485413;4481.663875209372;4489.842855500042;4502.234620114588;4509.616682581952;4510.684252102321;5021.271915572222;5091.785073493043;5107.463716309809;5149.7940082397035;5173.430922598511;1310.6133690561308;1313.356455336878;1314.7304802515462;1325.734853029398;1328.4154971812372;916.3402350307767;964.7588102974256;973.9269554783419;979.7207795778169;988.5403287471361;4225.049363893161;4303.612674859278;4321.978390108029;4324.762138082373;4415.448068991376;5183.922241166386;5187.481251874782;5195.428502864682;5203.271541984125;5207.1668533034535;4372.759498227628;4381.21138195128;4399.38408622793;4421.535738747385;4421.801018954155;2583.5607946649116;2668.2795645175693;2679;2693.165118813135;2693.3670587411943;4699.835505757282;4745.810167593327;4755.429348478205;4762.738049407247;4763.95236047642;5170.327857378592;5172.508611681959;5186.377634683787;5218.739063046908;5224.555912747383;4482.394856790304;4591.449026116888;4658.417697787777;4671.696339737906;4698.859034228979;5050.368703912011;5053.469385714447;5060.544550990428;5073.441921388718;5079.466656001066;4950.653454258168;4966.453690094015;4982.427020892644;4985.604030871362;4992.775325110451;4503.932441013453;4673.556012178838;4674.813007479663;4675.649326300473;4686.27362758773;3834.309824231665;3835.36716441784;3838.213166300846;3847.460675953857;3850.903727406725;4976.751162441936;4998.375527953357;5043.319151914445;5045.268436076822;5045.621578381562;4560.92818187719;4739.052189562032;4803.943132510842;4842.927356089732;4855.781489832895;4784.354112194809;4794.328793968777;4794.9280760787915;4807.278908163804;4816.735079570657;4693.296005599187;4715.3869996900185;4741.383620129499;4749.9287510688055;4759.881002974953;4635.415124325039;4706.529347065266;4816.566509014206;4836.008618233324;4856.5871900887405;4713.340132381538;4738.786754596121;4748.525147485224;4748.952510474851;4751.550777013044 05:12:28 INFO - PROCESS | 26208 | |5;yui.html;656.3239862941173;677.6408503493147;719.7820770286125;753.8718417868963;766.3907193780946;12931.741365172691;13826.17042977422;13837.792433113485;13855.584332470016;13941.860581394183;12715.173513721602;12796.104272700915;12823.679408014805;12830.294333811637;12845.935770321135;651.7230177174705;658.6772481484062;772.9420293477983;779.1157036763286;780.0288640642408;794.6265255330014;802.3701394405393;802.4984384759525;803.9196080391972;804.5735760047185;853.8975322961253;858.9141085891392;859.3211363023204;859.6303589456531;859.6389516403126;687.9415249703782;692.7159864455549;832.9000519937586;849.379952634574;852.4885068958606;623.7286780250561;626.5332327416058;626.6334194496225;627.3882964110002;627.4071002902259;13570.525031623845;13645.931770341085;13650.112742671694;13666;13721.862781372158;12676.619701408881;12777.16948398351;12876.80684789729;12943.093983421164;13065.673358166026;11863.762724745457;11979.700507487296;12140.392980351035;12268.263904165779;12282.75434491314;4073.9592604074173;4081.9183616327805;4082.101937573729;4196.244675958326;4226.450561426995;64116.358836411506;64965.350346496874;65371.67314163399;65381;66119;10244.180465562886;10377.740556485996;10428.687139385831;10433.5826566938;11023.06303964172;19557.413277601696;19558.90220548888;19573.314933977526;19575.412737617895;19579.8042019578;6349.365063493614;6442.774502892376;6506.577072490273;6576.901346479806;6615.63614001225;3321.2693207494312;3435.9769937196425;3456.2914602506426;3526.5415495985358;3565.144365352297;2707.851068191229;2753.903613373522;2767.2805070681366;2769.9584506232422;2788.735070168331;461.28270539311694;462.11966204380707;468.650855112943;473.16722568280073;478.170374400415;547.8520799384144;561.8511094559944;568.6985897474345;569.6240481282334;572.9455701708331;7778.937537768549;7815.765527034198;7903.84192316162;8045.637946292314;8657.653693852175;489.37115806188876;490.07620635102376;513.1558586125876;603.5352778360725;611.5841227965027;4162.875113746592;4171.666266698657;4317.201317756225;4339.652827773771;4493.438320209973;48739;50298.21570519364;61486.077708834404;61935.38064619296;63940.36059639437;53329;54080.18879716808;55429;56052;56158.43841561614;48451;48824.75587622039;49206.261906071435;49981.75009125004;50117.49882501128;7901;8071.717489887826;8143.75568732939;8345.749627511184;8407.53758543286;34115.31769364549;34913.65086349104;34992;35140;35231;37704.622953770115;39720.205595888496;40977.1804563913;41558.58441415547;43160.568394315655;11314.60398886035;11367.261128026652;11644.301341919512;11970.162088653711;12014.159008869296;12534.937325313314;12955.805662914876;13296.601101966957;13321;13325.600231993056;12229.816552751538;12428.875711242772;12585.433655485342;12628.242305461701;12805.359732013549;12322.383880805744;12603.810942836048;12722.173058751152;12777.680557986125;13173.868261317264;11353.001626275736;11633;11798.351090690094;12228.205166664138;12301.507939682671;9813.411195328303;10153;10240.692779216635;10487.056164945192;10515.57937682484;8973.416727912665;9312.72061838146;10335.483225838527;10838.891611083789;10981.780364392827 05:12:28 INFO - PROCESS | 26208 | __end_tp_report 05:12:28 INFO - PROCESS | 26208 | __start_cc_report 05:12:28 INFO - PROCESS | 26208 | _x_x_mozilla_cycle_collect,1180 05:12:28 INFO - PROCESS | 26208 | __end_cc_report 05:12:28 INFO - PROCESS | 26208 | __startTimestamp1485954748023__endTimestamp 05:12:28 INFO - PROCESS | 26208 | 05:12:28 INFO - PROCESS | 26208 | ------- Summary: start ------- 05:12:28 INFO - PROCESS | 26208 | Number of tests: 6 05:12:28 INFO - PROCESS | 26208 | 05:12:28 INFO - PROCESS | 26208 | [#0] dojo.html Cycles:165 Average:4510.98 Median:4585.22 stddev:454.38 (9.9%) stddev-sans-first:427.93 05:12:28 INFO - PROCESS | 26208 | Values: 2514.4 2539.4 2557.7 2568.2 2571.9 4467.2 4529.2 4549.2 4566.1 4582.1 4500.8 4551.5 4561.7 4565.5 4567.7 4192.3 4244.1 4275.2 4276.7 4290.1 4193.9 4285.1 4303.4 4303.9 4345.0 4249.5 4256.6 4257.0 4275.3 4299.7 4090.6 4096.5 4204.0 4286.4 4293.1 4183.8 4214.5 4216.9 4262.7 4267.3 4585.2 4588.2 4588.5 4612.0 4640.5 4793.5 4840.3 4896.3 4923.2 4932.5 4821.4 4823.0 4855.1 4856.7 4897.3 4548.2 4550.0 4551.4 4562.5 4591.0 4832.3 4941.9 4942.1 4969.3 4974.5 4677.6 4754.6 4791.6 4801.0 4856.6 4875.1 4888.9 4891.6 4894.0 4936.8 4728.7 4747.4 4858.3 4859.6 4868.8 4815.8 4845.2 4875.8 4884.2 4923.2 4218.7 4233.2 4234.9 4238.6 4280.3 3686.2 3689.6 3706.7 3712.9 3713.1 4129.2 4186.6 4220.7 4251.9 4266.6 4954.1 4967.5 4969.9 4992.9 5002.9 4273.1 4274.8 4275.2 4303.7 4306.4 4305.7 4339.7 4356.9 4425.4 4501.1 4487.3 4526.3 4531.0 4566.5 4571.0 4868.9 4871.0 4874.8 4880.9 4920.8 4466.7 4491.8 4535.6 4544.7 4566.5 4797.9 4823.2 4830.9 4849.4 4872.7 4911.0 4921.1 4926.6 4927.0 4980.8 4536.8 4706.8 4731.2 4731.4 4781.8 4558.6 4636.6 4660.8 4661.9 4726.9 4626.4 4636.4 4636.7 4641.7 4675.9 4584.1 4626.4 4641.7 4710.1 4713.2 4626.1 4626.6 4645.5 4665.1 4713.2 05:12:28 INFO - PROCESS | 26208 | 05:12:28 INFO - PROCESS | 26208 | [#1] ext.html Cycles:180 Average:44556.96 Median:34617.65 stddev:74230.38 (214.4%) stddev-sans-first:74365.07 05:12:28 INFO - PROCESS | 26208 | Values: 548.8 568.4 571.2 582.2 605.2 29754.3 39603.2 41550.4 41568.2 45324.1 40647.2 41067.6 41118.8 41127.0 41151.4 7818.3 8002.2 8006.1 8013.2 8014.6 7622.9 7777.7 10306.0 10465.0 10471.2 10377.7 10441.0 10448.7 10453.6 10458.4 10328.5 10343.8 10362.6 10363.0 10441.2 10226.1 10299.8 10334.6 10335.1 10339.5 38469.8 38776.6 38795.0 38809.8 38813.2 3559.9 3641.3 3665.6 3666.7 3668.2 28984.8 29031.0 29320.7 29733.9 30693.8 3335.2 3414.8 3422.3 3488.9 3553.3 246232.0 246683.0 246933.0 247452.0 248358.0 47541.8 47734.5 47778.5 47802.0 47849.0 58395.0 58716.0 58836.7 58838.1 58847.7 13969.7 14405.7 14450.7 14477.0 14500.6 9133.0 10585.3 10688.8 10696.8 10700.2 14862.5 16858.5 17142.3 17348.5 17784.6 6109.3 6160.5 6313.4 6327.2 6366.5 806.2 822.8 823.9 831.8 839.9 26258.3 27686.2 28019.2 28204.3 28398.4 946.7 960.5 962.4 982.3 993.8 14753.6 14772.9 14947.9 14996.5 15118.8 327984.0 329647.0 331709.0 331895.0 332463.0 49258.3 49537.5 49850.3 49856.3 50002.0 1149.6 1209.4 1211.3 1218.5 1220.7 25037.0 26254.9 26818.0 27172.0 27424.2 42440.8 42763.4 43006.8 43009.0 43100.6 265867.0 267166.0 268593.0 268677.0 268822.0 31149.8 31628.0 35025.6 35325.0 35327.5 35476.0 41729.8 41812.4 41855.8 41892.2 35152.0 35171.6 35458.6 35531.6 36050.1 34586.0 34649.3 34796.3 35343.5 35754.3 34068.1 34177.1 34984.8 35092.1 35156.3 28660.0 31313.5 31319.0 31542.2 31652.2 23992.6 23993.0 24039.5 24157.9 24336.4 05:12:28 INFO - PROCESS | 26208 | 05:12:28 INFO - PROCESS | 26208 | [#2] jquery.html Cycles:180 Average:27326.28 Median:396.91 stddev:77716.96 (19580.4%) stddev-sans-first:77908.64 05:12:28 INFO - PROCESS | 26208 | Values: 382.2 385.9 394.7 399.1 419.7 13772.4 13973.4 17016.4 18731.7 18741.6 14505.3 17406.7 17498.5 17782.6 18758.2 5242.8 5430.1 5439.0 5442.0 5445.1 5437.8 5659.2 5688.5 5778.7 5788.5 3641.9 3757.3 5782.0 6123.6 6391.8 6172.8 6385.4 6388.0 6394.9 6398.3 5602.7 5630.6 5635.7 5643.6 5646.7 12329.6 12464.4 12554.7 12720.2 13004.2 2381.1 2393.2 2461.3 2462.8 2464.6 9311.9 9568.2 10071.0 12049.2 13301.6 1732.5 1746.6 1749.6 1755.1 1756.9 56865.0 65787.7 79107.0 79848.6 80527.2 10525.5 10636.8 10677.9 10898.1 10967.9 15162.3 15196.6 15222.2 15241.3 15255.1 6787.1 6914.1 6967.9 7171.7 7228.5 6318.9 6342.2 6541.1 6559.9 6568.0 4554.8 4595.7 4605.6 4674.7 4707.5 1870.5 1881.9 1924.2 1966.6 1986.2 763.3 770.9 777.5 778.3 787.3 17390.8 17500.2 18334.2 18653.0 18834.8 751.2 771.4 793.1 795.4 801.2 9163.2 9748.5 9921.6 10001.6 10013.6 345564.0 352229.0 524005.0 525543.0 553273.0 95262.5 96422.0 99782.5 101091.0 102117.5 896.0 908.0 938.7 940.1 943.8 16214.5 16665.8 17009.9 17074.2 17412.6 36100.9 38403.8 39150.6 40226.8 40647.4 57278.7 58348.7 58615.0 58701.0 60318.0 6959.6 8255.9 8263.4 8331.0 8420.5 10768.8 12515.6 12544.6 12625.9 13042.3 10617.9 10706.8 10775.9 11209.5 11214.4 10368.0 11118.7 11237.9 11281.9 11351.4 10720.6 10955.5 11183.6 11329.3 11508.5 7467.6 7667.9 7691.0 7709.2 7793.1 8393.5 10628.2 10906.3 10995.3 11254.6 05:12:28 INFO - PROCESS | 26208 | 05:12:28 INFO - PROCESS | 26208 | [#3] mootools.html Cycles:180 Average:4790.85 Median:5249.17 stddev:2591.77 (49.4%) stddev-sans-first:2585.84 05:12:28 INFO - PROCESS | 26208 | Values: 1311.3 1316.5 1318.8 1325.0 1332.9 6886.4 7268.0 7297.6 7311.5 7320.4 6407.8 6619.3 6898.3 7042.8 7191.8 2064.9 2094.8 2096.9 2103.9 2104.3 2089.3 2147.2 2159.8 2159.8 2162.0 1820.4 1873.3 2025.3 2086.1 2090.3 2076.9 2080.9 2083.9 2085.6 2088.4 2002.2 2012.5 2029.0 2031.7 2102.9 7216.3 7253.3 7282.2 7288.9 7289.3 4415.7 4541.4 4543.3 4546.1 4551.1 2625.6 2718.0 2764.6 2768.4 2809.9 990.5 1020.5 1034.8 1064.2 1080.6 9755.0 9755.9 9784.0 9801.5 9809.4 3903.1 4108.8 4157.5 4162.9 4171.9 8496.6 8498.5 8509.6 8522.3 8531.4 4508.3 4515.5 4529.3 4530.5 4534.5 3523.9 3608.8 3893.3 4089.6 4195.6 3462.2 3465.5 3599.4 3602.2 3611.5 1161.5 1198.9 1201.7 1205.8 1217.0 845.7 853.3 854.0 886.1 886.3 4890.1 5010.8 5016.2 5070.6 5093.2 539.4 542.1 543.4 543.6 543.9 3571.1 3678.5 3712.3 3744.0 3862.6 8467.4 8582.4 8727.0 8883.7 8884.4 8684.8 8689.9 8690.8 8698.7 8701.2 6656.0 6746.9 6820.4 6824.1 6870.9 5192.1 5223.9 5274.4 5291.3 5319.1 7687.5 7858.7 7995.8 8011.2 8029.6 7988.0 8096.8 8108.6 8151.7 8156.9 5650.7 5798.3 6189.7 6305.0 6314.2 6738.5 6939.7 6967.5 7072.8 7079.8 6176.7 6271.2 6313.9 6349.4 6417.0 6174.4 6209.3 6226.6 6227.8 6238.1 5561.2 5672.2 5672.4 5675.8 5685.9 4429.8 4433.1 4478.7 4523.5 4528.5 4363.0 4374.6 4421.5 4435.3 4487.1 05:12:28 INFO - PROCESS | 26208 | 05:12:28 INFO - PROCESS | 26208 | [#4] prototype.html Cycles:180 Average:4183.53 Median:4680.96 stddev:1152.93 (24.6%) stddev-sans-first:1119.66 05:12:28 INFO - PROCESS | 26208 | Values: 348.7 350.5 360.2 362.6 367.6 4848.4 4854.6 4874.2 4890.4 4915.7 4827.4 4827.8 4842.8 4862.2 4894.8 3760.4 3800.8 3865.9 3868.5 3871.8 3861.2 3871.3 3888.0 3892.3 3893.8 3830.9 3834.1 3850.0 3859.2 3866.9 3726.3 3784.3 3793.5 3865.7 3901.2 3454.7 3497.9 3503.5 3506.9 3516.8 4670.7 4697.5 4705.6 4726.6 4754.4 4307.5 4469.8 4476.5 4482.3 4483.1 5051.5 5065.7 5094.6 5105.5 5105.9 3845.3 3860.1 3863.9 3869.7 3870.4 5026.9 5245.7 5298.6 5303.2 5314.8 3924.9 3930.5 3934.6 3936.3 3945.5 3965.6 3981.4 3984.4 4015.5 4050.7 4481.7 4489.8 4502.2 4509.6 4510.7 5021.3 5091.8 5107.5 5149.8 5173.4 1310.6 1313.4 1314.7 1325.7 1328.4 916.3 964.8 973.9 979.7 988.5 4225.0 4303.6 4322.0 4324.8 4415.4 5183.9 5187.5 5195.4 5203.3 5207.2 4372.8 4381.2 4399.4 4421.5 4421.8 2583.6 2668.3 2679.0 2693.2 2693.4 4699.8 4745.8 4755.4 4762.7 4764.0 5170.3 5172.5 5186.4 5218.7 5224.6 4482.4 4591.4 4658.4 4671.7 4698.9 5050.4 5053.5 5060.5 5073.4 5079.5 4950.7 4966.5 4982.4 4985.6 4992.8 4503.9 4673.6 4674.8 4675.6 4686.3 3834.3 3835.4 3838.2 3847.5 3850.9 4976.8 4998.4 5043.3 5045.3 5045.6 4560.9 4739.1 4803.9 4842.9 4855.8 4784.4 4794.3 4794.9 4807.3 4816.7 4693.3 4715.4 4741.4 4749.9 4759.9 4635.4 4706.5 4816.6 4836.0 4856.6 4713.3 4738.8 4748.5 4749.0 4751.6 05:12:28 INFO - PROCESS | 26208 | 05:12:28 INFO - PROCESS | 26208 | [#5] yui.html Cycles:180 Average:14531.14 Median:4183.96 stddev:17410.54 (416.1%) stddev-sans-first:17428.21 05:12:28 INFO - PROCESS | 26208 | Values: 656.3 677.6 719.8 753.9 766.4 12931.7 13826.2 13837.8 13855.6 13941.9 12715.2 12796.1 12823.7 12830.3 12845.9 651.7 658.7 772.9 779.1 780.0 794.6 802.4 802.5 803.9 804.6 853.9 858.9 859.3 859.6 859.6 687.9 692.7 832.9 849.4 852.5 623.7 626.5 626.6 627.4 627.4 13570.5 13645.9 13650.1 13666.0 13721.9 12676.6 12777.2 12876.8 12943.1 13065.7 11863.8 11979.7 12140.4 12268.3 12282.8 4074.0 4081.9 4082.1 4196.2 4226.5 64116.4 64965.4 65371.7 65381.0 66119.0 10244.2 10377.7 10428.7 10433.6 11023.1 19557.4 19558.9 19573.3 19575.4 19579.8 6349.4 6442.8 6506.6 6576.9 6615.6 3321.3 3436.0 3456.3 3526.5 3565.1 2707.9 2753.9 2767.3 2770.0 2788.7 461.3 462.1 468.7 473.2 478.2 547.9 561.9 568.7 569.6 572.9 7778.9 7815.8 7903.8 8045.6 8657.7 489.4 490.1 513.2 603.5 611.6 4162.9 4171.7 4317.2 4339.7 4493.4 48739.0 50298.2 61486.1 61935.4 63940.4 53329.0 54080.2 55429.0 56052.0 56158.4 48451.0 48824.8 49206.3 49981.8 50117.5 7901.0 8071.7 8143.8 8345.7 8407.5 34115.3 34913.7 34992.0 35140.0 35231.0 37704.6 39720.2 40977.2 41558.6 43160.6 11314.6 11367.3 11644.3 11970.2 12014.2 12534.9 12955.8 13296.6 13321.0 13325.6 12229.8 12428.9 12585.4 12628.2 12805.4 12322.4 12603.8 12722.2 12777.7 13173.9 11353.0 11633.0 11798.4 12228.2 12301.5 9813.4 10153.0 10240.7 10487.1 10515.6 8973.4 9312.7 10335.5 10838.9 10981.8 05:12:28 INFO - PROCESS | 26208 | -------- Summary: end -------- 05:12:28 INFO - PROCESS | 26208 | 05:12:28 INFO - TEST-INFO | 26208: exit 0 05:12:28 INFO - TEST-OK | dromaeo_css | took 1121394ms 05:12:28 INFO - TEST-START | kraken 05:12:28 INFO - operating with platform_type : linux_ 05:12:28 INFO - Initialising browser for kraken test... 05:12:28 INFO - TEST-INFO | started process 26502 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyPo7VQ/profile http://localhost:35450/getInfo.html) 05:12:32 INFO - PROCESS | 26502 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 05:12:32 INFO - PROCESS | 26502 | __metrics Screen width/height:1600/1200 05:12:32 INFO - PROCESS | 26502 | colorDepth:24 05:12:32 INFO - PROCESS | 26502 | Browser inner width/height: 1024/697 05:12:32 INFO - PROCESS | 26502 | __metrics 05:12:33 INFO - PROCESS | 26502 | 1485954753477 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 05:12:33 INFO - PROCESS | 26502 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:12:33 INFO - PROCESS | 26502 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:12:34 INFO - PROCESS | 26502 | console.error: PushService: 05:12:34 INFO - PROCESS | 26502 | stateChangeProcessEnqueue: Error transitioning state 05:12:34 INFO - PROCESS | 26502 | UnknownError 05:12:34 INFO - TEST-INFO | 26502: exit 0 05:12:34 INFO - Browser initialized. 05:12:34 INFO - Running cycle 1/1 for kraken test... 05:12:34 INFO - TEST-INFO | started process 26584 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyPo7VQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:46 INFO - PROCESS | 26584 | RSS: Main: 153550848 05:12:46 INFO - PROCESS | 26584 | 05:12:49 INFO - PROCESS | 26584 | Cycle 1(1): loaded http://localhost:35450/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35450/tests/kraken/driver.html?testName=audio-beat-detection) 05:12:50 INFO - PROCESS | 26584 | RSS: Main: 208846848 05:12:50 INFO - PROCESS | 26584 | 05:12:53 INFO - PROCESS | 26584 | Cycle 1(1): loaded http://localhost:35450/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35450/tests/kraken/driver.html?testName=audio-dft) 05:12:53 INFO - PROCESS | 26584 | RSS: Main: 187838464 05:12:53 INFO - PROCESS | 26584 | 05:12:57 INFO - PROCESS | 26584 | Cycle 1(1): loaded http://localhost:35450/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35450/tests/kraken/driver.html?testName=audio-fft) 05:12:57 INFO - PROCESS | 26584 | RSS: Main: 270565376 05:12:57 INFO - PROCESS | 26584 | 05:12:59 INFO - PROCESS | 26584 | Cycle 1(1): loaded http://localhost:35450/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35450/tests/kraken/driver.html?testName=audio-oscillator) 05:13:00 INFO - PROCESS | 26584 | RSS: Main: 181669888 05:13:00 INFO - PROCESS | 26584 | 05:13:02 INFO - PROCESS | 26584 | Cycle 1(1): loaded http://localhost:35450/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35450/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:13:03 INFO - PROCESS | 26584 | RSS: Main: 184655872 05:13:03 INFO - PROCESS | 26584 | 05:13:06 INFO - PROCESS | 26584 | Cycle 1(1): loaded http://localhost:35450/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35450/tests/kraken/driver.html?testName=imaging-darkroom) 05:13:06 INFO - PROCESS | 26584 | RSS: Main: 224063488 05:13:06 INFO - PROCESS | 26584 | 05:13:10 INFO - PROCESS | 26584 | Cycle 1(1): loaded http://localhost:35450/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35450/tests/kraken/driver.html?testName=imaging-desaturate) 05:13:11 INFO - PROCESS | 26584 | RSS: Main: 218423296 05:13:11 INFO - PROCESS | 26584 | 05:13:13 INFO - PROCESS | 26584 | Cycle 1(1): loaded http://localhost:35450/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35450/tests/kraken/driver.html?testName=json-parse-financial) 05:13:14 INFO - PROCESS | 26584 | RSS: Main: 219463680 05:13:14 INFO - PROCESS | 26584 | 05:13:16 INFO - PROCESS | 26584 | Cycle 1(1): loaded http://localhost:35450/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35450/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:13:16 INFO - PROCESS | 26584 | RSS: Main: 182976512 05:13:16 INFO - PROCESS | 26584 | 05:13:18 INFO - PROCESS | 26584 | Cycle 1(1): loaded http://localhost:35450/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35450/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:13:19 INFO - PROCESS | 26584 | RSS: Main: 191086592 05:13:19 INFO - PROCESS | 26584 | 05:13:21 INFO - PROCESS | 26584 | Cycle 1(1): loaded http://localhost:35450/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35450/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:13:22 INFO - PROCESS | 26584 | RSS: Main: 199557120 05:13:22 INFO - PROCESS | 26584 | 05:13:24 INFO - PROCESS | 26584 | Cycle 1(1): loaded http://localhost:35450/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35450/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:13:25 INFO - PROCESS | 26584 | RSS: Main: 208928768 05:13:25 INFO - PROCESS | 26584 | 05:13:28 INFO - PROCESS | 26584 | Cycle 1(1): loaded http://localhost:35450/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35450/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:13:29 INFO - PROCESS | 26584 | RSS: Main: 205201408 05:13:29 INFO - PROCESS | 26584 | 05:13:31 INFO - PROCESS | 26584 | Cycle 1(1): loaded http://localhost:35450/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35450/tests/kraken/driver.html?testName=ai-astar) 05:13:31 INFO - PROCESS | 26584 | RSS: Main: 257257472 05:13:31 INFO - PROCESS | 26584 | 05:13:31 INFO - PROCESS | 26584 | __start_tp_report 05:13:31 INFO - PROCESS | 26584 | _x_x_mozilla_page_load 05:13:31 INFO - PROCESS | 26584 | _x_x_mozilla_page_load_details 05:13:31 INFO - PROCESS | 26584 | |i|pagename|runs| 05:13:31 INFO - PROCESS | 26584 | |0;ai-astar;108;115;116;117;115;115;116;116;114;116 05:13:31 INFO - PROCESS | 26584 | |1;audio-beat-detection;155;124;132;165;125;125;126;127;156;127 05:13:31 INFO - PROCESS | 26584 | |2;audio-dft;161;161;162;163;163;164;161;161;161;161 05:13:31 INFO - PROCESS | 26584 | |3;audio-fft;78;76;75;99;77;77;76;76;92;76 05:13:31 INFO - PROCESS | 26584 | |4;audio-oscillator;85;84;113;84;84;84;97;83;83;110 05:13:31 INFO - PROCESS | 26584 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 05:13:31 INFO - PROCESS | 26584 | |6;imaging-darkroom;149;149;148;149;149;149;148;148;149;149 05:13:31 INFO - PROCESS | 26584 | |7;imaging-desaturate;95;95;96;95;95;95;96;96;95;96 05:13:31 INFO - PROCESS | 26584 | |8;json-parse-financial;60;60;60;61;62;61;61;63;62;63 05:13:31 INFO - PROCESS | 26584 | |9;json-stringify-tinderbox;67;68;67;67;67;66;66;67;68;66 05:13:31 INFO - PROCESS | 26584 | |10;stanford-crypto-aes;85;93;84;84;84;93;85;87;84;90 05:13:31 INFO - PROCESS | 26584 | |11;stanford-crypto-ccm;134;147;132;141;129;142;146;142;183;141 05:13:31 INFO - PROCESS | 26584 | |12;stanford-crypto-pbkdf2;179;184;182;180;178;181;181;179;178;179 05:13:31 INFO - PROCESS | 26584 | |13;stanford-crypto-sha256-iterative;68;68;67;68;66;69;69;66;66;66 05:13:31 INFO - PROCESS | 26584 | __end_tp_report 05:13:31 INFO - PROCESS | 26584 | __start_cc_report 05:13:31 INFO - PROCESS | 26584 | _x_x_mozilla_cycle_collect,1873 05:13:31 INFO - PROCESS | 26584 | __end_cc_report 05:13:31 INFO - PROCESS | 26584 | __startTimestamp1485954811414__endTimestamp 05:13:31 INFO - PROCESS | 26584 | 05:13:31 INFO - PROCESS | 26584 | ------- Summary: start ------- 05:13:31 INFO - PROCESS | 26584 | Number of tests: 14 05:13:31 INFO - PROCESS | 26584 | 05:13:31 INFO - PROCESS | 26584 | [#0] ai-astar Cycles:10 Average:114.80 Median:116.00 stddev:2.53 (2.2%) stddev-sans-first:0.88 05:13:31 INFO - PROCESS | 26584 | Values: 108.0 115.0 116.0 117.0 115.0 115.0 116.0 116.0 114.0 116.0 05:13:31 INFO - PROCESS | 26584 | 05:13:31 INFO - PROCESS | 26584 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:129.50 stddev:15.87 (12.3%) stddev-sans-first:15.30 05:13:31 INFO - PROCESS | 26584 | Values: 155.0 124.0 132.0 165.0 125.0 125.0 126.0 127.0 156.0 127.0 05:13:31 INFO - PROCESS | 26584 | 05:13:31 INFO - PROCESS | 26584 | [#2] audio-dft Cycles:10 Average:161.80 Median:161.50 stddev:1.14 (0.7%) stddev-sans-first:1.17 05:13:31 INFO - PROCESS | 26584 | Values: 161.0 161.0 162.0 163.0 163.0 164.0 161.0 161.0 161.0 161.0 05:13:31 INFO - PROCESS | 26584 | 05:13:31 INFO - PROCESS | 26584 | [#3] audio-fft Cycles:10 Average:80.20 Median:77.00 stddev:8.27 (10.7%) stddev-sans-first:8.73 05:13:31 INFO - PROCESS | 26584 | Values: 78.0 76.0 75.0 99.0 77.0 77.0 76.0 76.0 92.0 76.0 05:13:31 INFO - PROCESS | 26584 | 05:13:31 INFO - PROCESS | 26584 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:84.00 stddev:11.74 (14.0%) stddev-sans-first:12.27 05:13:31 INFO - PROCESS | 26584 | Values: 85.0 84.0 113.0 84.0 84.0 84.0 97.0 83.0 83.0 110.0 05:13:31 INFO - PROCESS | 26584 | 05:13:31 INFO - PROCESS | 26584 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 05:13:31 INFO - PROCESS | 26584 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 05:13:31 INFO - PROCESS | 26584 | 05:13:31 INFO - PROCESS | 26584 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 05:13:31 INFO - PROCESS | 26584 | Values: 149.0 149.0 148.0 149.0 149.0 149.0 148.0 148.0 149.0 149.0 05:13:31 INFO - PROCESS | 26584 | 05:13:31 INFO - PROCESS | 26584 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:13:31 INFO - PROCESS | 26584 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 05:13:31 INFO - PROCESS | 26584 | 05:13:31 INFO - PROCESS | 26584 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:61.50 stddev:1.16 (1.9%) stddev-sans-first:1.13 05:13:31 INFO - PROCESS | 26584 | Values: 60.0 60.0 60.0 61.0 62.0 61.0 61.0 63.0 62.0 63.0 05:13:31 INFO - PROCESS | 26584 | 05:13:31 INFO - PROCESS | 26584 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 05:13:31 INFO - PROCESS | 26584 | Values: 67.0 68.0 67.0 67.0 67.0 66.0 66.0 67.0 68.0 66.0 05:13:31 INFO - PROCESS | 26584 | 05:13:31 INFO - PROCESS | 26584 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:86.00 stddev:3.73 (4.3%) stddev-sans-first:3.89 05:13:31 INFO - PROCESS | 26584 | Values: 85.0 93.0 84.0 84.0 84.0 93.0 85.0 87.0 84.0 90.0 05:13:31 INFO - PROCESS | 26584 | 05:13:31 INFO - PROCESS | 26584 | [#11] stanford-crypto-ccm Cycles:10 Average:143.70 Median:142.00 stddev:15.01 (10.6%) stddev-sans-first:15.51 05:13:31 INFO - PROCESS | 26584 | Values: 134.0 147.0 132.0 141.0 129.0 142.0 146.0 142.0 183.0 141.0 05:13:31 INFO - PROCESS | 26584 | 05:13:31 INFO - PROCESS | 26584 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.10 Median:180.50 stddev:1.91 (1.1%) stddev-sans-first:1.99 05:13:31 INFO - PROCESS | 26584 | Values: 179.0 184.0 182.0 180.0 178.0 181.0 181.0 179.0 178.0 179.0 05:13:31 INFO - PROCESS | 26584 | 05:13:31 INFO - PROCESS | 26584 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:1.25 (1.8%) stddev-sans-first:1.30 05:13:31 INFO - PROCESS | 26584 | Values: 68.0 68.0 67.0 68.0 66.0 69.0 69.0 66.0 66.0 66.0 05:13:31 INFO - PROCESS | 26584 | -------- Summary: end -------- 05:13:31 INFO - PROCESS | 26584 | 05:13:32 INFO - TEST-INFO | 26584: exit 0 05:13:32 INFO - TEST-OK | kraken | took 63757ms 05:13:32 INFO - SUITE-END | took 1185s 05:13:33 INFO - Completed test suite (00:19:45) 05:13:33 INFO - javascript benchmark 05:13:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6324.016812610504, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2514.3588384961836, 2539.390546268896, 2557.7058638256594, 2568.1910198287537, 2571.8585477798715, 4467.151241264166, 4529.207388706971, 4549.181147393468, 4566.109608626323, 4582.0606775611, 4500.842470513533, 4551.499335073147, 4561.6806823522365, 4565.543445655433, 4567.703099298543, 4192.2663533881605, 4244.087521182945, 4275.230458517465, 4276.72201306914, 4290.120525292307, 4193.853215137471, 4285.142971405731, 4303.440552728141, 4303.870883873473, 4345.0, 4249.46881639795, 4256.59562341577, 4257.03130433055, 4275.337322714969, 4299.6775241856985, 4090.570490098556, 4096.508418989711, 4204.0, 4286.42133312002, 4293.055527783882, 4183.811728472196, 4214.536400995888, 4216.894577635553, 4262.744235345889, 4267.338562522814, 4585.220512512881, 4588.1511920294515, 4588.541145885418, 4611.953880461219, 4640.466346370177, 4793.544613261734, 4840.298156767284, 4896.338994235768, 4923.18767403378, 4932.53140951609, 4821.397325334333, 4823.03539292143, 4855.053264613402, 4856.660033797635, 4897.265410188465, 4548.204064288736, 4549.954500454953, 4551.431071116111, 4562.452505699337, 4591.0, 4832.251001094836, 4941.925871111936, 4942.085714142895, 4969.304297398367, 4974.452810190876, 4677.64917631179, 4754.619630429557, 4791.5687588117235, 4801.01579176268, 4856.587190088882, 4875.07373599015, 4888.877778055577, 4891.608671306287, 4893.975530122327, 4936.777844996912, 4728.739919304402, 4747.382840230817, 4858.271259311061, 4859.562639362474, 4868.756562171877, 4815.783289751969, 4845.176320025604, 4875.756212189376, 4884.1941079722155, 4923.187674033744, 4218.704690671685, 4233.238017156941, 4234.894127646772, 4238.618524332825, 4280.293751531025, 3686.170611612419, 3689.5756987946193, 3706.7405281630026, 3712.9071773205887, 3713.0717320669833, 4129.194807012664, 4186.602272784081, 4220.725652832556, 4251.914961700749, 4266.637335826489, 4954.083494553519, 4967.528084832007, 4969.925451118236, 4992.90014199714, 5002.924956125661, 4273.059926816096, 4274.807633656431, 4275.187714334266, 4303.74177549348, 4306.354046892929, 4305.720128191658, 4339.652827773771, 4356.869293921251, 4425.380446737459, 4501.0547784964865, 4487.259602165736, 4526.343680166292, 4530.977345113253, 4566.54334566554, 4571.0, 4868.853934381833, 4870.975645121894, 4874.780634871368, 4880.92678609814, 4920.803167873245, 4466.665000124939, 4491.797869095833, 4535.569120933506, 4544.7045942013665, 4566.45202575693, 4797.880052998703, 4823.204171311694, 4830.903381932412, 4849.393825771778, 4872.6832755870755, 4910.975445122752, 4921.114199444134, 4926.605871530341, 4926.989967056817, 4980.800767969241, 4536.795844186953, 4706.764661766966, 4731.195696731495, 4731.432228132646, 4781.808727650994, 4558.566936141061, 4636.559526844944, 4660.813567457264, 4661.930071048869, 4726.858194254178, 4626.421697287839, 4636.350910872413, 4636.652251081115, 4641.74470404131, 4675.859724208279, 4584.060267645192, 4626.3523106764405, 4641.698289611165, 4710.128626204163, 4713.175194341045, 4626.1441633297945, 4626.606738427271, 4645.512221216859, 4665.136949664323, 4713.2223183175765], "value": 4482.785007057564, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.7585462396545, 568.4486048532924, 571.2231365343134, 582.1558739827249, 605.1769593353042, 29754.322111010006, 39603.2079358413, 41550.37674434878, 41568.16863662725, 45324.093518129615, 40647.18705625893, 41067.58932410675, 41118.794406027926, 41127.0, 41151.38272925909, 7818.257265559777, 8002.19978002201, 8006.119326874039, 8013.2387423194705, 8014.599270036504, 7622.923770762304, 7777.688892444296, 10306.0, 10465.005824446665, 10471.16230701542, 10377.740556486073, 10441.0, 10448.738781530446, 10453.634122805703, 10458.372497650127, 10328.535215915303, 10343.844842327371, 10362.585496580128, 10363.0, 10441.164706823436, 10226.130778883804, 10299.845502317472, 10334.586616535329, 10335.069843714102, 10339.483025848678, 38469.807650961564, 38776.612233877866, 38795.0, 38809.80595097006, 38813.22373552541, 3559.9110022249392, 3641.289948460051, 3665.5784584772828, 3666.7066634669163, 3668.156324045458, 28984.840836277974, 29031.0, 29320.70679293201, 29733.851330743208, 30693.846530767205, 3335.2495688470144, 3414.7951122932704, 3422.264213194175, 3488.89533314001, 3553.289342131584, 246232.0, 246683.0, 246933.0, 247451.9999999982, 248358.0, 47541.76229118832, 47734.522654773005, 47778.5222147781, 47802.0, 47849.0, 58395.0, 58716.0, 58836.7058164715, 58838.11742823861, 58847.70576147178, 13969.72060558783, 14405.711885762226, 14450.710985780226, 14477.0, 14500.564983050524, 9133.0, 10585.253433183438, 10688.78622427547, 10696.839547406795, 10700.197485188486, 14862.479813206486, 16858.494245172664, 17142.314307427565, 17348.479545613653, 17784.555386115193, 6109.297430795426, 6160.476359509402, 6313.431791138728, 6327.209098862642, 6366.522510811707, 806.1776987472745, 822.7778499805139, 823.8846561481397, 831.8253166835033, 839.886615306938, 26258.343541411235, 27686.225427382487, 28019.15942521687, 28204.294892627437, 28398.43203135967, 946.6544711180508, 960.4728481714108, 962.3552220012608, 982.3025651787168, 993.8211121997965, 14753.557393278219, 14772.92613536947, 14947.850521494645, 14996.47512337063, 15118.773218401733, 327984.0, 329647.0, 331709.0, 331895.0, 332463.0, 49258.26112608314, 49537.50462495329, 49850.25224621633, 49856.252156217684, 50002.0, 1149.6493569461227, 1209.371127013948, 1211.3095535544655, 1218.530865616744, 1220.7436438348047, 25037.0, 26254.868725656248, 26818.0, 27172.0, 27424.17727468179, 42440.787796060824, 42763.35854962116, 43006.78496607622, 43009.0, 43100.56899430966, 265867.0, 267166.0, 268593.0, 268677.0, 268822.0, 31149.844250778602, 31628.0, 35025.64974350224, 35325.0, 35327.470087949216, 35476.0, 41729.79135104305, 41812.3728144072, 41855.7907210462, 41892.1621567573, 35152.0, 35171.648283516835, 35458.645413545535, 35531.64468355283, 36050.09874753152, 34586.0, 34649.30701385908, 34796.30407391889, 35343.46984795179, 35754.28491430209, 34068.1482962918, 34177.14557136092, 34984.825075874454, 35092.12269693278, 35156.296874062886, 28660.0, 31313.530297046018, 31319.0, 31542.211444714067, 31652.208694782814, 23992.64011039801, 23993.0, 24039.51920961536, 24157.879210603835, 24336.391590210387], "value": 17809.229816617335, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.17122250694536, 385.92088621832545, 394.6960840153082, 399.12591424779737, 419.67055861148987, 13772.380242889069, 13973.371198296076, 17016.4044258451, 18731.71902421463, 18741.62516749664, 14505.274736263198, 17406.738898916494, 17498.475045748648, 17782.555436114104, 18758.155882985266, 5242.8165014224505, 5430.131179011359, 5439.048166570854, 5441.972790136044, 5445.074337362638, 5437.782488700447, 5659.207710920475, 5688.459596338341, 5778.711064446782, 5788.507976821975, 3641.927161456769, 3757.3236817373, 5781.971090144564, 6123.632582045091, 6391.840203994914, 6172.7530898764, 6385.361463853624, 6388.0, 6394.8721025579225, 6398.264199617034, 5602.747876345574, 5630.634008789457, 5635.690037047961, 5643.6049476536655, 5646.661200327952, 12329.568465103679, 12464.439100240512, 12554.74890502194, 12720.173188742701, 13004.154729942618, 2381.0951838301335, 2393.246127469841, 2461.323136137559, 2462.827602067856, 2464.630305454178, 9311.906880931172, 9568.186704130158, 10071.0, 12049.228677404159, 13301.600951971359, 1732.4657698295462, 1746.6419384026372, 1749.6238308763677, 1755.139981409113, 1756.8770186086979, 56865.0, 65787.67106164439, 79107.0, 79848.60075699643, 80527.19472805255, 10525.526351314209, 10636.840447393295, 10677.9466102669, 10898.073663738513, 10967.945160274307, 15162.3176957035, 15196.620084497976, 15222.238888055554, 15241.314140863687, 15255.08469491834, 6787.117674702257, 6914.135733033371, 6967.895481567679, 7171.748988785367, 7228.530145540628, 6318.905216421757, 6342.23893132827, 6541.149650545399, 6559.868802623921, 6567.967160164264, 4554.795034223468, 4595.747233902101, 4605.631549476034, 4674.672772905932, 4707.458642256116, 1870.532366908273, 1881.9059047047592, 1924.2303078768605, 1966.5683382497348, 1986.2154448992567, 763.2596381509926, 770.8805135204052, 777.5490215674895, 778.2528772378466, 787.2835719495232, 17390.786101674872, 17500.21249043796, 18334.174962126737, 18653.0, 18834.81165188358, 751.1999720297865, 771.4252881603242, 793.095870707394, 795.3994733975927, 801.210807354755, 9163.221126204347, 9748.512574371252, 9921.553530091163, 10001.649612341094, 10013.64952226683, 345564.0, 352229.0, 524005.0, 525543.0, 553273.0, 95262.5236873825, 96422.0, 99782.50108749555, 101091.0, 102117.48941255246, 895.9776005599782, 907.9636814527477, 938.6996161228342, 940.1397721085131, 943.8301105801022, 16214.51356459308, 16665.833341666912, 17009.91495042517, 17074.2316595751, 17412.564685882953, 36100.916972490864, 38403.807980959915, 39150.6084939147, 40226.79886600548, 40647.39028914628, 57278.7136064317, 58348.70825645845, 58615.0, 58701.0, 60318.0, 6959.582425054513, 8255.876161857697, 8263.380246481418, 8331.0, 8420.536870472182, 10768.784624307627, 12515.56195533152, 12544.623661290176, 12625.87374126247, 13042.347882606022, 10617.89382106169, 10706.839397408889, 10775.892241077489, 11209.495572699085, 11214.383208923262, 10368.0, 11118.666440006813, 11237.887621123684, 11281.887181128084, 11351.432428378383, 10720.62477813304, 10955.50700218508, 11183.608573699881, 11329.320240785579, 11508.53965841357, 7467.551946883204, 7667.88498172539, 7691.000169977867, 7709.151993280847, 7793.064832219943, 8393.454425462325, 10628.202884783826, 10906.34561926287, 10995.285306455055, 11254.606088786853], "value": 8531.245284119737, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1311.259138586699, 1316.5326309160255, 1318.8285522882024, 1324.9801252981206, 1332.8667133286672, 6886.380225779679, 7267.963660181705, 7297.598632075234, 7311.524750891195, 7320.3777678897295, 6407.807765767023, 6619.271880093186, 6898.310168983099, 7042.788716338505, 7191.784246472601, 2064.917403303866, 2094.790520947908, 2096.9056392462376, 2103.905324260404, 2104.284543255293, 2089.3066394076095, 2147.162606583434, 2159.75162856272, 2159.7948194921537, 2162.0486985726307, 1820.3719716697717, 1873.3068764557133, 2025.311394125997, 2086.123827992247, 2090.341542414142, 2076.885771282579, 2080.9167633294574, 2083.9270625528184, 2085.5828834233216, 2088.3839267416147, 2002.209127394671, 2012.4566367080952, 2028.9695654565194, 2031.6952457131401, 2102.9158833646634, 7216.314450127229, 7253.274672532757, 7282.162551306615, 7288.9271107289305, 7289.271072892721, 4415.712978656377, 4541.364209010741, 4543.273076307775, 4546.090781843644, 4551.089782043571, 2625.5930330798756, 2717.9728202717915, 2764.5714914188334, 2768.3771151490955, 2809.9297517562222, 990.5344488090586, 1020.4693559349171, 1034.844773284006, 1064.2443864855961, 1080.573173596425, 9755.02449755026, 9755.853662195073, 9783.951080244624, 9801.509924503745, 9809.411435313905, 3903.1413089120347, 4108.753474791522, 4157.542670306264, 4162.91674166515, 4171.937420938689, 8496.575171241537, 8498.53258070812, 8509.61706723199, 8522.27560657351, 8531.402801803813, 4508.278675411918, 4515.458145022619, 4529.252673308867, 4530.501644819067, 4534.478534968455, 3523.8590456381457, 3608.783472991629, 3893.2992061429213, 4089.5501494835544, 4195.559466256061, 3462.186386199241, 3465.5148279240925, 3599.4060979938017, 3602.1534939289245, 3611.5124458197806, 1161.5179700424399, 1198.9460474278678, 1201.7115892185811, 1205.7528206717602, 1217.0385395537426, 845.6617353058703, 853.300293759124, 853.9658413663508, 886.1050339157497, 886.2821114896955, 4890.095332363524, 5010.774515146827, 5016.197408414636, 5070.645054846199, 5093.159628661304, 539.3931826694968, 542.0811724127644, 543.4456854008889, 543.6248988198131, 543.948324909133, 3571.0715214044535, 3678.4850120983083, 3712.331780279522, 3744.0, 3862.594427585063, 8467.40728149036, 8582.356323275655, 8726.956365218133, 8883.73348799537, 8884.422512536665, 8684.826303473896, 8689.869651955225, 8690.78273043179, 8698.695545655999, 8701.17338852808, 6655.966720166368, 6746.932530674729, 6820.420264277493, 6824.078749368771, 6870.896936545956, 5192.065428222956, 5223.92164117531, 5274.4198138204, 5291.3385826771655, 5319.148936170194, 7687.500312479671, 7858.685652573833, 7995.800104997422, 8011.158828323175, 8029.59852007409, 7988.0, 8096.83806323882, 8108.580998325388, 8151.673933042849, 8156.877646835421, 5650.717464126695, 5798.333191682842, 6189.669221117301, 6304.968475157595, 6314.242290925118, 6738.528303018742, 6939.653017349214, 6967.477439191979, 7072.752453664097, 7079.787606371817, 6176.722047507783, 6271.153394291895, 6313.873722525615, 6349.365063493614, 6417.0, 6174.413430724074, 6209.285932117684, 6226.62640241587, 6227.844303892439, 6238.095476156022, 5561.165825126263, 5672.234248376416, 5672.404397538364, 5675.829725108253, 5685.943140568541, 4429.844955426544, 4433.069055498252, 4478.686491945533, 4523.502414734311, 4528.547145285445, 4362.978185109054, 4374.5625437456, 4421.513633500376, 4435.334699795057, 4487.057717879282], "value": 3883.282129526426, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.67050637147895, 350.4742885671493, 360.17519879476004, 362.6192497877228, 367.6158414456892, 4848.418189817226, 4854.611631069515, 4874.220124780036, 4890.435060780552, 4915.680480768752, 4827.444843842959, 4827.7792215580785, 4842.782074806633, 4862.173430516812, 4894.8286809961655, 3760.4171353440192, 3800.8099595020276, 3865.942010869839, 3868.516435445569, 3871.7676939383587, 3861.162045896264, 3871.341871881773, 3887.9611203888026, 3892.3188442022674, 3893.805309734502, 3830.9042273943096, 3834.1373191031935, 3850.0, 3859.1702783901455, 3866.8646597369097, 3726.347889119407, 3784.3188226119287, 3793.4689143519654, 3865.6714179294795, 3901.200253947934, 3454.7408944329277, 3497.8775742849134, 3503.4744788281705, 3506.929861402783, 3516.82415879205, 4670.719756814602, 4697.530246975275, 4705.55297246761, 4726.621870250372, 4754.405699287589, 4307.483102027777, 4469.7541635210055, 4476.485204201526, 4482.327650852399, 4483.130796290377, 5051.469595692436, 5065.746712664389, 5094.566961808251, 5105.489451054902, 5105.897882042375, 3845.288621605012, 3860.1314704191614, 3863.903402414934, 3869.729118961674, 3870.4000879863383, 5026.874328141826, 5245.685258884441, 5298.576113910916, 5303.151495760699, 5314.787408503656, 3924.9215015699524, 3930.469386632768, 3934.6458818706456, 3936.2717897189114, 3945.546262179886, 3965.6232657897453, 3981.422693709396, 3984.4222587724616, 4015.5181378234215, 4050.7164498485413, 4481.663875209372, 4489.842855500042, 4502.234620114588, 4509.616682581952, 4510.684252102321, 5021.271915572222, 5091.785073493043, 5107.463716309809, 5149.7940082397035, 5173.430922598511, 1310.6133690561308, 1313.356455336878, 1314.7304802515462, 1325.734853029398, 1328.4154971812372, 916.3402350307767, 964.7588102974256, 973.9269554783419, 979.7207795778169, 988.5403287471361, 4225.049363893161, 4303.612674859278, 4321.978390108029, 4324.762138082373, 4415.448068991376, 5183.922241166386, 5187.481251874782, 5195.428502864682, 5203.271541984125, 5207.1668533034535, 4372.759498227628, 4381.21138195128, 4399.38408622793, 4421.535738747385, 4421.801018954155, 2583.5607946649116, 2668.2795645175693, 2679.0, 2693.165118813135, 2693.3670587411943, 4699.835505757282, 4745.810167593327, 4755.429348478205, 4762.738049407247, 4763.95236047642, 5170.327857378592, 5172.508611681959, 5186.377634683787, 5218.739063046908, 5224.555912747383, 4482.394856790304, 4591.449026116888, 4658.417697787777, 4671.696339737906, 4698.859034228979, 5050.368703912011, 5053.469385714447, 5060.544550990428, 5073.441921388718, 5079.466656001066, 4950.653454258168, 4966.453690094015, 4982.427020892644, 4985.604030871362, 4992.775325110451, 4503.932441013453, 4673.556012178838, 4674.813007479663, 4675.649326300473, 4686.27362758773, 3834.309824231665, 3835.36716441784, 3838.213166300846, 3847.460675953857, 3850.903727406725, 4976.751162441936, 4998.375527953357, 5043.319151914445, 5045.268436076822, 5045.621578381562, 4560.92818187719, 4739.052189562032, 4803.943132510842, 4842.927356089732, 4855.781489832895, 4784.354112194809, 4794.328793968777, 4794.9280760787915, 4807.278908163804, 4816.735079570657, 4693.296005599187, 4715.3869996900185, 4741.383620129499, 4749.9287510688055, 4759.881002974953, 4635.415124325039, 4706.529347065266, 4816.566509014206, 4836.008618233324, 4856.5871900887405, 4713.340132381538, 4738.786754596121, 4748.525147485224, 4748.952510474851, 4751.550777013044], "value": 3837.44011845306, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.3239862941173, 677.6408503493147, 719.7820770286125, 753.8718417868963, 766.3907193780946, 12931.741365172691, 13826.17042977422, 13837.792433113485, 13855.584332470016, 13941.860581394183, 12715.173513721602, 12796.104272700915, 12823.679408014805, 12830.294333811637, 12845.935770321135, 651.7230177174705, 658.6772481484062, 772.9420293477983, 779.1157036763286, 780.0288640642408, 794.6265255330014, 802.3701394405393, 802.4984384759525, 803.9196080391972, 804.5735760047185, 853.8975322961253, 858.9141085891392, 859.3211363023204, 859.6303589456531, 859.6389516403126, 687.9415249703782, 692.7159864455549, 832.9000519937586, 849.379952634574, 852.4885068958606, 623.7286780250561, 626.5332327416058, 626.6334194496225, 627.3882964110002, 627.4071002902259, 13570.525031623845, 13645.931770341085, 13650.112742671694, 13666.0, 13721.862781372158, 12676.619701408881, 12777.16948398351, 12876.80684789729, 12943.093983421164, 13065.673358166026, 11863.762724745457, 11979.700507487296, 12140.392980351035, 12268.263904165779, 12282.75434491314, 4073.9592604074173, 4081.9183616327805, 4082.101937573729, 4196.244675958326, 4226.450561426995, 64116.358836411506, 64965.350346496874, 65371.67314163399, 65381.0, 66119.0, 10244.180465562886, 10377.740556485996, 10428.687139385831, 10433.5826566938, 11023.06303964172, 19557.413277601696, 19558.90220548888, 19573.314933977526, 19575.412737617895, 19579.8042019578, 6349.365063493614, 6442.774502892376, 6506.577072490273, 6576.901346479806, 6615.63614001225, 3321.2693207494312, 3435.9769937196425, 3456.2914602506426, 3526.5415495985358, 3565.144365352297, 2707.851068191229, 2753.903613373522, 2767.2805070681366, 2769.9584506232422, 2788.735070168331, 461.28270539311694, 462.11966204380707, 468.650855112943, 473.16722568280073, 478.170374400415, 547.8520799384144, 561.8511094559944, 568.6985897474345, 569.6240481282334, 572.9455701708331, 7778.937537768549, 7815.765527034198, 7903.84192316162, 8045.637946292314, 8657.653693852175, 489.37115806188876, 490.07620635102376, 513.1558586125876, 603.5352778360725, 611.5841227965027, 4162.875113746592, 4171.666266698657, 4317.201317756225, 4339.652827773771, 4493.438320209973, 48739.0, 50298.21570519364, 61486.077708834404, 61935.38064619296, 63940.36059639437, 53329.0, 54080.18879716808, 55429.0, 56052.0, 56158.43841561614, 48451.0, 48824.75587622039, 49206.261906071435, 49981.75009125004, 50117.49882501128, 7901.0, 8071.717489887826, 8143.75568732939, 8345.749627511184, 8407.53758543286, 34115.31769364549, 34913.65086349104, 34992.0, 35140.0, 35231.0, 37704.622953770115, 39720.205595888496, 40977.1804563913, 41558.58441415547, 43160.568394315655, 11314.60398886035, 11367.261128026652, 11644.301341919512, 11970.162088653711, 12014.159008869296, 12534.937325313314, 12955.805662914876, 13296.601101966957, 13321.0, 13325.600231993056, 12229.816552751538, 12428.875711242772, 12585.433655485342, 12628.242305461701, 12805.359732013549, 12322.383880805744, 12603.810942836048, 12722.173058751152, 12777.680557986125, 13173.868261317264, 11353.001626275736, 11633.0, 11798.351090690094, 12228.205166664138, 12301.507939682671, 9813.411195328303, 10153.0, 10240.692779216635, 10487.056164945192, 10515.57937682484, 8973.416727912665, 9312.72061838146, 10335.483225838527, 10838.891611083789, 10981.780364392827], "value": 6301.704313810756, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 115.0, 116.0, 117.0, 115.0, 115.0, 116.0, 116.0, 114.0, 116.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 132.0, 165.0, 125.0, 125.0, 126.0, 127.0, 156.0, 127.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 163.0, 163.0, 164.0, 161.0, 161.0, 161.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 75.0, 99.0, 77.0, 77.0, 76.0, 76.0, 92.0, 76.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 113.0, 84.0, 84.0, 84.0, 97.0, 83.0, 83.0, 110.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 149.0, 149.0, 149.0, 148.0, 148.0, 149.0, 149.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 61.0, 62.0, 61.0, 61.0, 63.0, 62.0, 63.0], "value": 61.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 66.0, 66.0, 67.0, 68.0, 66.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 93.0, 84.0, 84.0, 84.0, 93.0, 85.0, 87.0, 84.0, 90.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 147.0, 132.0, 141.0, 129.0, 142.0, 146.0, 142.0, 183.0, 141.0], "value": 143.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 184.0, 182.0, 180.0, 178.0, 181.0, 181.0, 179.0, 178.0, 179.0], "value": 180.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 68.0, 66.0, 69.0, 69.0, 66.0, 66.0, 66.0], "value": 67.3, "unit": "score"}]}]} 05:13:33 INFO - Return code: 0 05:13:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:13:33 ERROR - # TBPL SUCCESS # 05:13:33 INFO - Running post-action listener: _resource_record_post_action 05:13:33 INFO - [mozharness: 2017-02-01 13:13:33.212778Z] Finished run-tests step (success) 05:13:33 INFO - Running post-run listener: _resource_record_post_run 05:13:33 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 0; Write bytes: 383926272; Read time: 0; Write time: 271352 05:13:33 INFO - TinderboxPrint: CPU usage
13.1% 05:13:33 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:13:33 INFO - TinderboxPrint: I/O write bytes / time
383,926,272 / 271,352 05:13:33 INFO - TinderboxPrint: CPU idle
8,335.1 (86.9%) 05:13:33 INFO - TinderboxPrint: CPU user
1,214.7 (12.7%) 05:13:33 INFO - TinderboxPrint: Swap in / out
0 / 0 05:13:33 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 100139008; Read time: 0; Write time: 76728 05:13:33 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 283787264; Read time: 0; Write time: 194624 05:13:33 INFO - Running post-run listener: _upload_blobber_files 05:13:33 INFO - Blob upload gear active. 05:13:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:13:33 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 05:13:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:13:34 INFO - (blobuploader) - INFO - Open directory for files ... 05:13:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:13:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:13:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:42 INFO - (blobuploader) - INFO - Done attempting. 05:13:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:13:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:13:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:43 INFO - (blobuploader) - INFO - Done attempting. 05:13:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:13:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:13:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:44 INFO - (blobuploader) - INFO - Done attempting. 05:13:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:13:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:13:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:44 INFO - (blobuploader) - INFO - Done attempting. 05:13:44 INFO - (blobuploader) - INFO - Iteration through files over. 05:13:44 INFO - Return code: 0 05:13:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:13:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:13:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a27f775765eb264336a8056a0f50271f26fb66d3ad14dd7ed49914312b11eb3b0524c718d388c90859bb5969d32af1dccdb5d0046f475cccfa3840de79e30331", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e8f7530ddb64b969e9fe5a5765201289b0ec4f7dea2b1d3ca009cec05e19c9464d1824a992bb3a7c41ca5de35327b5936e2fd8a2db62a4a90ebeb9a7ffabade", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/89a11fc3a7fdf86cc93594a6760cb0f779e59eac576bf400bbcf7b18652398bb76aa8b8502c8b505aea417e6744970799620cf304c14986a5b47e97d30321425", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/feacba1be193e2af89395007bc3e3ae284444eec9a207f73653672e1f4278ca080ad12e480fc994e2d422de05b2a461889db11002bb1dc9b945d23fdc408d471"} 05:13:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:13:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:13:44 INFO - Contents: 05:13:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a27f775765eb264336a8056a0f50271f26fb66d3ad14dd7ed49914312b11eb3b0524c718d388c90859bb5969d32af1dccdb5d0046f475cccfa3840de79e30331", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e8f7530ddb64b969e9fe5a5765201289b0ec4f7dea2b1d3ca009cec05e19c9464d1824a992bb3a7c41ca5de35327b5936e2fd8a2db62a4a90ebeb9a7ffabade", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/89a11fc3a7fdf86cc93594a6760cb0f779e59eac576bf400bbcf7b18652398bb76aa8b8502c8b505aea417e6744970799620cf304c14986a5b47e97d30321425", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/feacba1be193e2af89395007bc3e3ae284444eec9a207f73653672e1f4278ca080ad12e480fc994e2d422de05b2a461889db11002bb1dc9b945d23fdc408d471"} 05:13:44 INFO - Running post-run listener: copy_logs_to_upload_dir 05:13:44 INFO - Copying logs to upload dir... 05:13:44 INFO - mkdir: /builds/slave/test/build/upload/logs 05:13:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.579492 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-02-01 05:13:44.854353) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-01 05:13:44.859969) ========= 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=3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a27f775765eb264336a8056a0f50271f26fb66d3ad14dd7ed49914312b11eb3b0524c718d388c90859bb5969d32af1dccdb5d0046f475cccfa3840de79e30331", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e8f7530ddb64b969e9fe5a5765201289b0ec4f7dea2b1d3ca009cec05e19c9464d1824a992bb3a7c41ca5de35327b5936e2fd8a2db62a4a90ebeb9a7ffabade", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/89a11fc3a7fdf86cc93594a6760cb0f779e59eac576bf400bbcf7b18652398bb76aa8b8502c8b505aea417e6744970799620cf304c14986a5b47e97d30321425", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/feacba1be193e2af89395007bc3e3ae284444eec9a207f73653672e1f4278ca080ad12e480fc994e2d422de05b2a461889db11002bb1dc9b945d23fdc408d471"} build_url:https://queue.taskcluster.net/v1/task/VnnkjD7MTYqEJ8m5I6V2zg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011451 build_url: 'https://queue.taskcluster.net/v1/task/VnnkjD7MTYqEJ8m5I6V2zg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a27f775765eb264336a8056a0f50271f26fb66d3ad14dd7ed49914312b11eb3b0524c718d388c90859bb5969d32af1dccdb5d0046f475cccfa3840de79e30331", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e8f7530ddb64b969e9fe5a5765201289b0ec4f7dea2b1d3ca009cec05e19c9464d1824a992bb3a7c41ca5de35327b5936e2fd8a2db62a4a90ebeb9a7ffabade", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/89a11fc3a7fdf86cc93594a6760cb0f779e59eac576bf400bbcf7b18652398bb76aa8b8502c8b505aea417e6744970799620cf304c14986a5b47e97d30321425", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/feacba1be193e2af89395007bc3e3ae284444eec9a207f73653672e1f4278ca080ad12e480fc994e2d422de05b2a461889db11002bb1dc9b945d23fdc408d471"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-01 05:13:44.884265) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 05:13:44.884556) ========= 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=3836458cccd887f2d2de3cf1000001de-1485951006.113244-587557854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004393 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 05:13:44.969668) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-01 05:13:44.969972) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-01 05:13:44.970260) ========= ========= Total master_lag: 0.18 =========