builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-036 starttime: 1483445393.88 results: success (0) revision: 232424f9511d61179912ccaf5b169fb45f05599a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-03 04:09:53.878985) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-03 04:09:53.879431) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-03 04:09:53.879720) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-03 04:09:53.894581) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 04:09:53.894951) ========= 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=14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-03 04:09:53-- 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% 69.8M=0s 2017-01-03 04:09:53 (69.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.088105 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 04:09:53.996936) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 04:09:53.997252) ========= 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=14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019967 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 04:09:54.046488) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-03 04:09:54.046829) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 232424f9511d61179912ccaf5b169fb45f05599a --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 232424f9511d61179912ccaf5b169fb45f05599a --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=14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-03 04:09:54,125 truncating revision to first 12 chars 2017-01-03 04:09:54,125 Setting DEBUG logging. 2017-01-03 04:09:54,125 attempt 1/10 2017-01-03 04:09:54,125 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/232424f9511d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-03 04:09:55,501 unpacking tar archive at: mozilla-central-232424f9511d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.686092 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-03 04:09:55.746002) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-03 04:09:55.746321) ========= script_repo_revision: 232424f9511d61179912ccaf5b169fb45f05599a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-03 04:09:55.746692) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-03 04:09:55.746953) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-03 04:09:55.756337) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-01-03 04:09:55.756737) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:09:55 INFO - MultiFileLogger online at 20170103 04:09:55 in /builds/slave/test 04:09:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:09:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:09:55 INFO - {'append_to_log': False, 04:09:55 INFO - 'base_work_dir': '/builds/slave/test', 04:09:55 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:09:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:09:55 INFO - 'branch': 'Firefox-Non-PGO', 04:09:55 INFO - 'buildbot_json_path': 'buildprops.json', 04:09:55 INFO - 'config_files': ('talos/linux_config.py',), 04:09:55 INFO - 'default_actions': ('clobber', 04:09:55 INFO - 'read-buildbot-config', 04:09:55 INFO - 'download-and-extract', 04:09:55 INFO - 'populate-webroot', 04:09:55 INFO - 'create-virtualenv', 04:09:55 INFO - 'install', 04:09:55 INFO - 'run-tests'), 04:09:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:09:55 INFO - 'download_minidump_stackwalk': True, 04:09:55 INFO - 'download_symbols': 'ondemand', 04:09:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:09:55 INFO - 'tooltool.py': '/tools/tooltool.py', 04:09:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:09:55 INFO - '/tools/misc-python/virtualenv.py')}, 04:09:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:09:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:09:55 INFO - 'installer_path': 'installer.exe', 04:09:55 INFO - 'log_level': 'info', 04:09:55 INFO - 'log_name': 'talos', 04:09:55 INFO - 'log_to_console': True, 04:09:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:09:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:09:55 INFO - 'opt_config_files': (), 04:09:55 INFO - 'pip_index': False, 04:09:55 INFO - 'sps_profile': False, 04:09:55 INFO - 'sps_profile_interval': 0, 04:09:55 INFO - 'suite': 'dromaeojs-e10s', 04:09:55 INFO - 'system_bits': '32', 04:09:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:09:55 INFO - 'title': 'talos-linux64-ix-036', 04:09:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:09:55 INFO - 'use_talos_json': True, 04:09:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:09:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:09:55 INFO - 'work_dir': 'build'} 04:09:55 INFO - [mozharness: 2017-01-03 12:09:55.923578Z] Running clobber step. 04:09:55 INFO - Running pre-action listener: _resource_record_pre_action 04:09:55 INFO - Running main action method: clobber 04:09:55 INFO - rmtree: /builds/slave/test/build 04:09:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:09:56 INFO - Running post-action listener: _resource_record_post_action 04:09:56 INFO - [mozharness: 2017-01-03 12:09:56.950978Z] Finished clobber step (success) 04:09:56 INFO - [mozharness: 2017-01-03 12:09:56.951077Z] Running read-buildbot-config step. 04:09:56 INFO - Running pre-action listener: _resource_record_pre_action 04:09:56 INFO - Running main action method: read_buildbot_config 04:09:56 INFO - Using buildbot properties: 04:09:56 INFO - { 04:09:56 INFO - "project": "", 04:09:56 INFO - "product": "firefox", 04:09:56 INFO - "who": "cbook@mozilla.com", 04:09:56 INFO - "installer_path": "public/build/target.tar.bz2", 04:09:56 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:09:56 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:09:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:09:56 INFO - "stage_platform": "linux64", 04:09:56 INFO - "basedir": "/builds/slave/test", 04:09:56 INFO - "buildnumber": 596, 04:09:56 INFO - "platform": "ubuntu64_hw", 04:09:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:09:56 INFO - "slavebuilddir": "test", 04:09:56 INFO - "taskId": "Y-MSi-kTROmTdcOYa7bNpg", 04:09:56 INFO - "branch": "mozilla-central", 04:09:56 INFO - "script_repo_revision": "production", 04:09:56 INFO - "revision": "232424f9511d61179912ccaf5b169fb45f05599a", 04:09:56 INFO - "slavename": "talos-linux64-ix-036", 04:09:56 INFO - "repo_path": "mozilla-central" 04:09:56 INFO - } 04:09:56 INFO - Finding installer, test and symbols from parent task. 04:09:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y-MSi-kTROmTdcOYa7bNpg'}, attempt #1 04:09:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y-MSi-kTROmTdcOYa7bNpg'}, attempt #1 04:09:57 INFO - Task dependencies: Unm3omsuSS-MrpYcaR-y-A 04:09:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Unm3omsuSS-MrpYcaR-y-A'}, attempt #1 04:09:58 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Unm3omsuSS-MrpYcaR-y-A/artifacts/public/build/target.tar.bz2 04:09:58 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Unm3omsuSS-MrpYcaR-y-A/artifacts/public/build/test_packages.json 04:09:58 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Unm3omsuSS-MrpYcaR-y-A/artifacts/public/build/target.crashreporter-symbols.zip 04:09:58 INFO - Running post-action listener: _resource_record_post_action 04:09:58 INFO - [mozharness: 2017-01-03 12:09:58.381041Z] Finished read-buildbot-config step (success) 04:09:58 INFO - [mozharness: 2017-01-03 12:09:58.381261Z] Running download-and-extract step. 04:09:58 INFO - Running pre-action listener: _resource_record_pre_action 04:09:58 INFO - Running main action method: download_and_extract 04:09:58 INFO - mkdir: /builds/slave/test/build/tests 04:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:58 INFO - trying https://queue.taskcluster.net/v1/task/Unm3omsuSS-MrpYcaR-y-A/artifacts/public/build/target.test_packages.json 04:09:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Unm3omsuSS-MrpYcaR-y-A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:09:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Unm3omsuSS-MrpYcaR-y-A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:09:58 INFO - Downloaded 896 bytes. 04:09:58 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:09:58 INFO - Using the following test package requirements: 04:09:58 INFO - {u'common': [u'target.common.tests.zip'], 04:09:58 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:09:58 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:09:58 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:09:58 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:09:58 INFO - u'mozbase': [u'target.common.tests.zip'], 04:09:58 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:09:58 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:09:58 INFO - u'web-platform': [u'target.common.tests.zip', 04:09:58 INFO - u'target.web-platform.tests.zip'], 04:09:58 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:09:58 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:09:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Unm3omsuSS-MrpYcaR-y-A/artifacts/public/build/target.common.tests.zip 04:09:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Unm3omsuSS-MrpYcaR-y-A/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:09:58 INFO - Fetch https://queue.taskcluster.net/v1/task/Unm3omsuSS-MrpYcaR-y-A/artifacts/public/build/target.common.tests.zip into memory 04:09:59 INFO - Expected file size: 20246919 04:09:59 INFO - Obtained file size: 20246919 04:10:03 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:10:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Unm3omsuSS-MrpYcaR-y-A/artifacts/public/build/target.common.tests.zip 04:10:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Unm3omsuSS-MrpYcaR-y-A/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:10:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Unm3omsuSS-MrpYcaR-y-A/artifacts/public/build/target.common.tests.zip into memory 04:10:04 INFO - Expected file size: 20246919 04:10:04 INFO - Obtained file size: 20246919 04:10:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Unm3omsuSS-MrpYcaR-y-A/artifacts/public/build/target.talos.tests.zip 04:10:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Unm3omsuSS-MrpYcaR-y-A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:10:08 INFO - Fetch https://queue.taskcluster.net/v1/task/Unm3omsuSS-MrpYcaR-y-A/artifacts/public/build/target.talos.tests.zip into memory 04:10:09 INFO - Expected file size: 14409776 04:10:09 INFO - Obtained file size: 14409776 04:10: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:10:10 INFO - trying https://queue.taskcluster.net/v1/task/Unm3omsuSS-MrpYcaR-y-A/artifacts/public/build/target.tar.bz2 04:10:10 INFO - Downloading https://queue.taskcluster.net/v1/task/Unm3omsuSS-MrpYcaR-y-A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:10:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Unm3omsuSS-MrpYcaR-y-A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:10:11 INFO - Downloaded 55891400 bytes. 04:10:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Unm3omsuSS-MrpYcaR-y-A/artifacts/public/build/target.tar.bz2 04:10:11 INFO - mkdir: /builds/slave/test/properties 04:10:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:10:11 INFO - Writing to file /builds/slave/test/properties/build_url 04:10:11 INFO - Contents: 04:10:11 INFO - build_url:https://queue.taskcluster.net/v1/task/Unm3omsuSS-MrpYcaR-y-A/artifacts/public/build/target.tar.bz2 04:10:11 INFO - Running post-action listener: _resource_record_post_action 04:10:11 INFO - Running post-action listener: set_extra_try_arguments 04:10:11 INFO - [mozharness: 2017-01-03 12:10:11.077452Z] Finished download-and-extract step (success) 04:10:11 INFO - [mozharness: 2017-01-03 12:10:11.077549Z] Running populate-webroot step. 04:10:11 INFO - Running pre-action listener: _resource_record_pre_action 04:10:11 INFO - Running main action method: populate_webroot 04:10:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:10:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:10:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:10:11 INFO - '--tppagecycles', 04:10:11 INFO - '7'], 04:10:11 INFO - 'tests': ['tsvgm']}}, 04:10:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:10:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:10:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:10:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:10:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:10:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:10:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:10:11 INFO - 'talos_options': ['--disable-e10s'], 04:10:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:10:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:10:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:10:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:10:11 INFO - 'talos_options': ['--disable-e10s'], 04:10:11 INFO - 'tests': ['damp', 'tps']}, 04:10:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:10:11 INFO - 'tests': ['damp', 'tps']}, 04:10:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:10:11 INFO - 'tests': ['dromaeo_dom']}, 04:10:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:10:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:10:11 INFO - 'tests': ['basic_compositor_video']}, 04:10:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:10:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:10:11 INFO - 'tests': ['a11yr', 04:10:11 INFO - 'ts_paint', 04:10:11 INFO - 'tpaint', 04:10:11 INFO - 'sessionrestore', 04:10:11 INFO - 'sessionrestore_no_auto_restore', 04:10:11 INFO - 'tabpaint']}, 04:10:11 INFO - 'other-e10s': {'tests': ['a11yr', 04:10:11 INFO - 'ts_paint', 04:10:11 INFO - 'tpaint', 04:10:11 INFO - 'sessionrestore', 04:10:11 INFO - 'sessionrestore_no_auto_restore', 04:10:11 INFO - 'tabpaint']}, 04:10:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:10:11 INFO - 'ts_paint', 04:10:11 INFO - 'tpaint', 04:10:11 INFO - 'sessionrestore', 04:10:11 INFO - 'sessionrestore_no_auto_restore', 04:10:11 INFO - 'tabpaint']}, 04:10:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:10:11 INFO - 'ts_paint', 04:10:11 INFO - 'tpaint', 04:10:11 INFO - 'sessionrestore', 04:10:11 INFO - 'sessionrestore_no_auto_restore', 04:10:11 INFO - 'tabpaint']}, 04:10:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:10:11 INFO - 'tests': ['a11yr', 04:10:11 INFO - 'ts_paint', 04:10:11 INFO - 'tpaint', 04:10:11 INFO - 'sessionrestore', 04:10:11 INFO - 'sessionrestore_no_auto_restore', 04:10:11 INFO - 'tabpaint']}, 04:10:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:10:11 INFO - 'tests': ['a11yr', 04:10:11 INFO - 'ts_paint', 04:10:11 INFO - 'tpaint', 04:10:11 INFO - 'sessionrestore', 04:10:11 INFO - 'sessionrestore_no_auto_restore', 04:10:11 INFO - 'tabpaint']}, 04:10:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:10:11 INFO - 'tests': ['tsvgx', 04:10:11 INFO - 'tsvgr_opacity', 04:10:11 INFO - 'tart', 04:10:11 INFO - 'tscrollx', 04:10:11 INFO - 'cart', 04:10:11 INFO - 'tsvg_static']}, 04:10:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:10:11 INFO - 'tsvgr_opacity', 04:10:11 INFO - 'tart', 04:10:11 INFO - 'tscrollx', 04:10:11 INFO - 'cart', 04:10:11 INFO - 'tsvg_static']}, 04:10:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:10:11 INFO - 'talos_options': ['--disable-e10s'], 04:10:11 INFO - 'tests': ['tp5o']}, 04:10:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:10:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:10:11 INFO - 'talos_options': ['--disable-e10s', 04:10:11 INFO - '--xperf_path', 04:10:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:10:11 INFO - 'tests': ['tp5n']}, 04:10:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:10:11 INFO - 'talos_options': ['--xperf_path', 04:10:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:10:11 INFO - 'tests': ['tp5n']}}, 04:10:11 INFO - 'talos.zip': {'path': '', 04:10:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:10:11 INFO - Running post-action listener: _resource_record_post_action 04:10:11 INFO - [mozharness: 2017-01-03 12:10:11.090651Z] Finished populate-webroot step (success) 04:10:11 INFO - [mozharness: 2017-01-03 12:10:11.090741Z] Running create-virtualenv step. 04:10:11 INFO - Running pre-action listener: _resource_record_pre_action 04:10:11 INFO - Running main action method: create_virtualenv 04:10:11 INFO - Creating virtualenv /builds/slave/test/build/venv 04:10:11 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:10:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:10:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:10:11 INFO - Using real prefix '/usr' 04:10:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:10:11 INFO - Installing distribute.............................................................................................................................................................................................done. 04:10:13 INFO - Installing pip.................done. 04:10:13 INFO - Return code: 0 04:10:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:10:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:10:13 INFO - Reading from file tmpfile_stdout 04:10:13 INFO - Output received: 04:10:13 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:10:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:10:13 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:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:13 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:10:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:13 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 0x1bd91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ceaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f48820>, '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 0x1f49520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f499b0>, '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': '14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258', '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:10:13 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:10:13 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:10:13 INFO - Using env: {'DISPLAY': ':0', 04:10:13 INFO - 'HOME': '/home/cltbld', 04:10:13 INFO - 'LANG': 'en_US.UTF-8', 04:10:13 INFO - 'LANGUAGE': 'en_US:en', 04:10:13 INFO - 'LOGNAME': 'cltbld', 04:10:13 INFO - 'MAIL': '/var/mail/cltbld', 04:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:13 INFO - 'MOZ_NO_REMOTE': '1', 04:10:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:13 INFO - 'NO_EM_RESTART': '1', 04:10:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:13 INFO - 'PWD': '/builds/slave/test', 04:10:13 INFO - 'SHELL': '/bin/bash', 04:10:13 INFO - 'SHLVL': '1', 04:10:13 INFO - 'TERM': 'linux', 04:10:13 INFO - 'TMOUT': '86400', 04:10:13 INFO - 'USER': 'cltbld', 04:10:13 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258', 04:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:13 INFO - '_': '/tools/buildbot/bin/python'} 04:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:14 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:10:14 INFO - Cleaning up... 04:10:14 INFO - Return code: 0 04:10:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:10: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:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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', '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 0x1bd91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ceaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f48820>, '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 0x1f49520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f499b0>, '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': '14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258', '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:10: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:10: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 psutil>=3.1.1 04:10:14 INFO - Using env: {'DISPLAY': ':0', 04:10:14 INFO - 'HOME': '/home/cltbld', 04:10:14 INFO - 'LANG': 'en_US.UTF-8', 04:10:14 INFO - 'LANGUAGE': 'en_US:en', 04:10:14 INFO - 'LOGNAME': 'cltbld', 04:10:14 INFO - 'MAIL': '/var/mail/cltbld', 04:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:14 INFO - 'MOZ_NO_REMOTE': '1', 04:10:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:14 INFO - 'NO_EM_RESTART': '1', 04:10:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:14 INFO - 'PWD': '/builds/slave/test', 04:10:14 INFO - 'SHELL': '/bin/bash', 04:10:14 INFO - 'SHLVL': '1', 04:10:14 INFO - 'TERM': 'linux', 04:10:14 INFO - 'TMOUT': '86400', 04:10:14 INFO - 'USER': 'cltbld', 04:10:14 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258', 04:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:14 INFO - '_': '/tools/buildbot/bin/python'} 04:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:14 INFO - Downloading/unpacking psutil>=3.1.1 04:10: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:10: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:10: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:10: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:10: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:10: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:10:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:10:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:10:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:10:16 INFO - Installing collected packages: psutil 04:10:16 INFO - Running setup.py install for psutil 04:10:16 INFO - building 'psutil._psutil_linux' extension 04:10:16 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:10:16 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:10:16 INFO - building 'psutil._psutil_posix' extension 04:10:16 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:10:16 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:10:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:10:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:10:16 INFO - Successfully installed psutil 04:10:16 INFO - Cleaning up... 04:10:16 INFO - Return code: 0 04:10:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:10: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:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:17 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 0x1bd91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ceaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f48820>, '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 0x1f49520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f499b0>, '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': '14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258', '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:10:17 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:10:17 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:10:17 INFO - Using env: {'DISPLAY': ':0', 04:10:17 INFO - 'HOME': '/home/cltbld', 04:10:17 INFO - 'LANG': 'en_US.UTF-8', 04:10:17 INFO - 'LANGUAGE': 'en_US:en', 04:10:17 INFO - 'LOGNAME': 'cltbld', 04:10:17 INFO - 'MAIL': '/var/mail/cltbld', 04:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:17 INFO - 'MOZ_NO_REMOTE': '1', 04:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:17 INFO - 'NO_EM_RESTART': '1', 04:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:17 INFO - 'PWD': '/builds/slave/test', 04:10:17 INFO - 'SHELL': '/bin/bash', 04:10:17 INFO - 'SHLVL': '1', 04:10:17 INFO - 'TERM': 'linux', 04:10:17 INFO - 'TMOUT': '86400', 04:10:17 INFO - 'USER': 'cltbld', 04:10:17 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258', 04:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:17 INFO - '_': '/tools/buildbot/bin/python'} 04:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:10:17 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:10:17 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:10:17 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:10:17 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:10:17 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:10:17 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:10:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:10:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:10:19 INFO - Installing collected packages: mozsystemmonitor 04:10:19 INFO - Running setup.py install for mozsystemmonitor 04:10:19 INFO - Successfully installed mozsystemmonitor 04:10:19 INFO - Cleaning up... 04:10:19 INFO - Return code: 0 04:10:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:10: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:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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', '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 0x1bd91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ceaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f48820>, '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 0x1f49520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f499b0>, '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': '14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258', '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:10: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:10: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 jsonschema==2.5.1 04:10:19 INFO - Using env: {'DISPLAY': ':0', 04:10:19 INFO - 'HOME': '/home/cltbld', 04:10:19 INFO - 'LANG': 'en_US.UTF-8', 04:10:19 INFO - 'LANGUAGE': 'en_US:en', 04:10:19 INFO - 'LOGNAME': 'cltbld', 04:10:19 INFO - 'MAIL': '/var/mail/cltbld', 04:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:19 INFO - 'MOZ_NO_REMOTE': '1', 04:10:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:19 INFO - 'NO_EM_RESTART': '1', 04:10:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:19 INFO - 'PWD': '/builds/slave/test', 04:10:19 INFO - 'SHELL': '/bin/bash', 04:10:19 INFO - 'SHLVL': '1', 04:10:19 INFO - 'TERM': 'linux', 04:10:19 INFO - 'TMOUT': '86400', 04:10:19 INFO - 'USER': 'cltbld', 04:10:19 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258', 04:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:19 INFO - '_': '/tools/buildbot/bin/python'} 04:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:19 INFO - Downloading/unpacking jsonschema==2.5.1 04:10: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:10: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:10: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:10: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:10: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:10: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:10:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:10:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:10: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:10: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:10: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:10: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:10: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:10: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:10:22 INFO - Downloading functools32-3.2.3-2.tar.gz 04:10:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:10:22 INFO - warning: no files found matching '*.txt' 04:10:22 INFO - no previously-included directories found matching 'build' 04:10:22 INFO - no previously-included directories found matching 'dist' 04:10:22 INFO - no previously-included directories found matching '.git*' 04:10:22 INFO - Installing collected packages: jsonschema, functools32 04:10:22 INFO - Running setup.py install for functools32 04:10:22 INFO - warning: no files found matching '*.txt' 04:10:22 INFO - no previously-included directories found matching 'build' 04:10:22 INFO - no previously-included directories found matching 'dist' 04:10:22 INFO - no previously-included directories found matching '.git*' 04:10:22 INFO - Successfully installed jsonschema functools32 04:10:22 INFO - Cleaning up... 04:10:22 INFO - Return code: 0 04:10:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:22 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 0x1bd91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ceaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f48820>, '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 0x1f49520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f499b0>, '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': '14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258', '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:10:22 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:10:22 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:10:22 INFO - Using env: {'DISPLAY': ':0', 04:10:22 INFO - 'HOME': '/home/cltbld', 04:10:22 INFO - 'LANG': 'en_US.UTF-8', 04:10:22 INFO - 'LANGUAGE': 'en_US:en', 04:10:22 INFO - 'LOGNAME': 'cltbld', 04:10:22 INFO - 'MAIL': '/var/mail/cltbld', 04:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:22 INFO - 'MOZ_NO_REMOTE': '1', 04:10:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:22 INFO - 'NO_EM_RESTART': '1', 04:10:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:22 INFO - 'PWD': '/builds/slave/test', 04:10:22 INFO - 'SHELL': '/bin/bash', 04:10:22 INFO - 'SHLVL': '1', 04:10:22 INFO - 'TERM': 'linux', 04:10:22 INFO - 'TMOUT': '86400', 04:10:22 INFO - 'USER': 'cltbld', 04:10:22 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258', 04:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:22 INFO - '_': '/tools/buildbot/bin/python'} 04:10:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:10:22 INFO - Cleaning up... 04:10:22 INFO - Return code: 0 04:10:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:22 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 0x1bd91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ceaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f48820>, '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 0x1f49520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f499b0>, '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': '14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258', '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:10:22 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:10:22 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:10:22 INFO - Using env: {'DISPLAY': ':0', 04:10:22 INFO - 'HOME': '/home/cltbld', 04:10:22 INFO - 'LANG': 'en_US.UTF-8', 04:10:22 INFO - 'LANGUAGE': 'en_US:en', 04:10:22 INFO - 'LOGNAME': 'cltbld', 04:10:22 INFO - 'MAIL': '/var/mail/cltbld', 04:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:22 INFO - 'MOZ_NO_REMOTE': '1', 04:10:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:22 INFO - 'NO_EM_RESTART': '1', 04:10:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:22 INFO - 'PWD': '/builds/slave/test', 04:10:22 INFO - 'SHELL': '/bin/bash', 04:10:22 INFO - 'SHLVL': '1', 04:10:22 INFO - 'TERM': 'linux', 04:10:22 INFO - 'TMOUT': '86400', 04:10:22 INFO - 'USER': 'cltbld', 04:10:22 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258', 04:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:22 INFO - '_': '/tools/buildbot/bin/python'} 04:10:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:22 INFO - Downloading/unpacking blobuploader==1.2.4 04:10: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:10: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:10: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:10: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:10: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:10: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:10:24 INFO - Downloading blobuploader-1.2.4.tar.gz 04:10:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:10:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:10:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:10:25 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:10:25 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:10:25 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:10:25 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:10:25 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:10:25 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:10:25 INFO - Downloading docopt-0.6.1.tar.gz 04:10:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:10:25 INFO - Installing collected packages: blobuploader, requests, docopt 04:10:25 INFO - Running setup.py install for blobuploader 04:10:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:10:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:10:25 INFO - Running setup.py install for requests 04:10:26 INFO - Running setup.py install for docopt 04:10:26 INFO - Successfully installed blobuploader requests docopt 04:10:26 INFO - Cleaning up... 04:10:26 INFO - Return code: 0 04:10:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:10: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:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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:10:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:26 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 0x1bd91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ceaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f48820>, '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 0x1f49520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f499b0>, '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': '14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258', '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:10:26 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:10:26 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:10:26 INFO - Using env: {'DISPLAY': ':0', 04:10:26 INFO - 'HOME': '/home/cltbld', 04:10:26 INFO - 'LANG': 'en_US.UTF-8', 04:10:26 INFO - 'LANGUAGE': 'en_US:en', 04:10:26 INFO - 'LOGNAME': 'cltbld', 04:10:26 INFO - 'MAIL': '/var/mail/cltbld', 04:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:26 INFO - 'MOZ_NO_REMOTE': '1', 04:10:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:26 INFO - 'NO_EM_RESTART': '1', 04:10:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:26 INFO - 'PWD': '/builds/slave/test', 04:10:26 INFO - 'SHELL': '/bin/bash', 04:10:26 INFO - 'SHLVL': '1', 04:10:26 INFO - 'TERM': 'linux', 04:10:26 INFO - 'TMOUT': '86400', 04:10:26 INFO - 'USER': 'cltbld', 04:10:26 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258', 04:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:26 INFO - '_': '/tools/buildbot/bin/python'} 04:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:10:26 INFO - Running setup.py (path:/tmp/pip-PV5eJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:10:26 INFO - Running setup.py (path:/tmp/pip-DD7MoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:10:26 INFO - Running setup.py (path:/tmp/pip-CFmxo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:10:26 INFO - Running setup.py (path:/tmp/pip-_bT8LW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:10:26 INFO - Running setup.py (path:/tmp/pip-n7oK5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:10:26 INFO - Running setup.py (path:/tmp/pip-ZY3wN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:10:26 INFO - Running setup.py (path:/tmp/pip-3MwxI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:10:26 INFO - Running setup.py (path:/tmp/pip-KhwWAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:10:27 INFO - Running setup.py (path:/tmp/pip-euQD1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:10:27 INFO - Running setup.py (path:/tmp/pip-ZZZJtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:10:27 INFO - Running setup.py (path:/tmp/pip-Q121Eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:10:27 INFO - Running setup.py (path:/tmp/pip-KMFNaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:10:27 INFO - Running setup.py (path:/tmp/pip-TbrIfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:10:27 INFO - Running setup.py (path:/tmp/pip-4XAZgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:27 INFO - Running setup.py (path:/tmp/pip-L5Q7P1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:10:27 INFO - Running setup.py (path:/tmp/pip-U2cnmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:10:27 INFO - Running setup.py (path:/tmp/pip-2QMR5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:10:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:10:27 INFO - Running setup.py install for manifestparser 04:10:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:10:27 INFO - Running setup.py install for mozcrash 04:10:27 INFO - Running setup.py install for mozdebug 04:10:27 INFO - Running setup.py install for mozdevice 04:10:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:10:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:10:28 INFO - Running setup.py install for mozfile 04:10:28 INFO - Running setup.py install for mozhttpd 04:10:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:10:28 INFO - Running setup.py install for mozinfo 04:10:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:10:28 INFO - Running setup.py install for mozInstall 04:10:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:10:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:10:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:10:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:10:28 INFO - Running setup.py install for mozleak 04:10:28 INFO - Running setup.py install for mozlog 04:10:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:10:28 INFO - Running setup.py install for moznetwork 04:10:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:10:28 INFO - Running setup.py install for mozprocess 04:10:28 INFO - Running setup.py install for mozprofile 04:10:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:10:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:10:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:10:29 INFO - Running setup.py install for mozrunner 04:10:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:10:29 INFO - Running setup.py install for mozscreenshot 04:10:29 INFO - Running setup.py install for moztest 04:10:29 INFO - Running setup.py install for mozversion 04:10:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:10:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:10:29 INFO - Cleaning up... 04:10:29 INFO - Return code: 0 04:10:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:29 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 0x1bd91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ceaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f48820>, '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 0x1f49520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f499b0>, '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': '14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258', '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:10:29 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:10:29 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:10:29 INFO - Using env: {'DISPLAY': ':0', 04:10:29 INFO - 'HOME': '/home/cltbld', 04:10:29 INFO - 'LANG': 'en_US.UTF-8', 04:10:29 INFO - 'LANGUAGE': 'en_US:en', 04:10:29 INFO - 'LOGNAME': 'cltbld', 04:10:29 INFO - 'MAIL': '/var/mail/cltbld', 04:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:29 INFO - 'MOZ_NO_REMOTE': '1', 04:10:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:29 INFO - 'NO_EM_RESTART': '1', 04:10:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:29 INFO - 'PWD': '/builds/slave/test', 04:10:29 INFO - 'SHELL': '/bin/bash', 04:10:29 INFO - 'SHLVL': '1', 04:10:29 INFO - 'TERM': 'linux', 04:10:29 INFO - 'TMOUT': '86400', 04:10:29 INFO - 'USER': 'cltbld', 04:10:29 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258', 04:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:29 INFO - '_': '/tools/buildbot/bin/python'} 04:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:10:29 INFO - Running setup.py (path:/tmp/pip-Zem4iD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:10:29 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:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:10:29 INFO - Running setup.py (path:/tmp/pip-RwV_9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:10:29 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:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:10:29 INFO - Running setup.py (path:/tmp/pip-0R9Hmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:10:29 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:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:10:29 INFO - Running setup.py (path:/tmp/pip-gAAzSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:10:29 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:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:10:29 INFO - Running setup.py (path:/tmp/pip-TI9Szn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:10:30 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:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:10:30 INFO - Running setup.py (path:/tmp/pip-SbGGSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:10:30 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:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:10:30 INFO - Running setup.py (path:/tmp/pip-Mm6qCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:10:30 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:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:10:30 INFO - Running setup.py (path:/tmp/pip-PbrRfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:10:30 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:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:10:30 INFO - Running setup.py (path:/tmp/pip-J4vZm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:10:30 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:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:10:30 INFO - Running setup.py (path:/tmp/pip-3yY0sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:10:30 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:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:10:30 INFO - Running setup.py (path:/tmp/pip-zrM3Rg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:10:30 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:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:10:30 INFO - Running setup.py (path:/tmp/pip-WLDc0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:10:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:10:30 INFO - Running setup.py (path:/tmp/pip-fkTd9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:10:30 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:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:10:30 INFO - Running setup.py (path:/tmp/pip-jPdNet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:10:30 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:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:30 INFO - Running setup.py (path:/tmp/pip-1q1_5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:30 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:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:10:30 INFO - Running setup.py (path:/tmp/pip-C9pHis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:10:30 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:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:10:30 INFO - Running setup.py (path:/tmp/pip-F8ZB4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:10:30 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:10:30 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:10:30 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:10:30 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:10:30 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:10:30 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:10:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:32 INFO - Downloading blessings-1.6.tar.gz 04:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:10:33 INFO - Installing collected packages: blessings 04:10:33 INFO - Running setup.py install for blessings 04:10:33 INFO - Successfully installed blessings 04:10:33 INFO - Cleaning up... 04:10:33 INFO - Return code: 0 04:10:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:10:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:10:33 INFO - Reading from file tmpfile_stdout 04:10:33 INFO - Current package versions: 04:10:33 INFO - argparse == 1.2.1 04:10:33 INFO - blessings == 1.6 04:10:33 INFO - blobuploader == 1.2.4 04:10:33 INFO - docopt == 0.6.1 04:10:33 INFO - functools32 == 3.2.3-2 04:10:33 INFO - jsonschema == 2.5.1 04:10:33 INFO - manifestparser == 1.1 04:10:33 INFO - mozInstall == 1.12 04:10:33 INFO - mozcrash == 1.0 04:10:33 INFO - mozdebug == 0.1 04:10:33 INFO - mozdevice == 0.49 04:10:33 INFO - mozfile == 1.2 04:10:33 INFO - mozhttpd == 0.7 04:10:33 INFO - mozinfo == 0.9 04:10:33 INFO - mozleak == 0.1 04:10:33 INFO - mozlog == 3.4 04:10:33 INFO - moznetwork == 0.27 04:10:33 INFO - mozprocess == 0.23 04:10:33 INFO - mozprofile == 0.28 04:10:33 INFO - mozrunner == 6.13 04:10:33 INFO - mozscreenshot == 0.1 04:10:33 INFO - mozsystemmonitor == 0.3 04:10:33 INFO - moztest == 0.8 04:10:33 INFO - mozversion == 1.4 04:10:33 INFO - psutil == 3.1.1 04:10:33 INFO - requests == 1.2.3 04:10:33 INFO - wsgiref == 0.1.2 04:10:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:33 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 0x1bd91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ceaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f48820>, '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 0x1f49520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f499b0>, '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': '14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258', '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:10:33 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:10:33 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:10:33 INFO - Using env: {'DISPLAY': ':0', 04:10:33 INFO - 'HOME': '/home/cltbld', 04:10:33 INFO - 'LANG': 'en_US.UTF-8', 04:10:33 INFO - 'LANGUAGE': 'en_US:en', 04:10:33 INFO - 'LOGNAME': 'cltbld', 04:10:33 INFO - 'MAIL': '/var/mail/cltbld', 04:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:33 INFO - 'MOZ_NO_REMOTE': '1', 04:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:33 INFO - 'NO_EM_RESTART': '1', 04:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:33 INFO - 'PWD': '/builds/slave/test', 04:10:33 INFO - 'SHELL': '/bin/bash', 04:10:33 INFO - 'SHLVL': '1', 04:10:33 INFO - 'TERM': 'linux', 04:10:33 INFO - 'TMOUT': '86400', 04:10:33 INFO - 'USER': 'cltbld', 04:10:33 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258', 04:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:33 INFO - '_': '/tools/buildbot/bin/python'} 04:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:33 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:10:33 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:10:33 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:10:33 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:10:33 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:10:33 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:10:33 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:10:33 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:10:33 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:10:33 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:10:33 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:10:33 INFO - Cleaning up... 04:10:33 INFO - Return code: 0 04:10:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:33 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 0x1bd91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ceaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f48820>, '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 0x1f49520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f499b0>, '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': '14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258', '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:10:33 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:10:33 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:10:33 INFO - Using env: {'DISPLAY': ':0', 04:10:33 INFO - 'HOME': '/home/cltbld', 04:10:33 INFO - 'LANG': 'en_US.UTF-8', 04:10:33 INFO - 'LANGUAGE': 'en_US:en', 04:10:33 INFO - 'LOGNAME': 'cltbld', 04:10:33 INFO - 'MAIL': '/var/mail/cltbld', 04:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:33 INFO - 'MOZ_NO_REMOTE': '1', 04:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:33 INFO - 'NO_EM_RESTART': '1', 04:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:33 INFO - 'PWD': '/builds/slave/test', 04:10:33 INFO - 'SHELL': '/bin/bash', 04:10:33 INFO - 'SHLVL': '1', 04:10:33 INFO - 'TERM': 'linux', 04:10:33 INFO - 'TMOUT': '86400', 04:10:33 INFO - 'USER': 'cltbld', 04:10:33 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258', 04:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:33 INFO - '_': '/tools/buildbot/bin/python'} 04:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:10:33 INFO - Cleaning up... 04:10:33 INFO - Return code: 0 04:10:33 INFO - Running post-action listener: _resource_record_post_action 04:10:33 INFO - Running post-action listener: _start_resource_monitoring 04:10:33 INFO - Starting resource monitoring. 04:10:33 INFO - [mozharness: 2017-01-03 12:10:33.919322Z] Finished create-virtualenv step (success) 04:10:33 INFO - [mozharness: 2017-01-03 12:10:33.919768Z] Running install step. 04:10:33 INFO - Running pre-action listener: _resource_record_pre_action 04:10:33 INFO - Running main action method: install 04:10:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:10:34 INFO - Reading from file tmpfile_stdout 04:10:34 INFO - Detecting whether we're running mozinstall >=1.0... 04:10:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:10:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:10:34 INFO - Reading from file tmpfile_stdout 04:10:34 INFO - Output received: 04:10:34 INFO - Usage: mozinstall [options] installer 04:10:34 INFO - Options: 04:10:34 INFO - -h, --help show this help message and exit 04:10:34 INFO - -d DEST, --destination=DEST 04:10:34 INFO - Directory to install application into. [default: 04:10:34 INFO - "/builds/slave/test"] 04:10:34 INFO - --app=APP Application being installed. [default: firefox] 04:10:34 INFO - mkdir: /builds/slave/test/build/application 04:10:34 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:10:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:10:50 INFO - Reading from file tmpfile_stdout 04:10:50 INFO - Output received: 04:10:50 INFO - /builds/slave/test/build/application/firefox/firefox 04:10:50 INFO - Running post-action listener: _resource_record_post_action 04:10:50 INFO - [mozharness: 2017-01-03 12:10:50.325295Z] Finished install step (success) 04:10:50 INFO - [mozharness: 2017-01-03 12:10:50.325629Z] Running run-tests step. 04:10:50 INFO - Running pre-action listener: _resource_record_pre_action 04:10:50 INFO - Running main action method: run_tests 04:10:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:10:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:10:50 INFO - Python 2.7.3 04:10:50 INFO - Return code: 0 04:10:50 INFO - grabbing minidump binary from tooltool 04:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:50 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 0x1f48820>, '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 0x1f49520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f499b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:10:50 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:10:50 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:10:50 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:10:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:10:50 INFO - Return code: 0 04:10:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:10:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:10:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:10:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:10:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:10:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Unm3omsuSS-MrpYcaR-y-A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:10:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Unm3omsuSS-MrpYcaR-y-A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:10:50 INFO - Using env: {'DISPLAY': ':0', 04:10:50 INFO - 'HOME': '/home/cltbld', 04:10:50 INFO - 'LANG': 'en_US.UTF-8', 04:10:50 INFO - 'LANGUAGE': 'en_US:en', 04:10:50 INFO - 'LOGNAME': 'cltbld', 04:10:50 INFO - 'MAIL': '/var/mail/cltbld', 04:10:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:10:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:50 INFO - 'MOZ_NO_REMOTE': '1', 04:10:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:10:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:50 INFO - 'NO_EM_RESTART': '1', 04:10:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:50 INFO - 'PWD': '/builds/slave/test', 04:10:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:10:50 INFO - 'SHELL': '/bin/bash', 04:10:50 INFO - 'SHLVL': '1', 04:10:50 INFO - 'TERM': 'linux', 04:10:50 INFO - 'TMOUT': '86400', 04:10:50 INFO - 'USER': 'cltbld', 04:10:50 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258', 04:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:50 INFO - '_': '/tools/buildbot/bin/python'} 04:10:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Unm3omsuSS-MrpYcaR-y-A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:10:50 INFO - mozversion application_buildid: 20170103113804 04:10:50 INFO - mozversion application_changeset: 232424f9511d61179912ccaf5b169fb45f05599a 04:10:50 INFO - mozversion application_display_name: Nightly 04:10:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:10:50 INFO - mozversion application_name: Firefox 04:10:50 INFO - mozversion application_remotingname: firefox 04:10:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:10:50 INFO - mozversion application_vendor: Mozilla 04:10:50 INFO - mozversion application_version: 53.0a1 04:10:50 INFO - mozversion platform_buildid: 20170103113804 04:10:50 INFO - mozversion platform_changeset: 232424f9511d61179912ccaf5b169fb45f05599a 04:10:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:10:50 INFO - mozversion platform_version: 53.0a1 04:10:50 INFO - using testdate: 1483445450 04:10:50 INFO - actual date: 1483445450 04:10:50 INFO - starting webserver on 'localhost:40171' 04:10:50 INFO - SUITE-START | Running 2 tests 04:10:50 INFO - TEST-START | dromaeo_css 04:10:50 INFO - operating with platform_type : linux_ 04:10:50 INFO - Initialising browser for dromaeo_css test... 04:10:50 INFO - TEST-INFO | started process 13377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdgrYm6/profile http://localhost:40171/getInfo.html) 04:10:51 INFO - PROCESS | 13377 | 1483445451161 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 04:10:55 INFO - PROCESS | 13377 | __metrics Screen width/height:1600/1200 04:10:55 INFO - PROCESS | 13377 | colorDepth:24 04:10:55 INFO - PROCESS | 13377 | Browser inner width/height: 1024/697 04:10:55 INFO - PROCESS | 13377 | __metrics 04:10:55 ERROR - PROCESS | 13377 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 04:10:56 INFO - TEST-INFO | 13377: exit 0 04:10:56 INFO - Browser initialized. 04:10:56 INFO - Running cycle 1/1 for dromaeo_css test... 04:10:56 INFO - TEST-INFO | started process 13497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdgrYm6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:11:08 INFO - PROCESS | 13497 | RSS: Main: 158203904 04:11:08 INFO - PROCESS | 13497 | 04:11:58 INFO - PROCESS | 13497 | 1483445518454 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:14:12 INFO - PROCESS | 13497 | Cycle 1(1): loaded http://localhost:40171/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40171/tests/dromaeo/cssquery-ext.html) 04:14:14 INFO - PROCESS | 13497 | RSS: Main: 165879808 04:14:14 INFO - PROCESS | 13497 | 04:15:57 INFO - PROCESS | 13497 | ************************* 04:15:57 INFO - PROCESS | 13497 | A coding exception was thrown and uncaught in a Task. 04:15:57 INFO - PROCESS | 13497 | 04:15:57 INFO - PROCESS | 13497 | Full message: ReferenceError: fetch is not defined 04:15:57 INFO - PROCESS | 13497 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 04:15:57 INFO - PROCESS | 13497 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 04:15:57 INFO - PROCESS | 13497 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 04:15:57 INFO - PROCESS | 13497 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 04:15:57 INFO - PROCESS | 13497 | TaskImpl@resource://gre/modules/Task.jsm:277:3 04:15:57 INFO - PROCESS | 13497 | asyncFunction@resource://gre/modules/Task.jsm:252:14 04:15:57 INFO - PROCESS | 13497 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 04:15:57 INFO - PROCESS | 13497 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 04:15:57 INFO - PROCESS | 13497 | TaskImpl@resource://gre/modules/Task.jsm:277:3 04:15:57 INFO - PROCESS | 13497 | asyncFunction@resource://gre/modules/Task.jsm:252:14 04:15:57 INFO - PROCESS | 13497 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 04:15:57 INFO - PROCESS | 13497 | 04:15:57 INFO - PROCESS | 13497 | ************************* 04:17:17 INFO - PROCESS | 13497 | Cycle 1(1): loaded http://localhost:40171/tests/dromaeo/cssquery-ext.html (next: http://localhost:40171/tests/dromaeo/cssquery-jquery.html) 04:17:17 INFO - PROCESS | 13497 | RSS: Main: 162979840 04:17:17 INFO - PROCESS | 13497 | 04:20:20 INFO - PROCESS | 13497 | Cycle 1(1): loaded http://localhost:40171/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40171/tests/dromaeo/cssquery-mootools.html) 04:20:20 INFO - PROCESS | 13497 | RSS: Main: 168534016 04:20:20 INFO - PROCESS | 13497 | 04:23:22 INFO - PROCESS | 13497 | Cycle 1(1): loaded http://localhost:40171/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40171/tests/dromaeo/cssquery-prototype.html) 04:23:23 INFO - PROCESS | 13497 | RSS: Main: 163082240 04:23:23 INFO - PROCESS | 13497 | 04:26:26 INFO - PROCESS | 13497 | Cycle 1(1): loaded http://localhost:40171/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40171/tests/dromaeo/cssquery-yui.html) 04:26:27 INFO - PROCESS | 13497 | RSS: Main: 166457344 04:26:27 INFO - PROCESS | 13497 | 04:29:30 INFO - PROCESS | 13497 | Cycle 1(1): loaded http://localhost:40171/tests/dromaeo/cssquery-yui.html (next: http://localhost:40171/tests/dromaeo/cssquery-dojo.html) 04:29:30 INFO - PROCESS | 13497 | RSS: Main: 166719488 04:29:30 INFO - PROCESS | 13497 | 04:29:30 INFO - PROCESS | 13497 | __start_tp_report 04:29:30 INFO - PROCESS | 13497 | _x_x_mozilla_page_load 04:29:30 INFO - PROCESS | 13497 | _x_x_mozilla_page_load_details 04:29:30 INFO - PROCESS | 13497 | |i|pagename|runs| 04:29:30 INFO - PROCESS | 13497 | |0;dojo.html;2623.7245089265625;2633.7102918678943;2634.7496987786153;2658.6277921091046;2659.2554084856233;4813.6389770767155;4905.975470122648;4922.409310882695;4943.5550800428;4974.502549745023;4827.058723548909;4896.412430508344;4918.70487770734;4934.654574179809;4991.176455884774;4410.55894410558;4430.379746835446;4482.372467854503;4503.279475283955;4566.611837993774;4462.263726485142;4514.564560069454;4545.045540436512;4559.612432943204;4575.199340115483;4349.608535231844;4500.5274446183;4517.141743068839;4571.702839315451;4573.908521829561;4365.803538840728;4432.977835110836;4434.157510073108;4437.64498840092;4438.911221775546;4357.063231405232;4388.078503514266;4397.31841564558;4398.406215160944;4406.581374769392;4734.124187025412;4773.236282194867;4774.212254977924;4781.713097214179;4787.736674482902;5102.36220472441;5122.897542049138;5128.1794912813775;5130.538251557377;5151.974240128813;5221.738913054332;5234.659747116425;5239.16173412256;5269.789208431658;5292.894142117175;4861.149298872719;4863.489333619919;4863.7324947128245;4868.099401610678;4904.950950490521;5147.176451767699;5153.227015947563;5353.197020446886;5360.785568577213;5366.731663416892;5027.949720502748;5102.540771330598;5103.668261562986;5116.30929824469;5174.094533456705;5049.293098966147;5175.171972484384;5192.61055420845;5196.402413722471;5203.9219411708855;5078.4667609900425;5176.482351764794;5199.1161502544655;5220.947790522122;5274.077036518594;4950.6782059166035;5216.504432078947;5220;5227.895442091137;5234.398044224887;4295.183915056129;4359.673024523174;4367.192069467159;4377.124575084996;4442.044960333544;3783.319002579562;3796;3802.657760801486;3831.9425208621337;3848.3842585186235;4360.716553424018;4368.934465983013;4378.16814805186;4383.539728328544;4420.535843736426;5074.847754567369;5095.745212739348;5180.430152683201;5214.374275087014;5233.136532472099;4396.1867054595;4410.823567057346;4411.316245981878;4446.3552784846015;4459.576340247671;4656.8602941911795;4686.7656617169005;4716.9056618867435;4729.12511185425;4773.689710168897;4707.693999889996;4748.738819364969;4877.3903262092235;4892.461829198714;4917.704937703749;5300.469953004668;5307.150855863198;5308.946910530845;5332.653377530448;5337.119375303031;4907.803687852446;4911.287863259879;4921.557059864629;4929.482404347492;4955.40535135786;4936.160852654985;4957.3059771632725;4967.05625931072;5171.276021357088;5224.242484839753;5056.494350564914;5104.719240441811;5119.795208191631;5126;5126.128558145198;4903.239997800347;4929.433115191656;4940.802367905388;4947.802087916443;4974.626902982219;4930.975345123252;4941.258811178352;4957.925631115464;4970.776315065903;5094.337736094284;4910.950890491193;4941.357623508921;4970.527799859007;4996.900061998813;5004.924926126184;5023.623228257822;5027.120253955616;5058.848234552969;5058.898822023465;5086.872828179326;4798.832040878692;4858.05267972742;4961.305417241661;5040.042391945519;5042.823501177441 04:29:30 INFO - PROCESS | 13497 | |1;ext.html;519.5895242758221;520.2222677097742;520.7786690656473;533.9332583427072;535.6304150136406;36355.272894542126;38658.42012369817;38714.41928371077;41381.7930910345;41615.16769664605;38574.22851542968;38838.41742373867;38842.41736373949;38933.41599875997;38953.41569876454;7663.386929045677;7814.413918956073;7853.253940875607;7857.096433910087;9372.812543749122;9341.81316373672;9703.563339649698;9720.61117555297;9723.173530249936;9730.172935300472;9735.756606084833;9774.169195618346;9781.168600668952;9800.31397802154;9829.017098290149;9706.563204655808;9751.268654850914;9756.756081097958;9768.462734549597;9772.21822254218;9541.33210675253;9609.423434593948;9624.615015399375;9631.277654175965;9638.807223855554;33243.16892077717;33354.166145846306;33491;33654.32691346159;33667.83166084178;3413.5562376891094;3453.6546345365514;3476.4785282207617;3491.8603255869734;3518.5074089627474;25298.241052768262;25355.49289014228;29059.12822615325;29521.557176642367;31444.842775786205;3545.3441113394106;3589.766665166756;3596.118950857057;3649.3066317399607;3660.4509323601405;233646;237994;239031;239365;239657;54055;55136;55205.1719224212;55233.171502427496;55289.44710552924;58006.129908051415;58094;58225.70887145537;58649.413505864395;58672.706636466544;13812.171269723849;14041.78937315941;14053.71892562143;14058.859411405754;14072.437102515989;8435.831283374298;8747.562621868881;9437.716868493957;10149.441780702133;10460.895391046144;18513.81486185121;18524;18544;18564.814351856578;18587.90706046461;6992.510524263253;7015.89476157858;7027.508074434741;7117.181524124689;7303.89044164338;782.1513657681365;800.7357572001225;801.5551368990266;810.3193317613233;820.8973878265217;26800.32999174997;27485.738484916106;27699.446011079664;27722.306942326602;28074.157775266776;946.9384490008127;952.8427809411509;967.1025766162377;973.445136272318;981.190517822799;13179.53871614508;14311.257651447553;14564.198969056804;14669.046511976901;14689.19209443491;372511;375834;379336;379604;379620;42087.36868946968;42545.36181957273;42551.57448425538;42584;42725;1219.5304807648943;1223.7552489502136;1239.9566015189425;1240.4170040081146;1244;23993.400164996016;24803.751962480143;25085.49829003373;26051.609225861248;26113.73886261189;40439.39340909947;40855.795721021204;40908.795456022526;40989.38515922204;41065.38401924033;331036;332300;333113;333895;334957;23218;23414.414639633465;23686.407839804142;24344.26967190987;33157.00528984134;35315.82342088376;35621.46567801537;35723.46414803728;35989.460158098176;36755.81622091872;30773.8461307692;31101.377972439972;31413.371732565676;31428.214294642818;31665.683343167195;30021.399572008002;30693;30939.535906961864;31433.8428307857;31641.525377119822;29965.70034299629;30189.547156793105;30435.412989896107;30792.692073079877;31058;26808.8659556701;27373.178804635892;28510.287242818267;28656.856715716287;28773.71226287794;22032.228871989402;22219.22232721847;22287.739360910196;22515.324540263817;22582.774172258723 04:29:30 INFO - PROCESS | 13497 | |2;jquery.html;374.6253746253746;377.52997518089984;380.6402949212994;393.1115678566439;399.96600288975435;15475.38098476061;15977.68044639108;16508.422205222803;16682;16719.247633856474;13949.442022319121;16448.259828307724;16469.67060658786;16601.83398166018;16609.418670346542;4472.664550158743;4688.929666054994;4692.6949748266425;4697.201475749131;4704.835330763407;3582.390993531106;3755.5493340799144;4592.839250626229;4662.137504561667;5174.896502069956;5450.5367043801325;5522.696251706175;5551.583631227674;5559.583031272671;5562.86092847678;5331.626786124993;5445.727713614343;5487.862803429906;5495.148252020923;5547.11246200608;5323.973380133075;5338.092524270884;5339.6262261641705;5340.839774806762;5342.332208473941;11898.107641926803;20965.68551471729;21717.67423488649;21771.23800666985;22044.88977555118;2275.8179345652306;2395.1616934072936;2450.5221481811054;2451.767082127195;2458.606622940321;13394.196348219139;13554.728905421935;14083.155010699391;14403.495877644336;14638.926805365905;1823.9361622343154;1850.7408962745226;1895.2608482691762;1896.1467339697192;1901.1254822781398;62569.68715156441;73557;75521.6223918877;76933;79694.99999999942;15403.614909627126;15788.447404340794;15797.921010395105;16124.11317377532;16168;27023.459530809272;27111;27188.1843544694;27218.45563088727;27421;8088.78668199763;8153.1439198884445;8173.264406203471;8292.668293268322;8390.454620449651;6651.201855777241;6655.768682793699;6722.462203023746;6767.830804229835;6801.761938332134;8173.509589424653;8265.421420500506;8364.665413383396;8397.412181147383;8551.529665868313;1532.364333346642;3357.3285342931513;3389.1527118220447;3417.8974630761118;3507.3686736387695;899.4648184330313;938.0525669074284;941.5010044676333;953.8855337359561;975.8926518083006;15759.763603545956;15774.447894323643;15886.364545418284;16110.516684499484;16184.190790460665;929.6885543343055;937.1471960515897;937.4281688170211;940.8447606145046;942.5240253671852;8706.47761134334;8881.37830351882;9059.909400906039;9222.76943076415;9237.861432078524;312982;313491;315633;316272;318213;43653.56346436559;53145.46854531483;69112;70149.64925175342;73608.63195683988;863.0629828129752;877.2280393253895;903.6385445821724;904.7964208053136;905.0542183418344;14216.715665686836;14284;14353.784693229401;14380.856191437952;14681.779773303622;33541;34797.652023480456;35111.47332789959;35116.82441587776;35281.1179720509;47332;47458.76270618625;47584;47594.286085709435;47776.7611161942;5823.505002074701;6139.969300153471;6849.1096157499205;7059.188193357624;7234.095738032746;10553.630622928467;10620.787584248426;11318.4906679198;11334.60328888485;11778.76442471163;9626.614935402786;9851;10146.594136234467;10358.637447689294;10416.427096509764;10095.091441770275;10363.274570780275;10420;10512.106470950055;10578.523966421375;9945.651902183388;10124.746881327732;10290;10296.794064118525;10438.164946804389;6744.325567443217;6918.584884906922;6929.618870962146;6930.787112255436;7253.3834624057545;8379.734824839523;9260.30547708911;9484.288678349289;9501.337265978564;9956.303058785816 04:29:30 INFO - PROCESS | 13497 | |3;mootools.html;1317.3874148520938;1325.4565628092485;1329.7207586406855;1334.7263810918762;1335.9473602817561;6069;6265.154204182445;6708.530402871801;7124.964375178123;7127.109111361074;6645.4019138277545;6942;6944.6874890629915;7100;7103.715851365952;2064.401323616153;2127.6702111172795;2128.0104751290646;2128.4998025464;2129.2866889592005;2084.8220755273296;2096.5911647228795;2146.7423909130925;2159.7948194921455;2169.642009068502;2111.5987962287195;2137.348108826807;2137.4976880433087;2138.0592539282743;2144.3138195777356;2079.4281572567515;2083.3749875037506;2097.2449918029497;2097.5699981503753;2105.284203370861;2038.9592208155755;2098.9580208395746;2126.7022616833656;2127.723395958531;2152.4296061543705;7044.471664625174;7214.819629509252;7226.421886249087;7230.060092187982;7237.240089790602;4255.8084886180195;4366.170427618774;4393.78031098447;4396.472423309224;4396.846110386153;2710.823796453244;2813.38105616764;2889.1765846733792;2896.8986085487118;2900.9564856527168;1157.6816375496721;1171.94140292985;1175.0364700945229;1211.7818792617325;1234.2286071205497;9171.954140229323;9241.95379023114;9248.39885407453;9276;9297.442153470745;3578.4274516077303;3761.285355782393;3799.1831756172555;3803.0492376905772;3888.358420860526;7493.025906632103;7504.174540800507;7514;7521.05986751656;7537.2462753724185;4352.347147927836;4362.21480133579;4364.388985542027;4369.344598310279;4374.562543745664;3875.2830726315724;3924.3132451820816;3979.7015223858325;4042.4946881639794;4058.7564746115327;3057.4496590613903;3101.1936896407096;3121.562981182636;3149.10250578584;3228.322052368982;955.1928620315822;961.8749562556823;989.6387818446359;997.3567049253191;1007.9496025198711;823.81052357958;852.3011130872749;864.9913500865036;879.5338470610586;884.429542944797;4853.490383509751;4855.5387238212315;4860.854174374775;4950.960298337318;4951.405831300195;859.9226069653761;861.5562985062697;865;872.0015582158393;873.7990262239593;3324.335132973415;3436.518887355772;3472.6353732857688;3532.2405682778326;3562.6437356264682;7716.112647045549;7882.251186137308;8073.031236251687;8085.312748416332;8086.150954149847;7900.486468379537;8026.277635012877;8027.759167224993;8028.879566806502;8032.518048917083;6551.967240163769;6593.86812263752;6667.466602671775;6672.366125218096;6683;4600.608948239437;4609.723416595015;4707.29390591414;4823.758812059313;4897.436794768647;7309.671064801991;7631.618419078913;7663.195364486649;7716.189800070912;7743.303102720783;7577.318041376303;7619.123800762762;7672.386209103147;7759.262870027338;7765.72819951299;6157.907631385622;6235.251769787655;6243.406876346739;6260.561760676891;6321.146645203023;6531.542792004704;6540.280569137296;6540.934590654033;6622.63575503352;6634.9004764927595;6002.759889604367;6066.726997285221;6070.666113363631;6154.538409619386;6206.658633775186;6064.727087280995;6071.210742603434;6075.665838378754;6094.024956007018;6105.17580126695;5551.111822108443;5629.521490673174;5668.858278542904;5681.8863622726485;5698.914516282176;4069.4302797607766;4176.4570605821045;4202.138561594927;4236.110416812504;4240.745555266694;4085.325921222965;4101.384792281182;4381.539938306432;4434.667399944952;4469.642428605639 04:29:30 INFO - PROCESS | 13497 | |4;prototype.html;342.5615212527965;346.2469129643027;356.3247645711376;357.04668535011535;357.7513628028518;4926.950730492694;4929.87675308117;4974.925376119361;4985.152524070908;5016.27264046713;4853.563179313861;4873.171560834658;4892.633052521057;4913.950860491403;4921.507849215077;3740.831662575191;3884.59211782763;3891.8443262269475;3955.5846636103224;4002.919941601166;3948;3949.780928543242;3961.584033676466;3968.6229808168177;3971.6624086952643;3969.30537155998;3972.398079258076;3976.3637817949134;3977.34373828318;3997.7001724870606;3882.281777871103;3892.7957805569918;3900.8634697785724;3987.7806720630356;4004.7196696231276;3521.2605352875926;3533.4876442915634;3539.256756081226;3545.6808887200277;3581.247937933037;4789.616830653575;4829.565339119461;4841.273808928654;4847.442544107437;4862.6839255448285;4509.86470405885;4535.319702044687;4553.998120413504;4555.4533455985165;4563.863084107482;4908.116539022974;5105.851183483724;5124.205748109011;5149.562287205592;5157.896842063138;3659.26814637071;3672.467492213641;3674.8056881513617;3676.742628016013;3692.3538380783525;5405.621606487587;5409.675419474844;5445.646033007842;5451.3458384993655;5464.26232458617;3666.4866918631415;3716.9442458362605;3724.1248306647917;3730.850765969331;3769.1142581493327;3790.1093243087853;3795.772253664734;3804.771713697187;3814.7329686922203;3815.828287727059;4324.827006919751;4327.156204540147;4335.393044973706;4352.499462561783;4356.847510337123;4964.751762411865;5122.487751224922;5185.144451165515;5185.559227465707;5206.114960456732;1275.4515558309831;1276.8914642255327;1277.8913792327755;1279.6033229698824;1284.4155909061355;830.9086000539936;868.921797038257;876.268315956171;886.7162507997508;888.6090120347027;4224.950898814072;4312.417823593774;4366.934495982563;4415.205263052681;4469.173202957463;5262.158054711304;5272.868178295574;5293.967676303161;5299.4435584263865;5309.5752339812725;4465.218586747306;4471.06107717383;4477.462704475483;4480.865574032784;4481.395011673448;2624.645672834143;2716.9864150679514;2726.1821453563853;2736.166768265267;2740.410811675499;4765.404324459442;4810.735409552508;4843.588294994965;4856.660033797601;4861.708297502161;5064.873378165576;5213.201445501296;5251.36983561975;5313.57491400687;5330.466953304638;4753.762311884392;4778.761061946958;4789.976050119727;4806.447258565309;4811.446683631357;5093.668911520739;5126;5142.614303927146;5147.56245719118;5177.91263834599;4859.562639362474;5071.264666623393;5087.389513258433;5095.146717838023;5102.540771330598;4802;4803.567678908915;4835.162638197462;4838.604890579186;4856.271559266138;3842.830528876201;3879.4180872869297;3884.892805550405;3885.203533275728;3900.707446941434;4989.35138432016;5151.896962060663;5161.657968928031;5171.146760784429;5182.827823602037;4903.387076615423;4923.310736496822;4968.950310496849;4970.27930950003;4975.776090075883;4971.229459433794;4996.650234483552;5010;5031.459113147837;5066.5693416058575;4755.004347261203;4881.29221262922;4882.414110306786;4905.914986130809;4973.801047958041;4949.960508293155;4986.351774269322;4996.6002719783055;5061.898762024665;5197.428282888804;5111.4888511150075;5113.207452844815;5136.152534831711;5136.845894623168;5137.075326441127 04:29:30 INFO - PROCESS | 13497 | |5;yui.html;662.1458318768786;666.4934649666252;666.9733210671574;670.7149461478873;696.7839969609421;12122.45448954797;13058.347082645878;13069.67325816854;13092.803607945889;13149.868501314995;11127.554897804079;12962.222266663983;13009.089363744542;13046;13060.955123590114;668.2582333609689;780.6174974262627;805.2752522729531;811.4036183405193;812.743985644523;814.7352110564061;817.6279792694339;823.7611092783086;825.0594322472386;826.7850358906697;866.1901122450497;872.16708043818;872.5549969515561;874.1608056265992;875.4090988582681;862.7541150772;872.3675335381861;872.4939535069676;872.6378552900538;874.9693760718376;631.8546734251101;636.8821767972939;636.9458596019344;638.1321402892063;640.3564417760122;12441.191322564004;12465;12528.310942898137;12567.434465449076;12574.43415046325;13116.27860467674;13812.309384530734;13921.23433211173;14050.789238161437;14258.928705356511;10696.304740191863;10786.676399708022;10821.218543837116;10972.890271097267;11058.281211721292;3253.5770349854606;3266.1344743642717;3278.1149089745873;3305.6694330566993;3329.067860998924;63174;63439.68280158616;64057.359426406074;64187.67906160486;64956;10359.63741269067;10508.306471609223;10534.841977370346;10590.417527036087;11116.221864469571;19482.902585486983;19636.607267854564;19943.800561994485;19991.700124498144;20087.196512139642;6261.373862613702;6376.5855219411515;6384.106225128486;6400.519961002943;6407.263164736115;3593.514875491775;3643.690286325639;3698.7780733156096;3714.4799728038097;3717.6096509866616;2834.4047749972324;2885.2209903325984;2905.535114381689;2907.3022474606364;2909.941801163965;450.7791182320639;452.60171049476907;454.3366684640396;461.457787100156;464.15060439395825;607.3804719186405;614.7940439952577;628.4658040665398;634.352959980817;643.1446176585131;7774.844503109906;8020.598970051591;8127.471714338549;8323.791905202419;8384.832303353898;599.9610025348426;626.614632001316;627.5356236385043;628.6102616377875;629.8393909553126;3757.680597149218;3810.847566097325;3835.5780864104927;4047.0894048839364;4240.491141063092;49352.75323623359;55979;57691.13463298054;59932;64998.67500662467;56514.71742641261;56579.71710141423;59106;59923;61444.692776535834;51760.48239517557;52183;52519.212211816855;52727;53067.20399194015;8482.151784821468;8608.698695545625;8639.222469977733;8731.825363492568;8774.34192435557;29305.413891722474;29959.400811983203;34565.48151777776;35927.820360898026;37103;43310.53515718672;43917.78041109774;43965.34051989287;44503.33245001392;45858;10753;11021.338719676845;11279.661610151708;11320.26418282809;11376.260543064674;13210.933945330213;13291;13483.662908427368;13538.58456617361;13559.389827457591;11132.499037543492;11151.665450036511;11291.943540282246;11748.70628234301;11909.761804763682;11234.101271898391;11366.488508016993;11372.488238029144;11435.313881167156;11697.88302117002;10842.78314433691;11176.552937882394;11887.702807429883;11899.762004759683;11931.701707457383;8752.606132723915;10453;10577.350813969168;10646.520906559379;11085.612003579836;9059.22996545301;9651.758706032406;9694.85457718149;9708.466034368177;9831.213502919607 04:29:30 INFO - PROCESS | 13497 | __end_tp_report 04:29:30 INFO - PROCESS | 13497 | __start_cc_report 04:29:30 INFO - PROCESS | 13497 | _x_x_mozilla_cycle_collect,331 04:29:30 INFO - PROCESS | 13497 | __end_cc_report 04:29:30 INFO - PROCESS | 13497 | __startTimestamp1483446570364__endTimestamp 04:29:30 INFO - PROCESS | 13497 | 04:29:30 INFO - PROCESS | 13497 | ------- Summary: start ------- 04:29:30 INFO - PROCESS | 13497 | Number of tests: 6 04:29:30 INFO - PROCESS | 13497 | 04:29:30 INFO - PROCESS | 13497 | [#0] dojo.html Cycles:165 Average:4778.21 Median:4922.41 stddev:512.53 (10.4%) stddev-sans-first:485.44 04:29:30 INFO - PROCESS | 13497 | Values: 2623.7 2633.7 2634.7 2658.6 2659.3 4813.6 4906.0 4922.4 4943.6 4974.5 4827.1 4896.4 4918.7 4934.7 4991.2 4410.6 4430.4 4482.4 4503.3 4566.6 4462.3 4514.6 4545.0 4559.6 4575.2 4349.6 4500.5 4517.1 4571.7 4573.9 4365.8 4433.0 4434.2 4437.6 4438.9 4357.1 4388.1 4397.3 4398.4 4406.6 4734.1 4773.2 4774.2 4781.7 4787.7 5102.4 5122.9 5128.2 5130.5 5152.0 5221.7 5234.7 5239.2 5269.8 5292.9 4861.1 4863.5 4863.7 4868.1 4905.0 5147.2 5153.2 5353.2 5360.8 5366.7 5027.9 5102.5 5103.7 5116.3 5174.1 5049.3 5175.2 5192.6 5196.4 5203.9 5078.5 5176.5 5199.1 5220.9 5274.1 4950.7 5216.5 5220.0 5227.9 5234.4 4295.2 4359.7 4367.2 4377.1 4442.0 3783.3 3796.0 3802.7 3831.9 3848.4 4360.7 4368.9 4378.2 4383.5 4420.5 5074.8 5095.7 5180.4 5214.4 5233.1 4396.2 4410.8 4411.3 4446.4 4459.6 4656.9 4686.8 4716.9 4729.1 4773.7 4707.7 4748.7 4877.4 4892.5 4917.7 5300.5 5307.2 5308.9 5332.7 5337.1 4907.8 4911.3 4921.6 4929.5 4955.4 4936.2 4957.3 4967.1 5171.3 5224.2 5056.5 5104.7 5119.8 5126.0 5126.1 4903.2 4929.4 4940.8 4947.8 4974.6 4931.0 4941.3 4957.9 4970.8 5094.3 4911.0 4941.4 4970.5 4996.9 5004.9 5023.6 5027.1 5058.8 5058.9 5086.9 4798.8 4858.1 4961.3 5040.0 5042.8 04:29:30 INFO - PROCESS | 13497 | 04:29:30 INFO - PROCESS | 13497 | [#1] ext.html Cycles:180 Average:46194.17 Median:19656.62 stddev:84709.68 (430.9%) stddev-sans-first:84877.89 04:29:30 INFO - PROCESS | 13497 | Values: 519.6 520.2 520.8 533.9 535.6 36355.3 38658.4 38714.4 41381.8 41615.2 38574.2 38838.4 38842.4 38933.4 38953.4 7663.4 7814.4 7853.3 7857.1 9372.8 9341.8 9703.6 9720.6 9723.2 9730.2 9735.8 9774.2 9781.2 9800.3 9829.0 9706.6 9751.3 9756.8 9768.5 9772.2 9541.3 9609.4 9624.6 9631.3 9638.8 33243.2 33354.2 33491.0 33654.3 33667.8 3413.6 3453.7 3476.5 3491.9 3518.5 25298.2 25355.5 29059.1 29521.6 31444.8 3545.3 3589.8 3596.1 3649.3 3660.5 233646.0 237994.0 239031.0 239365.0 239657.0 54055.0 55136.0 55205.2 55233.2 55289.4 58006.1 58094.0 58225.7 58649.4 58672.7 13812.2 14041.8 14053.7 14058.9 14072.4 8435.8 8747.6 9437.7 10149.4 10460.9 18513.8 18524.0 18544.0 18564.8 18587.9 6992.5 7015.9 7027.5 7117.2 7303.9 782.2 800.7 801.6 810.3 820.9 26800.3 27485.7 27699.4 27722.3 28074.2 946.9 952.8 967.1 973.4 981.2 13179.5 14311.3 14564.2 14669.0 14689.2 372511.0 375834.0 379336.0 379604.0 379620.0 42087.4 42545.4 42551.6 42584.0 42725.0 1219.5 1223.8 1240.0 1240.4 1244.0 23993.4 24803.8 25085.5 26051.6 26113.7 40439.4 40855.8 40908.8 40989.4 41065.4 331036.0 332300.0 333113.0 333895.0 334957.0 23218.0 23414.4 23686.4 24344.3 33157.0 35315.8 35621.5 35723.5 35989.5 36755.8 30773.8 31101.4 31413.4 31428.2 31665.7 30021.4 30693.0 30939.5 31433.8 31641.5 29965.7 30189.5 30435.4 30792.7 31058.0 26808.9 27373.2 28510.3 28656.9 28773.7 22032.2 22219.2 22287.7 22515.3 22582.8 04:29:30 INFO - PROCESS | 13497 | 04:29:30 INFO - PROCESS | 13497 | [#2] jquery.html Cycles:180 Average:22372.54 Median:4532.75 stddev:52298.17 (1153.8%) stddev-sans-first:52418.80 04:29:30 INFO - PROCESS | 13497 | Values: 374.6 377.5 380.6 393.1 400.0 15475.4 15977.7 16508.4 16682.0 16719.2 13949.4 16448.3 16469.7 16601.8 16609.4 4472.7 4688.9 4692.7 4697.2 4704.8 3582.4 3755.5 4592.8 4662.1 5174.9 5450.5 5522.7 5551.6 5559.6 5562.9 5331.6 5445.7 5487.9 5495.1 5547.1 5324.0 5338.1 5339.6 5340.8 5342.3 11898.1 20965.7 21717.7 21771.2 22044.9 2275.8 2395.2 2450.5 2451.8 2458.6 13394.2 13554.7 14083.2 14403.5 14638.9 1823.9 1850.7 1895.3 1896.1 1901.1 62569.7 73557.0 75521.6 76933.0 79695.0 15403.6 15788.4 15797.9 16124.1 16168.0 27023.5 27111.0 27188.2 27218.5 27421.0 8088.8 8153.1 8173.3 8292.7 8390.5 6651.2 6655.8 6722.5 6767.8 6801.8 8173.5 8265.4 8364.7 8397.4 8551.5 1532.4 3357.3 3389.2 3417.9 3507.4 899.5 938.1 941.5 953.9 975.9 15759.8 15774.4 15886.4 16110.5 16184.2 929.7 937.1 937.4 940.8 942.5 8706.5 8881.4 9059.9 9222.8 9237.9 312982.0 313491.0 315633.0 316272.0 318213.0 43653.6 53145.5 69112.0 70149.6 73608.6 863.1 877.2 903.6 904.8 905.1 14216.7 14284.0 14353.8 14380.9 14681.8 33541.0 34797.7 35111.5 35116.8 35281.1 47332.0 47458.8 47584.0 47594.3 47776.8 5823.5 6140.0 6849.1 7059.2 7234.1 10553.6 10620.8 11318.5 11334.6 11778.8 9626.6 9851.0 10146.6 10358.6 10416.4 10095.1 10363.3 10420.0 10512.1 10578.5 9945.7 10124.7 10290.0 10296.8 10438.2 6744.3 6918.6 6929.6 6930.8 7253.4 8379.7 9260.3 9484.3 9501.3 9956.3 04:29:30 INFO - PROCESS | 13497 | 04:29:30 INFO - PROCESS | 13497 | [#3] mootools.html Cycles:180 Average:4608.94 Median:5251.26 stddev:2404.37 (45.8%) stddev-sans-first:2398.39 04:29:30 INFO - PROCESS | 13497 | Values: 1317.4 1325.5 1329.7 1334.7 1335.9 6069.0 6265.2 6708.5 7125.0 7127.1 6645.4 6942.0 6944.7 7100.0 7103.7 2064.4 2127.7 2128.0 2128.5 2129.3 2084.8 2096.6 2146.7 2159.8 2169.6 2111.6 2137.3 2137.5 2138.1 2144.3 2079.4 2083.4 2097.2 2097.6 2105.3 2039.0 2099.0 2126.7 2127.7 2152.4 7044.5 7214.8 7226.4 7230.1 7237.2 4255.8 4366.2 4393.8 4396.5 4396.8 2710.8 2813.4 2889.2 2896.9 2901.0 1157.7 1171.9 1175.0 1211.8 1234.2 9172.0 9242.0 9248.4 9276.0 9297.4 3578.4 3761.3 3799.2 3803.0 3888.4 7493.0 7504.2 7514.0 7521.1 7537.2 4352.3 4362.2 4364.4 4369.3 4374.6 3875.3 3924.3 3979.7 4042.5 4058.8 3057.4 3101.2 3121.6 3149.1 3228.3 955.2 961.9 989.6 997.4 1007.9 823.8 852.3 865.0 879.5 884.4 4853.5 4855.5 4860.9 4951.0 4951.4 859.9 861.6 865.0 872.0 873.8 3324.3 3436.5 3472.6 3532.2 3562.6 7716.1 7882.3 8073.0 8085.3 8086.2 7900.5 8026.3 8027.8 8028.9 8032.5 6552.0 6593.9 6667.5 6672.4 6683.0 4600.6 4609.7 4707.3 4823.8 4897.4 7309.7 7631.6 7663.2 7716.2 7743.3 7577.3 7619.1 7672.4 7759.3 7765.7 6157.9 6235.3 6243.4 6260.6 6321.1 6531.5 6540.3 6540.9 6622.6 6634.9 6002.8 6066.7 6070.7 6154.5 6206.7 6064.7 6071.2 6075.7 6094.0 6105.2 5551.1 5629.5 5668.9 5681.9 5698.9 4069.4 4176.5 4202.1 4236.1 4240.7 4085.3 4101.4 4381.5 4434.7 4469.6 04:29:30 INFO - PROCESS | 13497 | 04:29:30 INFO - PROCESS | 13497 | [#4] prototype.html Cycles:180 Average:4248.66 Median:4820.51 stddev:1206.34 (25.0%) stddev-sans-first:1173.55 04:29:30 INFO - PROCESS | 13497 | Values: 342.6 346.2 356.3 357.0 357.8 4927.0 4929.9 4974.9 4985.2 5016.3 4853.6 4873.2 4892.6 4914.0 4921.5 3740.8 3884.6 3891.8 3955.6 4002.9 3948.0 3949.8 3961.6 3968.6 3971.7 3969.3 3972.4 3976.4 3977.3 3997.7 3882.3 3892.8 3900.9 3987.8 4004.7 3521.3 3533.5 3539.3 3545.7 3581.2 4789.6 4829.6 4841.3 4847.4 4862.7 4509.9 4535.3 4554.0 4555.5 4563.9 4908.1 5105.9 5124.2 5149.6 5157.9 3659.3 3672.5 3674.8 3676.7 3692.4 5405.6 5409.7 5445.6 5451.3 5464.3 3666.5 3716.9 3724.1 3730.9 3769.1 3790.1 3795.8 3804.8 3814.7 3815.8 4324.8 4327.2 4335.4 4352.5 4356.8 4964.8 5122.5 5185.1 5185.6 5206.1 1275.5 1276.9 1277.9 1279.6 1284.4 830.9 868.9 876.3 886.7 888.6 4225.0 4312.4 4366.9 4415.2 4469.2 5262.2 5272.9 5294.0 5299.4 5309.6 4465.2 4471.1 4477.5 4480.9 4481.4 2624.6 2717.0 2726.2 2736.2 2740.4 4765.4 4810.7 4843.6 4856.7 4861.7 5064.9 5213.2 5251.4 5313.6 5330.5 4753.8 4778.8 4790.0 4806.4 4811.4 5093.7 5126.0 5142.6 5147.6 5177.9 4859.6 5071.3 5087.4 5095.1 5102.5 4802.0 4803.6 4835.2 4838.6 4856.3 3842.8 3879.4 3884.9 3885.2 3900.7 4989.4 5151.9 5161.7 5171.1 5182.8 4903.4 4923.3 4969.0 4970.3 4975.8 4971.2 4996.7 5010.0 5031.5 5066.6 4755.0 4881.3 4882.4 4905.9 4973.8 4950.0 4986.4 4996.6 5061.9 5197.4 5111.5 5113.2 5136.2 5136.8 5137.1 04:29:30 INFO - PROCESS | 13497 | 04:29:30 INFO - PROCESS | 13497 | [#5] yui.html Cycles:180 Average:14604.51 Median:43941.56 stddev:17905.79 (40.7%) stddev-sans-first:17925.42 04:29:30 INFO - PROCESS | 13497 | Values: 662.1 666.5 667.0 670.7 696.8 12122.5 13058.3 13069.7 13092.8 13149.9 11127.6 12962.2 13009.1 13046.0 13061.0 668.3 780.6 805.3 811.4 812.7 814.7 817.6 823.8 825.1 826.8 866.2 872.2 872.6 874.2 875.4 862.8 872.4 872.5 872.6 875.0 631.9 636.9 636.9 638.1 640.4 12441.2 12465.0 12528.3 12567.4 12574.4 13116.3 13812.3 13921.2 14050.8 14258.9 10696.3 10786.7 10821.2 10972.9 11058.3 3253.6 3266.1 3278.1 3305.7 3329.1 63174.0 63439.7 64057.4 64187.7 64956.0 10359.6 10508.3 10534.8 10590.4 11116.2 19482.9 19636.6 19943.8 19991.7 20087.2 6261.4 6376.6 6384.1 6400.5 6407.3 3593.5 3643.7 3698.8 3714.5 3717.6 2834.4 2885.2 2905.5 2907.3 2909.9 450.8 452.6 454.3 461.5 464.2 607.4 614.8 628.5 634.4 643.1 7774.8 8020.6 8127.5 8323.8 8384.8 600.0 626.6 627.5 628.6 629.8 3757.7 3810.8 3835.6 4047.1 4240.5 49352.8 55979.0 57691.1 59932.0 64998.7 56514.7 56579.7 59106.0 59923.0 61444.7 51760.5 52183.0 52519.2 52727.0 53067.2 8482.2 8608.7 8639.2 8731.8 8774.3 29305.4 29959.4 34565.5 35927.8 37103.0 43310.5 43917.8 43965.3 44503.3 45858.0 10753.0 11021.3 11279.7 11320.3 11376.3 13210.9 13291.0 13483.7 13538.6 13559.4 11132.5 11151.7 11291.9 11748.7 11909.8 11234.1 11366.5 11372.5 11435.3 11697.9 10842.8 11176.6 11887.7 11899.8 11931.7 8752.6 10453.0 10577.4 10646.5 11085.6 9059.2 9651.8 9694.9 9708.5 9831.2 04:29:30 INFO - PROCESS | 13497 | -------- Summary: end -------- 04:29:30 INFO - PROCESS | 13497 | 04:29:31 INFO - TEST-INFO | 13497: exit 0 04:29:31 INFO - TEST-OK | dromaeo_css | took 1120623ms 04:29:31 INFO - TEST-START | kraken 04:29:31 INFO - operating with platform_type : linux_ 04:29:31 INFO - Initialising browser for kraken test... 04:29:31 INFO - TEST-INFO | started process 13853 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvrDGFk/profile http://localhost:40171/getInfo.html) 04:29:31 INFO - PROCESS | 13853 | 1483446571713 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 04:29:36 INFO - PROCESS | 13853 | __metrics Screen width/height:1600/1200 04:29:36 INFO - PROCESS | 13853 | colorDepth:24 04:29:36 INFO - PROCESS | 13853 | Browser inner width/height: 1024/697 04:29:36 INFO - PROCESS | 13853 | __metrics 04:29:36 ERROR - PROCESS | 13853 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 04:29:37 INFO - TEST-INFO | 13853: exit 0 04:29:37 INFO - Browser initialized. 04:29:37 INFO - Running cycle 1/1 for kraken test... 04:29:37 INFO - TEST-INFO | started process 13976 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvrDGFk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:29:49 INFO - PROCESS | 13976 | RSS: Main: 158724096 04:29:49 INFO - PROCESS | 13976 | 04:29:52 INFO - PROCESS | 13976 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40171/tests/kraken/driver.html?testName=audio-beat-detection) 04:29:53 INFO - PROCESS | 13976 | RSS: Main: 163962880 04:29:53 INFO - PROCESS | 13976 | 04:29:56 INFO - PROCESS | 13976 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40171/tests/kraken/driver.html?testName=audio-dft) 04:29:56 INFO - PROCESS | 13976 | RSS: Main: 162508800 04:29:56 INFO - PROCESS | 13976 | 04:29:59 INFO - PROCESS | 13976 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40171/tests/kraken/driver.html?testName=audio-fft) 04:30:00 INFO - PROCESS | 13976 | RSS: Main: 159113216 04:30:00 INFO - PROCESS | 13976 | 04:30:02 INFO - PROCESS | 13976 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40171/tests/kraken/driver.html?testName=audio-oscillator) 04:30:03 INFO - PROCESS | 13976 | RSS: Main: 159879168 04:30:03 INFO - PROCESS | 13976 | 04:30:05 INFO - PROCESS | 13976 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40171/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:30:05 INFO - PROCESS | 13976 | RSS: Main: 160210944 04:30:05 INFO - PROCESS | 13976 | 04:30:09 INFO - PROCESS | 13976 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40171/tests/kraken/driver.html?testName=imaging-darkroom) 04:30:09 INFO - PROCESS | 13976 | RSS: Main: 165285888 04:30:09 INFO - PROCESS | 13976 | 04:30:13 INFO - PROCESS | 13976 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40171/tests/kraken/driver.html?testName=imaging-desaturate) 04:30:13 INFO - PROCESS | 13976 | RSS: Main: 161685504 04:30:13 INFO - PROCESS | 13976 | 04:30:16 INFO - PROCESS | 13976 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40171/tests/kraken/driver.html?testName=json-parse-financial) 04:30:17 INFO - PROCESS | 13976 | RSS: Main: 162906112 04:30:17 INFO - PROCESS | 13976 | 04:30:19 INFO - PROCESS | 13976 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40171/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:30:19 INFO - PROCESS | 13976 | RSS: Main: 162689024 04:30:19 INFO - PROCESS | 13976 | 04:30:21 INFO - PROCESS | 13976 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40171/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:30:22 INFO - PROCESS | 13976 | RSS: Main: 162848768 04:30:22 INFO - PROCESS | 13976 | 04:30:24 INFO - PROCESS | 13976 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40171/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:30:25 INFO - PROCESS | 13976 | RSS: Main: 164130816 04:30:25 INFO - PROCESS | 13976 | 04:30:28 INFO - PROCESS | 13976 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40171/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:30:28 INFO - PROCESS | 13976 | RSS: Main: 164155392 04:30:28 INFO - PROCESS | 13976 | 04:30:31 INFO - PROCESS | 13976 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40171/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:30:32 INFO - PROCESS | 13976 | RSS: Main: 163737600 04:30:32 INFO - PROCESS | 13976 | 04:30:34 INFO - PROCESS | 13976 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40171/tests/kraken/driver.html?testName=ai-astar) 04:30:34 INFO - PROCESS | 13976 | RSS: Main: 165371904 04:30:34 INFO - PROCESS | 13976 | 04:30:34 INFO - PROCESS | 13976 | __start_tp_report 04:30:34 INFO - PROCESS | 13976 | _x_x_mozilla_page_load 04:30:34 INFO - PROCESS | 13976 | _x_x_mozilla_page_load_details 04:30:34 INFO - PROCESS | 13976 | |i|pagename|runs| 04:30:34 INFO - PROCESS | 13976 | |0;ai-astar;111;117;117;116;115;116;117;116;116;116 04:30:34 INFO - PROCESS | 13976 | |1;audio-beat-detection;155;132;128;178;128;130;128;128;149;133 04:30:34 INFO - PROCESS | 13976 | |2;audio-dft;162;166;174;165;163;162;164;163;163;163 04:30:34 INFO - PROCESS | 13976 | |3;audio-fft;77;78;78;117;85;78;77;77;95;78 04:30:34 INFO - PROCESS | 13976 | |4;audio-oscillator;86;85;109;85;84;85;109;84;85;108 04:30:34 INFO - PROCESS | 13976 | |5;imaging-gaussian-blur;121;122;121;119;119;118;120;117;118;118 04:30:34 INFO - PROCESS | 13976 | |6;imaging-darkroom;150;152;151;151;151;151;150;152;149;150 04:30:34 INFO - PROCESS | 13976 | |7;imaging-desaturate;96;96;96;96;95;96;96;96;95;97 04:30:34 INFO - PROCESS | 13976 | |8;json-parse-financial;64;65;65;65;68;67;66;65;66;66 04:30:34 INFO - PROCESS | 13976 | |9;json-stringify-tinderbox;67;67;67;68;67;68;67;68;68;69 04:30:34 INFO - PROCESS | 13976 | |10;stanford-crypto-aes;90;85;92;88;85;86;84;84;83;84 04:30:34 INFO - PROCESS | 13976 | |11;stanford-crypto-ccm;148;147;141;139;141;141;143;150;184;142 04:30:34 INFO - PROCESS | 13976 | |12;stanford-crypto-pbkdf2;183;186;180;180;182;187;188;184;182;183 04:30:34 INFO - PROCESS | 13976 | |13;stanford-crypto-sha256-iterative;71;70;71;74;70;69;69;69;71;68 04:30:34 INFO - PROCESS | 13976 | __end_tp_report 04:30:34 INFO - PROCESS | 13976 | __start_cc_report 04:30:34 INFO - PROCESS | 13976 | _x_x_mozilla_cycle_collect,798 04:30:34 INFO - PROCESS | 13976 | __end_cc_report 04:30:34 INFO - PROCESS | 13976 | __startTimestamp1483446634602__endTimestamp 04:30:34 INFO - PROCESS | 13976 | 04:30:34 INFO - PROCESS | 13976 | ------- Summary: start ------- 04:30:34 INFO - PROCESS | 13976 | Number of tests: 14 04:30:34 INFO - PROCESS | 13976 | 04:30:34 INFO - PROCESS | 13976 | [#0] ai-astar Cycles:10 Average:115.70 Median:116.00 stddev:1.77 (1.5%) stddev-sans-first:0.67 04:30:34 INFO - PROCESS | 13976 | Values: 111.0 117.0 117.0 116.0 115.0 116.0 117.0 116.0 116.0 116.0 04:30:34 INFO - PROCESS | 13976 | 04:30:34 INFO - PROCESS | 13976 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:132.50 stddev:16.76 (12.6%) stddev-sans-first:16.73 04:30:34 INFO - PROCESS | 13976 | Values: 155.0 132.0 128.0 178.0 128.0 130.0 128.0 128.0 149.0 133.0 04:30:34 INFO - PROCESS | 13976 | 04:30:34 INFO - PROCESS | 13976 | [#2] audio-dft Cycles:10 Average:164.50 Median:163.50 stddev:3.57 (2.2%) stddev-sans-first:3.67 04:30:34 INFO - PROCESS | 13976 | Values: 162.0 166.0 174.0 165.0 163.0 162.0 164.0 163.0 163.0 163.0 04:30:34 INFO - PROCESS | 13976 | 04:30:34 INFO - PROCESS | 13976 | [#3] audio-fft Cycles:10 Average:84.00 Median:78.00 stddev:12.92 (16.6%) stddev-sans-first:13.45 04:30:34 INFO - PROCESS | 13976 | Values: 77.0 78.0 78.0 117.0 85.0 78.0 77.0 77.0 95.0 78.0 04:30:34 INFO - PROCESS | 13976 | 04:30:34 INFO - PROCESS | 13976 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:85.00 stddev:11.52 (13.6%) stddev-sans-first:12.01 04:30:34 INFO - PROCESS | 13976 | Values: 86.0 85.0 109.0 85.0 84.0 85.0 109.0 84.0 85.0 108.0 04:30:34 INFO - PROCESS | 13976 | 04:30:34 INFO - PROCESS | 13976 | [#5] imaging-gaussian-blur Cycles:10 Average:119.30 Median:119.50 stddev:1.64 (1.4%) stddev-sans-first:1.62 04:30:34 INFO - PROCESS | 13976 | Values: 121.0 122.0 121.0 119.0 119.0 118.0 120.0 117.0 118.0 118.0 04:30:34 INFO - PROCESS | 13976 | 04:30:34 INFO - PROCESS | 13976 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 04:30:34 INFO - PROCESS | 13976 | Values: 150.0 152.0 151.0 151.0 151.0 151.0 150.0 152.0 149.0 150.0 04:30:34 INFO - PROCESS | 13976 | 04:30:34 INFO - PROCESS | 13976 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 04:30:34 INFO - PROCESS | 13976 | Values: 96.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 97.0 04:30:34 INFO - PROCESS | 13976 | 04:30:34 INFO - PROCESS | 13976 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:66.00 stddev:1.16 (1.8%) stddev-sans-first:1.05 04:30:34 INFO - PROCESS | 13976 | Values: 64.0 65.0 65.0 65.0 68.0 67.0 66.0 65.0 66.0 66.0 04:30:34 INFO - PROCESS | 13976 | 04:30:34 INFO - PROCESS | 13976 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 04:30:34 INFO - PROCESS | 13976 | Values: 67.0 67.0 67.0 68.0 67.0 68.0 67.0 68.0 68.0 69.0 04:30:34 INFO - PROCESS | 13976 | 04:30:34 INFO - PROCESS | 13976 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:85.50 stddev:2.96 (3.5%) stddev-sans-first:2.78 04:30:34 INFO - PROCESS | 13976 | Values: 90.0 85.0 92.0 88.0 85.0 86.0 84.0 84.0 83.0 84.0 04:30:34 INFO - PROCESS | 13976 | 04:30:34 INFO - PROCESS | 13976 | [#11] stanford-crypto-ccm Cycles:10 Average:147.60 Median:145.00 stddev:13.28 (9.2%) stddev-sans-first:14.09 04:30:34 INFO - PROCESS | 13976 | Values: 148.0 147.0 141.0 139.0 141.0 141.0 143.0 150.0 184.0 142.0 04:30:34 INFO - PROCESS | 13976 | 04:30:34 INFO - PROCESS | 13976 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.50 Median:183.50 stddev:2.76 (1.5%) stddev-sans-first:2.92 04:30:34 INFO - PROCESS | 13976 | Values: 183.0 186.0 180.0 180.0 182.0 187.0 188.0 184.0 182.0 183.0 04:30:34 INFO - PROCESS | 13976 | 04:30:34 INFO - PROCESS | 13976 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.50 stddev:1.69 (2.4%) stddev-sans-first:1.76 04:30:34 INFO - PROCESS | 13976 | Values: 71.0 70.0 71.0 74.0 70.0 69.0 69.0 69.0 71.0 68.0 04:30:34 INFO - PROCESS | 13976 | -------- Summary: end -------- 04:30:34 INFO - PROCESS | 13976 | 04:30:35 INFO - TEST-INFO | 13976: exit 0 04:30:35 INFO - TEST-OK | kraken | took 64519ms 04:30:35 INFO - SUITE-END | took 1185s 04:30:35 INFO - Completed test suite (00:19:45) 04:30:35 INFO - javascript benchmark 04:30:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6350.595765998708, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2623.7245089265625, 2633.7102918678943, 2634.7496987786153, 2658.6277921091046, 2659.2554084856233, 4813.6389770767155, 4905.975470122648, 4922.409310882695, 4943.5550800428, 4974.502549745023, 4827.058723548909, 4896.412430508344, 4918.70487770734, 4934.654574179809, 4991.176455884774, 4410.55894410558, 4430.379746835446, 4482.372467854503, 4503.279475283955, 4566.611837993774, 4462.263726485142, 4514.564560069454, 4545.045540436512, 4559.612432943204, 4575.199340115483, 4349.608535231844, 4500.5274446183, 4517.141743068839, 4571.702839315451, 4573.908521829561, 4365.803538840728, 4432.977835110836, 4434.157510073108, 4437.64498840092, 4438.911221775546, 4357.063231405232, 4388.078503514266, 4397.31841564558, 4398.406215160944, 4406.581374769392, 4734.124187025412, 4773.236282194867, 4774.212254977924, 4781.713097214179, 4787.736674482902, 5102.36220472441, 5122.897542049138, 5128.1794912813775, 5130.538251557377, 5151.974240128813, 5221.738913054332, 5234.659747116425, 5239.16173412256, 5269.789208431658, 5292.894142117175, 4861.149298872719, 4863.489333619919, 4863.7324947128245, 4868.099401610678, 4904.950950490521, 5147.176451767699, 5153.227015947563, 5353.197020446886, 5360.785568577213, 5366.731663416892, 5027.949720502748, 5102.540771330598, 5103.668261562986, 5116.30929824469, 5174.094533456705, 5049.293098966147, 5175.171972484384, 5192.61055420845, 5196.402413722471, 5203.9219411708855, 5078.4667609900425, 5176.482351764794, 5199.1161502544655, 5220.947790522122, 5274.077036518594, 4950.6782059166035, 5216.504432078947, 5220.0, 5227.895442091137, 5234.398044224887, 4295.183915056129, 4359.673024523174, 4367.192069467159, 4377.124575084996, 4442.044960333544, 3783.319002579562, 3796.0, 3802.657760801486, 3831.9425208621337, 3848.3842585186235, 4360.716553424018, 4368.934465983013, 4378.16814805186, 4383.539728328544, 4420.535843736426, 5074.847754567369, 5095.745212739348, 5180.430152683201, 5214.374275087014, 5233.136532472099, 4396.1867054595, 4410.823567057346, 4411.316245981878, 4446.3552784846015, 4459.576340247671, 4656.8602941911795, 4686.7656617169005, 4716.9056618867435, 4729.12511185425, 4773.689710168897, 4707.693999889996, 4748.738819364969, 4877.3903262092235, 4892.461829198714, 4917.704937703749, 5300.469953004668, 5307.150855863198, 5308.946910530845, 5332.653377530448, 5337.119375303031, 4907.803687852446, 4911.287863259879, 4921.557059864629, 4929.482404347492, 4955.40535135786, 4936.160852654985, 4957.3059771632725, 4967.05625931072, 5171.276021357088, 5224.242484839753, 5056.494350564914, 5104.719240441811, 5119.795208191631, 5126.0, 5126.128558145198, 4903.239997800347, 4929.433115191656, 4940.802367905388, 4947.802087916443, 4974.626902982219, 4930.975345123252, 4941.258811178352, 4957.925631115464, 4970.776315065903, 5094.337736094284, 4910.950890491193, 4941.357623508921, 4970.527799859007, 4996.900061998813, 5004.924926126184, 5023.623228257822, 5027.120253955616, 5058.848234552969, 5058.898822023465, 5086.872828179326, 4798.832040878692, 4858.05267972742, 4961.305417241661, 5040.042391945519, 5042.823501177441], "value": 4744.45262110015, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [519.5895242758221, 520.2222677097742, 520.7786690656473, 533.9332583427072, 535.6304150136406, 36355.272894542126, 38658.42012369817, 38714.41928371077, 41381.7930910345, 41615.16769664605, 38574.22851542968, 38838.41742373867, 38842.41736373949, 38933.41599875997, 38953.41569876454, 7663.386929045677, 7814.413918956073, 7853.253940875607, 7857.096433910087, 9372.812543749122, 9341.81316373672, 9703.563339649698, 9720.61117555297, 9723.173530249936, 9730.172935300472, 9735.756606084833, 9774.169195618346, 9781.168600668952, 9800.31397802154, 9829.017098290149, 9706.563204655808, 9751.268654850914, 9756.756081097958, 9768.462734549597, 9772.21822254218, 9541.33210675253, 9609.423434593948, 9624.615015399375, 9631.277654175965, 9638.807223855554, 33243.16892077717, 33354.166145846306, 33491.0, 33654.32691346159, 33667.83166084178, 3413.5562376891094, 3453.6546345365514, 3476.4785282207617, 3491.8603255869734, 3518.5074089627474, 25298.241052768262, 25355.49289014228, 29059.12822615325, 29521.557176642367, 31444.842775786205, 3545.3441113394106, 3589.766665166756, 3596.118950857057, 3649.3066317399607, 3660.4509323601405, 233646.0, 237994.0, 239031.0, 239365.0, 239657.0, 54055.0, 55136.0, 55205.1719224212, 55233.171502427496, 55289.44710552924, 58006.129908051415, 58094.0, 58225.70887145537, 58649.413505864395, 58672.706636466544, 13812.171269723849, 14041.78937315941, 14053.71892562143, 14058.859411405754, 14072.437102515989, 8435.831283374298, 8747.562621868881, 9437.716868493957, 10149.441780702133, 10460.895391046144, 18513.81486185121, 18524.0, 18544.0, 18564.814351856578, 18587.90706046461, 6992.510524263253, 7015.89476157858, 7027.508074434741, 7117.181524124689, 7303.89044164338, 782.1513657681365, 800.7357572001225, 801.5551368990266, 810.3193317613233, 820.8973878265217, 26800.32999174997, 27485.738484916106, 27699.446011079664, 27722.306942326602, 28074.157775266776, 946.9384490008127, 952.8427809411509, 967.1025766162377, 973.445136272318, 981.190517822799, 13179.53871614508, 14311.257651447553, 14564.198969056804, 14669.046511976901, 14689.19209443491, 372511.0, 375834.0, 379336.0, 379604.0, 379620.0, 42087.36868946968, 42545.36181957273, 42551.57448425538, 42584.0, 42725.0, 1219.5304807648943, 1223.7552489502136, 1239.9566015189425, 1240.4170040081146, 1244.0, 23993.400164996016, 24803.751962480143, 25085.49829003373, 26051.609225861248, 26113.73886261189, 40439.39340909947, 40855.795721021204, 40908.795456022526, 40989.38515922204, 41065.38401924033, 331036.0, 332300.0, 333113.0, 333895.0, 334957.0, 23218.0, 23414.414639633465, 23686.407839804142, 24344.26967190987, 33157.00528984134, 35315.82342088376, 35621.46567801537, 35723.46414803728, 35989.460158098176, 36755.81622091872, 30773.8461307692, 31101.377972439972, 31413.371732565676, 31428.214294642818, 31665.683343167195, 30021.399572008002, 30693.0, 30939.535906961864, 31433.8428307857, 31641.525377119822, 29965.70034299629, 30189.547156793105, 30435.412989896107, 30792.692073079877, 31058.0, 26808.8659556701, 27373.178804635892, 28510.287242818267, 28656.856715716287, 28773.71226287794, 22032.228871989402, 22219.22232721847, 22287.739360910196, 22515.324540263817, 22582.774172258723], "value": 17225.664524383068, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.6253746253746, 377.52997518089984, 380.6402949212994, 393.1115678566439, 399.96600288975435, 15475.38098476061, 15977.68044639108, 16508.422205222803, 16682.0, 16719.247633856474, 13949.442022319121, 16448.259828307724, 16469.67060658786, 16601.83398166018, 16609.418670346542, 4472.664550158743, 4688.929666054994, 4692.6949748266425, 4697.201475749131, 4704.835330763407, 3582.390993531106, 3755.5493340799144, 4592.839250626229, 4662.137504561667, 5174.896502069956, 5450.5367043801325, 5522.696251706175, 5551.583631227674, 5559.583031272671, 5562.86092847678, 5331.626786124993, 5445.727713614343, 5487.862803429906, 5495.148252020923, 5547.11246200608, 5323.973380133075, 5338.092524270884, 5339.6262261641705, 5340.839774806762, 5342.332208473941, 11898.107641926803, 20965.68551471729, 21717.67423488649, 21771.23800666985, 22044.88977555118, 2275.8179345652306, 2395.1616934072936, 2450.5221481811054, 2451.767082127195, 2458.606622940321, 13394.196348219139, 13554.728905421935, 14083.155010699391, 14403.495877644336, 14638.926805365905, 1823.9361622343154, 1850.7408962745226, 1895.2608482691762, 1896.1467339697192, 1901.1254822781398, 62569.68715156441, 73557.0, 75521.6223918877, 76933.0, 79694.99999999942, 15403.614909627126, 15788.447404340794, 15797.921010395105, 16124.11317377532, 16168.0, 27023.459530809272, 27111.0, 27188.1843544694, 27218.45563088727, 27421.0, 8088.78668199763, 8153.1439198884445, 8173.264406203471, 8292.668293268322, 8390.454620449651, 6651.201855777241, 6655.768682793699, 6722.462203023746, 6767.830804229835, 6801.761938332134, 8173.509589424653, 8265.421420500506, 8364.665413383396, 8397.412181147383, 8551.529665868313, 1532.364333346642, 3357.3285342931513, 3389.1527118220447, 3417.8974630761118, 3507.3686736387695, 899.4648184330313, 938.0525669074284, 941.5010044676333, 953.8855337359561, 975.8926518083006, 15759.763603545956, 15774.447894323643, 15886.364545418284, 16110.516684499484, 16184.190790460665, 929.6885543343055, 937.1471960515897, 937.4281688170211, 940.8447606145046, 942.5240253671852, 8706.47761134334, 8881.37830351882, 9059.909400906039, 9222.76943076415, 9237.861432078524, 312982.0, 313491.0, 315633.0, 316272.0, 318213.0, 43653.56346436559, 53145.46854531483, 69112.0, 70149.64925175342, 73608.63195683988, 863.0629828129752, 877.2280393253895, 903.6385445821724, 904.7964208053136, 905.0542183418344, 14216.715665686836, 14284.0, 14353.784693229401, 14380.856191437952, 14681.779773303622, 33541.0, 34797.652023480456, 35111.47332789959, 35116.82441587776, 35281.1179720509, 47332.0, 47458.76270618625, 47584.0, 47594.286085709435, 47776.7611161942, 5823.505002074701, 6139.969300153471, 6849.1096157499205, 7059.188193357624, 7234.095738032746, 10553.630622928467, 10620.787584248426, 11318.4906679198, 11334.60328888485, 11778.76442471163, 9626.614935402786, 9851.0, 10146.594136234467, 10358.637447689294, 10416.427096509764, 10095.091441770275, 10363.274570780275, 10420.0, 10512.106470950055, 10578.523966421375, 9945.651902183388, 10124.746881327732, 10290.0, 10296.794064118525, 10438.164946804389, 6744.325567443217, 6918.584884906922, 6929.618870962146, 6930.787112255436, 7253.3834624057545, 8379.734824839523, 9260.30547708911, 9484.288678349289, 9501.337265978564, 9956.303058785816], "value": 8626.461696485167, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1317.3874148520938, 1325.4565628092485, 1329.7207586406855, 1334.7263810918762, 1335.9473602817561, 6069.0, 6265.154204182445, 6708.530402871801, 7124.964375178123, 7127.109111361074, 6645.4019138277545, 6942.0, 6944.6874890629915, 7100.0, 7103.715851365952, 2064.401323616153, 2127.6702111172795, 2128.0104751290646, 2128.4998025464, 2129.2866889592005, 2084.8220755273296, 2096.5911647228795, 2146.7423909130925, 2159.7948194921455, 2169.642009068502, 2111.5987962287195, 2137.348108826807, 2137.4976880433087, 2138.0592539282743, 2144.3138195777356, 2079.4281572567515, 2083.3749875037506, 2097.2449918029497, 2097.5699981503753, 2105.284203370861, 2038.9592208155755, 2098.9580208395746, 2126.7022616833656, 2127.723395958531, 2152.4296061543705, 7044.471664625174, 7214.819629509252, 7226.421886249087, 7230.060092187982, 7237.240089790602, 4255.8084886180195, 4366.170427618774, 4393.78031098447, 4396.472423309224, 4396.846110386153, 2710.823796453244, 2813.38105616764, 2889.1765846733792, 2896.8986085487118, 2900.9564856527168, 1157.6816375496721, 1171.94140292985, 1175.0364700945229, 1211.7818792617325, 1234.2286071205497, 9171.954140229323, 9241.95379023114, 9248.39885407453, 9276.0, 9297.442153470745, 3578.4274516077303, 3761.285355782393, 3799.1831756172555, 3803.0492376905772, 3888.358420860526, 7493.025906632103, 7504.174540800507, 7514.0, 7521.05986751656, 7537.2462753724185, 4352.347147927836, 4362.21480133579, 4364.388985542027, 4369.344598310279, 4374.562543745664, 3875.2830726315724, 3924.3132451820816, 3979.7015223858325, 4042.4946881639794, 4058.7564746115327, 3057.4496590613903, 3101.1936896407096, 3121.562981182636, 3149.10250578584, 3228.322052368982, 955.1928620315822, 961.8749562556823, 989.6387818446359, 997.3567049253191, 1007.9496025198711, 823.81052357958, 852.3011130872749, 864.9913500865036, 879.5338470610586, 884.429542944797, 4853.490383509751, 4855.5387238212315, 4860.854174374775, 4950.960298337318, 4951.405831300195, 859.9226069653761, 861.5562985062697, 865.0, 872.0015582158393, 873.7990262239593, 3324.335132973415, 3436.518887355772, 3472.6353732857688, 3532.2405682778326, 3562.6437356264682, 7716.112647045549, 7882.251186137308, 8073.031236251687, 8085.312748416332, 8086.150954149847, 7900.486468379537, 8026.277635012877, 8027.759167224993, 8028.879566806502, 8032.518048917083, 6551.967240163769, 6593.86812263752, 6667.466602671775, 6672.366125218096, 6683.0, 4600.608948239437, 4609.723416595015, 4707.29390591414, 4823.758812059313, 4897.436794768647, 7309.671064801991, 7631.618419078913, 7663.195364486649, 7716.189800070912, 7743.303102720783, 7577.318041376303, 7619.123800762762, 7672.386209103147, 7759.262870027338, 7765.72819951299, 6157.907631385622, 6235.251769787655, 6243.406876346739, 6260.561760676891, 6321.146645203023, 6531.542792004704, 6540.280569137296, 6540.934590654033, 6622.63575503352, 6634.9004764927595, 6002.759889604367, 6066.726997285221, 6070.666113363631, 6154.538409619386, 6206.658633775186, 6064.727087280995, 6071.210742603434, 6075.665838378754, 6094.024956007018, 6105.17580126695, 5551.111822108443, 5629.521490673174, 5668.858278542904, 5681.8863622726485, 5698.914516282176, 4069.4302797607766, 4176.4570605821045, 4202.138561594927, 4236.110416812504, 4240.745555266694, 4085.325921222965, 4101.384792281182, 4381.539938306432, 4434.667399944952, 4469.642428605639], "value": 3818.4501764351894, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.5615212527965, 346.2469129643027, 356.3247645711376, 357.04668535011535, 357.7513628028518, 4926.950730492694, 4929.87675308117, 4974.925376119361, 4985.152524070908, 5016.27264046713, 4853.563179313861, 4873.171560834658, 4892.633052521057, 4913.950860491403, 4921.507849215077, 3740.831662575191, 3884.59211782763, 3891.8443262269475, 3955.5846636103224, 4002.919941601166, 3948.0, 3949.780928543242, 3961.584033676466, 3968.6229808168177, 3971.6624086952643, 3969.30537155998, 3972.398079258076, 3976.3637817949134, 3977.34373828318, 3997.7001724870606, 3882.281777871103, 3892.7957805569918, 3900.8634697785724, 3987.7806720630356, 4004.7196696231276, 3521.2605352875926, 3533.4876442915634, 3539.256756081226, 3545.6808887200277, 3581.247937933037, 4789.616830653575, 4829.565339119461, 4841.273808928654, 4847.442544107437, 4862.6839255448285, 4509.86470405885, 4535.319702044687, 4553.998120413504, 4555.4533455985165, 4563.863084107482, 4908.116539022974, 5105.851183483724, 5124.205748109011, 5149.562287205592, 5157.896842063138, 3659.26814637071, 3672.467492213641, 3674.8056881513617, 3676.742628016013, 3692.3538380783525, 5405.621606487587, 5409.675419474844, 5445.646033007842, 5451.3458384993655, 5464.26232458617, 3666.4866918631415, 3716.9442458362605, 3724.1248306647917, 3730.850765969331, 3769.1142581493327, 3790.1093243087853, 3795.772253664734, 3804.771713697187, 3814.7329686922203, 3815.828287727059, 4324.827006919751, 4327.156204540147, 4335.393044973706, 4352.499462561783, 4356.847510337123, 4964.751762411865, 5122.487751224922, 5185.144451165515, 5185.559227465707, 5206.114960456732, 1275.4515558309831, 1276.8914642255327, 1277.8913792327755, 1279.6033229698824, 1284.4155909061355, 830.9086000539936, 868.921797038257, 876.268315956171, 886.7162507997508, 888.6090120347027, 4224.950898814072, 4312.417823593774, 4366.934495982563, 4415.205263052681, 4469.173202957463, 5262.158054711304, 5272.868178295574, 5293.967676303161, 5299.4435584263865, 5309.5752339812725, 4465.218586747306, 4471.06107717383, 4477.462704475483, 4480.865574032784, 4481.395011673448, 2624.645672834143, 2716.9864150679514, 2726.1821453563853, 2736.166768265267, 2740.410811675499, 4765.404324459442, 4810.735409552508, 4843.588294994965, 4856.660033797601, 4861.708297502161, 5064.873378165576, 5213.201445501296, 5251.36983561975, 5313.57491400687, 5330.466953304638, 4753.762311884392, 4778.761061946958, 4789.976050119727, 4806.447258565309, 4811.446683631357, 5093.668911520739, 5126.0, 5142.614303927146, 5147.56245719118, 5177.91263834599, 4859.562639362474, 5071.264666623393, 5087.389513258433, 5095.146717838023, 5102.540771330598, 4802.0, 4803.567678908915, 4835.162638197462, 4838.604890579186, 4856.271559266138, 3842.830528876201, 3879.4180872869297, 3884.892805550405, 3885.203533275728, 3900.707446941434, 4989.35138432016, 5151.896962060663, 5161.657968928031, 5171.146760784429, 5182.827823602037, 4903.387076615423, 4923.310736496822, 4968.950310496849, 4970.27930950003, 4975.776090075883, 4971.229459433794, 4996.650234483552, 5010.0, 5031.459113147837, 5066.5693416058575, 4755.004347261203, 4881.29221262922, 4882.414110306786, 4905.914986130809, 4973.801047958041, 4949.960508293155, 4986.351774269322, 4996.6002719783055, 5061.898762024665, 5197.428282888804, 5111.4888511150075, 5113.207452844815, 5136.152534831711, 5136.845894623168, 5137.075326441127], "value": 3875.518551921513, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.1458318768786, 666.4934649666252, 666.9733210671574, 670.7149461478873, 696.7839969609421, 12122.45448954797, 13058.347082645878, 13069.67325816854, 13092.803607945889, 13149.868501314995, 11127.554897804079, 12962.222266663983, 13009.089363744542, 13046.0, 13060.955123590114, 668.2582333609689, 780.6174974262627, 805.2752522729531, 811.4036183405193, 812.743985644523, 814.7352110564061, 817.6279792694339, 823.7611092783086, 825.0594322472386, 826.7850358906697, 866.1901122450497, 872.16708043818, 872.5549969515561, 874.1608056265992, 875.4090988582681, 862.7541150772, 872.3675335381861, 872.4939535069676, 872.6378552900538, 874.9693760718376, 631.8546734251101, 636.8821767972939, 636.9458596019344, 638.1321402892063, 640.3564417760122, 12441.191322564004, 12465.0, 12528.310942898137, 12567.434465449076, 12574.43415046325, 13116.27860467674, 13812.309384530734, 13921.23433211173, 14050.789238161437, 14258.928705356511, 10696.304740191863, 10786.676399708022, 10821.218543837116, 10972.890271097267, 11058.281211721292, 3253.5770349854606, 3266.1344743642717, 3278.1149089745873, 3305.6694330566993, 3329.067860998924, 63174.0, 63439.68280158616, 64057.359426406074, 64187.67906160486, 64956.0, 10359.63741269067, 10508.306471609223, 10534.841977370346, 10590.417527036087, 11116.221864469571, 19482.902585486983, 19636.607267854564, 19943.800561994485, 19991.700124498144, 20087.196512139642, 6261.373862613702, 6376.5855219411515, 6384.106225128486, 6400.519961002943, 6407.263164736115, 3593.514875491775, 3643.690286325639, 3698.7780733156096, 3714.4799728038097, 3717.6096509866616, 2834.4047749972324, 2885.2209903325984, 2905.535114381689, 2907.3022474606364, 2909.941801163965, 450.7791182320639, 452.60171049476907, 454.3366684640396, 461.457787100156, 464.15060439395825, 607.3804719186405, 614.7940439952577, 628.4658040665398, 634.352959980817, 643.1446176585131, 7774.844503109906, 8020.598970051591, 8127.471714338549, 8323.791905202419, 8384.832303353898, 599.9610025348426, 626.614632001316, 627.5356236385043, 628.6102616377875, 629.8393909553126, 3757.680597149218, 3810.847566097325, 3835.5780864104927, 4047.0894048839364, 4240.491141063092, 49352.75323623359, 55979.0, 57691.13463298054, 59932.0, 64998.67500662467, 56514.71742641261, 56579.71710141423, 59106.0, 59923.0, 61444.692776535834, 51760.48239517557, 52183.0, 52519.212211816855, 52727.0, 53067.20399194015, 8482.151784821468, 8608.698695545625, 8639.222469977733, 8731.825363492568, 8774.34192435557, 29305.413891722474, 29959.400811983203, 34565.48151777776, 35927.820360898026, 37103.0, 43310.53515718672, 43917.78041109774, 43965.34051989287, 44503.33245001392, 45858.0, 10753.0, 11021.338719676845, 11279.661610151708, 11320.26418282809, 11376.260543064674, 13210.933945330213, 13291.0, 13483.662908427368, 13538.58456617361, 13559.389827457591, 11132.499037543492, 11151.665450036511, 11291.943540282246, 11748.70628234301, 11909.761804763682, 11234.101271898391, 11366.488508016993, 11372.488238029144, 11435.313881167156, 11697.88302117002, 10842.78314433691, 11176.552937882394, 11887.702807429883, 11899.762004759683, 11931.701707457383, 8752.606132723915, 10453.0, 10577.350813969168, 10646.520906559379, 11085.612003579836, 9059.22996545301, 9651.758706032406, 9694.85457718149, 9708.466034368177, 9831.213502919607], "value": 6286.710093227967, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1581.6999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 117.0, 117.0, 116.0, 115.0, 116.0, 117.0, 116.0, 116.0, 116.0], "value": 115.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 132.0, 128.0, 178.0, 128.0, 130.0, 128.0, 128.0, 149.0, 133.0], "value": 138.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 174.0, 165.0, 163.0, 162.0, 164.0, 163.0, 163.0, 163.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 117.0, 85.0, 78.0, 77.0, 77.0, 95.0, 78.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 109.0, 85.0, 84.0, 85.0, 109.0, 84.0, 85.0, 108.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 122.0, 121.0, 119.0, 119.0, 118.0, 120.0, 117.0, 118.0, 118.0], "value": 119.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 151.0, 151.0, 151.0, 151.0, 150.0, 152.0, 149.0, 150.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 97.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 68.0, 67.0, 66.0, 65.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 68.0, 67.0, 68.0, 67.0, 68.0, 68.0, 69.0], "value": 67.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 85.0, 92.0, 88.0, 85.0, 86.0, 84.0, 84.0, 83.0, 84.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 141.0, 139.0, 141.0, 141.0, 143.0, 150.0, 184.0, 142.0], "value": 147.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 186.0, 180.0, 180.0, 182.0, 187.0, 188.0, 184.0, 182.0, 183.0], "value": 183.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 71.0, 74.0, 70.0, 69.0, 69.0, 69.0, 71.0, 68.0], "value": 70.2, "unit": "score"}]}]} 04:30:35 INFO - Return code: 0 04:30:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:30:35 ERROR - # TBPL SUCCESS # 04:30:35 INFO - Running post-action listener: _resource_record_post_action 04:30:35 INFO - [mozharness: 2017-01-03 12:30:35.929953Z] Finished run-tests step (success) 04:30:35 INFO - Running post-run listener: _resource_record_post_run 04:30:36 INFO - Total resource usage - Wall time: 1201s; CPU: 14.0%; Read bytes: 40960; Write bytes: 386830336; Read time: 64; Write time: 354644 04:30:36 INFO - TinderboxPrint: CPU usage
13.5% 04:30:36 INFO - TinderboxPrint: I/O read bytes / time
40,960 / 64 04:30:36 INFO - TinderboxPrint: I/O write bytes / time
386,830,336 / 354,644 04:30:36 INFO - TinderboxPrint: CPU idle
8,284.4 (86.5%) 04:30:36 INFO - TinderboxPrint: CPU user
1,235.4 (12.9%) 04:30:36 INFO - TinderboxPrint: Swap in / out
0 / 0 04:30:36 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 103870464; Read time: 0; Write time: 130736 04:30:36 INFO - run-tests - Wall time: 1186s; CPU: 14.0%; Read bytes: 36864; Write bytes: 282345472; Read time: 40; Write time: 223908 04:30:36 INFO - Running post-run listener: _upload_blobber_files 04:30:36 INFO - Blob upload gear active. 04:30:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:30:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:30:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:30:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:30:36 INFO - (blobuploader) - INFO - Open directory for files ... 04:30:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:30:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:30:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:30:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:30:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:30:37 INFO - (blobuploader) - INFO - Done attempting. 04:30:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:30:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:30:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:30:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:30:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:30:38 INFO - (blobuploader) - INFO - Done attempting. 04:30:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:30:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:30:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:30:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:30:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:30:39 INFO - (blobuploader) - INFO - Done attempting. 04:30:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:30:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:30:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:30:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:30:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:30:43 INFO - (blobuploader) - INFO - Done attempting. 04:30:43 INFO - (blobuploader) - INFO - Iteration through files over. 04:30:43 INFO - Return code: 0 04:30:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:30:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:30:43 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/af3cc5a4c7752a6913439f65f085f9031440a5d759da15ebee63c4914774d2ef521af1289d570a5090262f632dfbe2c698e5f0de06e26ffc627780aff89031bd", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/553fd7ab17c80b59be9551968c63392091d28fdb691240824c18af6f6bf124c73dd2bbb6de3c000f7ba294a60acaac0e5b4ace5cdb6484316eec886b98e3c44d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2735e5c7d2fdc54213c711637ea3444ee2ccc193aa4f62e65d7fc1db7ca4ed3b92110657f030005ac61ec7d9d89a9b974ba0f419a60ecd591b6edcb05c0b460d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/18f85b22d675bac2f2224aca52ae11716be820995aabbebfc73d6ebe34f5781f323f28a181fe4951e54b8e0cb620582f5a39f2b838f78ed48dde166b8c1ec85d"} 04:30:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:30:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:30:43 INFO - Contents: 04:30:43 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/af3cc5a4c7752a6913439f65f085f9031440a5d759da15ebee63c4914774d2ef521af1289d570a5090262f632dfbe2c698e5f0de06e26ffc627780aff89031bd", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/553fd7ab17c80b59be9551968c63392091d28fdb691240824c18af6f6bf124c73dd2bbb6de3c000f7ba294a60acaac0e5b4ace5cdb6484316eec886b98e3c44d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2735e5c7d2fdc54213c711637ea3444ee2ccc193aa4f62e65d7fc1db7ca4ed3b92110657f030005ac61ec7d9d89a9b974ba0f419a60ecd591b6edcb05c0b460d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/18f85b22d675bac2f2224aca52ae11716be820995aabbebfc73d6ebe34f5781f323f28a181fe4951e54b8e0cb620582f5a39f2b838f78ed48dde166b8c1ec85d"} 04:30:43 INFO - Running post-run listener: copy_logs_to_upload_dir 04:30:43 INFO - Copying logs to upload dir... 04:30:43 INFO - mkdir: /builds/slave/test/build/upload/logs 04:30:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.160408 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-01-03 04:30:43.936468) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-03 04:30:43.939722) ========= 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=14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/af3cc5a4c7752a6913439f65f085f9031440a5d759da15ebee63c4914774d2ef521af1289d570a5090262f632dfbe2c698e5f0de06e26ffc627780aff89031bd", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/553fd7ab17c80b59be9551968c63392091d28fdb691240824c18af6f6bf124c73dd2bbb6de3c000f7ba294a60acaac0e5b4ace5cdb6484316eec886b98e3c44d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2735e5c7d2fdc54213c711637ea3444ee2ccc193aa4f62e65d7fc1db7ca4ed3b92110657f030005ac61ec7d9d89a9b974ba0f419a60ecd591b6edcb05c0b460d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/18f85b22d675bac2f2224aca52ae11716be820995aabbebfc73d6ebe34f5781f323f28a181fe4951e54b8e0cb620582f5a39f2b838f78ed48dde166b8c1ec85d"} build_url:https://queue.taskcluster.net/v1/task/Unm3omsuSS-MrpYcaR-y-A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/Unm3omsuSS-MrpYcaR-y-A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/af3cc5a4c7752a6913439f65f085f9031440a5d759da15ebee63c4914774d2ef521af1289d570a5090262f632dfbe2c698e5f0de06e26ffc627780aff89031bd", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/553fd7ab17c80b59be9551968c63392091d28fdb691240824c18af6f6bf124c73dd2bbb6de3c000f7ba294a60acaac0e5b4ace5cdb6484316eec886b98e3c44d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2735e5c7d2fdc54213c711637ea3444ee2ccc193aa4f62e65d7fc1db7ca4ed3b92110657f030005ac61ec7d9d89a9b974ba0f419a60ecd591b6edcb05c0b460d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/18f85b22d675bac2f2224aca52ae11716be820995aabbebfc73d6ebe34f5781f323f28a181fe4951e54b8e0cb620582f5a39f2b838f78ed48dde166b8c1ec85d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-03 04:30:43.965437) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 04:30:43.965826) ========= 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=14ef55db36f7623abb31b9cf000001d5-1483445393.280086-964608258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 04:30:44.051662) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-03 04:30:44.051991) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-03 04:30:44.052303) ========= ========= Total master_lag: 0.17 =========