builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-068 starttime: 1483995342.55 results: success (0) revision: 0f9d69253ac67887b64f5efeffaebebb5929b1a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 12:55:42.548286) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 12:55:42.548767) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 12:55:42.549047) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 12:55:42.563682) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 12:55:42.564065) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-09 12:55:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|: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.9M=0s 2017-01-09 12:55:42 (69.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.101396 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 12:55:42.679165) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 12:55:42.679548) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014923 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 12:55:42.729555) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-09 12:55:42.729951) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0f9d69253ac67887b64f5efeffaebebb5929b1a7 --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 0f9d69253ac67887b64f5efeffaebebb5929b1a7 --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=97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-09 12:55:42,810 truncating revision to first 12 chars 2017-01-09 12:55:42,810 Setting DEBUG logging. 2017-01-09 12:55:42,810 attempt 1/10 2017-01-09 12:55:42,810 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0f9d69253ac6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-09 12:55:43,898 unpacking tar archive at: mozilla-central-0f9d69253ac6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.391409 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-09 12:55:44.134892) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 12:55:44.135248) ========= script_repo_revision: 0f9d69253ac67887b64f5efeffaebebb5929b1a7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 12:55:44.135653) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 12:55:44.135938) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 12:55:44.144139) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-01-09 12:55:44.144428) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:55:44 INFO - MultiFileLogger online at 20170109 12:55:44 in /builds/slave/test 12:55:44 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 12:55:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:55:44 INFO - {'append_to_log': False, 12:55:44 INFO - 'base_work_dir': '/builds/slave/test', 12:55:44 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 12:55:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:55:44 INFO - 'branch': 'Firefox-Non-PGO', 12:55:44 INFO - 'buildbot_json_path': 'buildprops.json', 12:55:44 INFO - 'config_files': ('talos/linux_config.py',), 12:55:44 INFO - 'default_actions': ('clobber', 12:55:44 INFO - 'read-buildbot-config', 12:55:44 INFO - 'download-and-extract', 12:55:44 INFO - 'populate-webroot', 12:55:44 INFO - 'create-virtualenv', 12:55:44 INFO - 'install', 12:55:44 INFO - 'run-tests'), 12:55:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:55:44 INFO - 'download_minidump_stackwalk': True, 12:55:44 INFO - 'download_symbols': 'ondemand', 12:55:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:55:44 INFO - 'tooltool.py': '/tools/tooltool.py', 12:55:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:55:44 INFO - '/tools/misc-python/virtualenv.py')}, 12:55:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:55:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:55:44 INFO - 'installer_path': 'installer.exe', 12:55:44 INFO - 'log_level': 'info', 12:55:44 INFO - 'log_name': 'talos', 12:55:44 INFO - 'log_to_console': True, 12:55:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:55:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:55:44 INFO - 'opt_config_files': (), 12:55:44 INFO - 'pip_index': False, 12:55:44 INFO - 'sps_profile': False, 12:55:44 INFO - 'sps_profile_interval': 0, 12:55:44 INFO - 'suite': 'dromaeojs-e10s', 12:55:44 INFO - 'system_bits': '32', 12:55:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:55:44 INFO - 'title': 'talos-linux64-ix-068', 12:55:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:55:44 INFO - 'use_talos_json': True, 12:55:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:55:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:55:44 INFO - 'work_dir': 'build'} 12:55:44 INFO - [mozharness: 2017-01-09 20:55:44.316917Z] Running clobber step. 12:55:44 INFO - Running pre-action listener: _resource_record_pre_action 12:55:44 INFO - Running main action method: clobber 12:55:44 INFO - rmtree: /builds/slave/test/build 12:55:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:55:44 INFO - Running post-action listener: _resource_record_post_action 12:55:44 INFO - [mozharness: 2017-01-09 20:55:44.783769Z] Finished clobber step (success) 12:55:44 INFO - [mozharness: 2017-01-09 20:55:44.783871Z] Running read-buildbot-config step. 12:55:44 INFO - Running pre-action listener: _resource_record_pre_action 12:55:44 INFO - Running main action method: read_buildbot_config 12:55:44 INFO - Using buildbot properties: 12:55:44 INFO - { 12:55:44 INFO - "project": "", 12:55:44 INFO - "product": "firefox", 12:55:44 INFO - "who": "kwierso@gmail.com", 12:55:44 INFO - "installer_path": "public/build/target.tar.bz2", 12:55:44 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 12:55:44 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 12:55:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 12:55:44 INFO - "stage_platform": "linux64", 12:55:44 INFO - "basedir": "/builds/slave/test", 12:55:44 INFO - "buildnumber": 634, 12:55:44 INFO - "platform": "ubuntu64_hw", 12:55:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:55:44 INFO - "slavebuilddir": "test", 12:55:44 INFO - "taskId": "BdcnNifKShGDou9oamG5wQ", 12:55:44 INFO - "branch": "mozilla-central", 12:55:44 INFO - "script_repo_revision": "production", 12:55:44 INFO - "revision": "0f9d69253ac67887b64f5efeffaebebb5929b1a7", 12:55:44 INFO - "slavename": "talos-linux64-ix-068", 12:55:44 INFO - "repo_path": "mozilla-central" 12:55:44 INFO - } 12:55:44 INFO - Finding installer, test and symbols from parent task. 12:55:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BdcnNifKShGDou9oamG5wQ'}, attempt #1 12:55:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BdcnNifKShGDou9oamG5wQ'}, attempt #1 12:55:45 INFO - Task dependencies: bxe2kBhIQlyjhN5GRPT4vA 12:55:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bxe2kBhIQlyjhN5GRPT4vA'}, attempt #1 12:55:46 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bxe2kBhIQlyjhN5GRPT4vA/artifacts/public/build/target.tar.bz2 12:55:46 INFO - Set test_url: https://queue.taskcluster.net/v1/task/bxe2kBhIQlyjhN5GRPT4vA/artifacts/public/build/test_packages.json 12:55:46 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bxe2kBhIQlyjhN5GRPT4vA/artifacts/public/build/target.crashreporter-symbols.zip 12:55:46 INFO - Running post-action listener: _resource_record_post_action 12:55:46 INFO - [mozharness: 2017-01-09 20:55:46.239968Z] Finished read-buildbot-config step (success) 12:55:46 INFO - [mozharness: 2017-01-09 20:55:46.240187Z] Running download-and-extract step. 12:55:46 INFO - Running pre-action listener: _resource_record_pre_action 12:55:46 INFO - Running main action method: download_and_extract 12:55:46 INFO - mkdir: /builds/slave/test/build/tests 12:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:55:46 INFO - trying https://queue.taskcluster.net/v1/task/bxe2kBhIQlyjhN5GRPT4vA/artifacts/public/build/target.test_packages.json 12:55:46 INFO - Downloading https://queue.taskcluster.net/v1/task/bxe2kBhIQlyjhN5GRPT4vA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:55:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bxe2kBhIQlyjhN5GRPT4vA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:55:46 INFO - Downloaded 896 bytes. 12:55:46 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:55:46 INFO - Using the following test package requirements: 12:55:46 INFO - {u'common': [u'target.common.tests.zip'], 12:55:46 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:55:46 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:55:46 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:55:46 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:55:46 INFO - u'mozbase': [u'target.common.tests.zip'], 12:55:46 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:55:46 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:55:46 INFO - u'web-platform': [u'target.common.tests.zip', 12:55:46 INFO - u'target.web-platform.tests.zip'], 12:55:46 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:55:46 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 12:55:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bxe2kBhIQlyjhN5GRPT4vA/artifacts/public/build/target.common.tests.zip 12:55:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bxe2kBhIQlyjhN5GRPT4vA/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:55:46 INFO - Fetch https://queue.taskcluster.net/v1/task/bxe2kBhIQlyjhN5GRPT4vA/artifacts/public/build/target.common.tests.zip into memory 12:55:47 INFO - Expected file size: 20251352 12:55:47 INFO - Obtained file size: 20251352 12:55:51 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 12:55:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bxe2kBhIQlyjhN5GRPT4vA/artifacts/public/build/target.common.tests.zip 12:55:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bxe2kBhIQlyjhN5GRPT4vA/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:55:51 INFO - Fetch https://queue.taskcluster.net/v1/task/bxe2kBhIQlyjhN5GRPT4vA/artifacts/public/build/target.common.tests.zip into memory 12:55:52 INFO - Expected file size: 20251352 12:55:52 INFO - Obtained file size: 20251352 12:55:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bxe2kBhIQlyjhN5GRPT4vA/artifacts/public/build/target.talos.tests.zip 12:55:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bxe2kBhIQlyjhN5GRPT4vA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:55:56 INFO - Fetch https://queue.taskcluster.net/v1/task/bxe2kBhIQlyjhN5GRPT4vA/artifacts/public/build/target.talos.tests.zip into memory 12:55:57 INFO - Expected file size: 14403537 12:55:57 INFO - Obtained file size: 14403537 12:55:57 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')]} 12:55:57 INFO - trying https://queue.taskcluster.net/v1/task/bxe2kBhIQlyjhN5GRPT4vA/artifacts/public/build/target.tar.bz2 12:55:57 INFO - Downloading https://queue.taskcluster.net/v1/task/bxe2kBhIQlyjhN5GRPT4vA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:55:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bxe2kBhIQlyjhN5GRPT4vA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:55:58 INFO - Downloaded 55903389 bytes. 12:55:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bxe2kBhIQlyjhN5GRPT4vA/artifacts/public/build/target.tar.bz2 12:55:58 INFO - mkdir: /builds/slave/test/properties 12:55:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:55:58 INFO - Writing to file /builds/slave/test/properties/build_url 12:55:58 INFO - Contents: 12:55:58 INFO - build_url:https://queue.taskcluster.net/v1/task/bxe2kBhIQlyjhN5GRPT4vA/artifacts/public/build/target.tar.bz2 12:55:58 INFO - Running post-action listener: _resource_record_post_action 12:55:58 INFO - Running post-action listener: set_extra_try_arguments 12:55:58 INFO - [mozharness: 2017-01-09 20:55:58.880987Z] Finished download-and-extract step (success) 12:55:58 INFO - [mozharness: 2017-01-09 20:55:58.881085Z] Running populate-webroot step. 12:55:58 INFO - Running pre-action listener: _resource_record_pre_action 12:55:58 INFO - Running main action method: populate_webroot 12:55:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:55:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:55:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:55:58 INFO - '--tppagecycles', 12:55:58 INFO - '7'], 12:55:58 INFO - 'tests': ['tsvgm']}}, 12:55:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:55:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:55:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:55:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:55:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:55:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:55:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:55:58 INFO - 'talos_options': ['--disable-e10s'], 12:55:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:55:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:55:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:55:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:55:58 INFO - 'talos_options': ['--disable-e10s'], 12:55:58 INFO - 'tests': ['damp', 'tps']}, 12:55:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:55:58 INFO - 'tests': ['damp', 'tps']}, 12:55:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:55:58 INFO - 'tests': ['dromaeo_dom']}, 12:55:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:55:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:55:58 INFO - 'tests': ['basic_compositor_video']}, 12:55:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:55:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:55:58 INFO - 'tests': ['a11yr', 12:55:58 INFO - 'ts_paint', 12:55:58 INFO - 'tpaint', 12:55:58 INFO - 'sessionrestore', 12:55:58 INFO - 'sessionrestore_no_auto_restore', 12:55:58 INFO - 'tabpaint']}, 12:55:58 INFO - 'other-e10s': {'tests': ['a11yr', 12:55:58 INFO - 'ts_paint', 12:55:58 INFO - 'tpaint', 12:55:58 INFO - 'sessionrestore', 12:55:58 INFO - 'sessionrestore_no_auto_restore', 12:55:58 INFO - 'tabpaint']}, 12:55:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:55:58 INFO - 'ts_paint', 12:55:58 INFO - 'tpaint', 12:55:58 INFO - 'sessionrestore', 12:55:58 INFO - 'sessionrestore_no_auto_restore', 12:55:58 INFO - 'tabpaint']}, 12:55:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:55:58 INFO - 'ts_paint', 12:55:58 INFO - 'tpaint', 12:55:58 INFO - 'sessionrestore', 12:55:58 INFO - 'sessionrestore_no_auto_restore', 12:55:58 INFO - 'tabpaint']}, 12:55:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:55:58 INFO - 'tests': ['a11yr', 12:55:58 INFO - 'ts_paint', 12:55:58 INFO - 'tpaint', 12:55:58 INFO - 'sessionrestore', 12:55:58 INFO - 'sessionrestore_no_auto_restore', 12:55:58 INFO - 'tabpaint']}, 12:55:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:55:58 INFO - 'tests': ['a11yr', 12:55:58 INFO - 'ts_paint', 12:55:58 INFO - 'tpaint', 12:55:58 INFO - 'sessionrestore', 12:55:58 INFO - 'sessionrestore_no_auto_restore', 12:55:58 INFO - 'tabpaint']}, 12:55:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:55:58 INFO - 'tests': ['tsvgx', 12:55:58 INFO - 'tsvgr_opacity', 12:55:58 INFO - 'tart', 12:55:58 INFO - 'tscrollx', 12:55:58 INFO - 'cart', 12:55:58 INFO - 'tsvg_static']}, 12:55:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:55:58 INFO - 'tsvgr_opacity', 12:55:58 INFO - 'tart', 12:55:58 INFO - 'tscrollx', 12:55:58 INFO - 'cart', 12:55:58 INFO - 'tsvg_static']}, 12:55:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:55:58 INFO - 'talos_options': ['--disable-e10s'], 12:55:58 INFO - 'tests': ['tp5o']}, 12:55:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:55:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:55:58 INFO - 'talos_options': ['--disable-e10s', 12:55:58 INFO - '--xperf_path', 12:55:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:55:58 INFO - 'tests': ['tp5n']}, 12:55:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:55:58 INFO - 'talos_options': ['--xperf_path', 12:55:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:55:58 INFO - 'tests': ['tp5n']}}, 12:55:58 INFO - 'talos.zip': {'path': '', 12:55:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:55:58 INFO - Running post-action listener: _resource_record_post_action 12:55:58 INFO - [mozharness: 2017-01-09 20:55:58.894407Z] Finished populate-webroot step (success) 12:55:58 INFO - [mozharness: 2017-01-09 20:55:58.894498Z] Running create-virtualenv step. 12:55:58 INFO - Running pre-action listener: _resource_record_pre_action 12:55:58 INFO - Running main action method: create_virtualenv 12:55:58 INFO - Creating virtualenv /builds/slave/test/build/venv 12:55:58 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 12:55:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:55:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:55:58 INFO - Using real prefix '/usr' 12:55:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:55:59 INFO - Installing distribute.............................................................................................................................................................................................done. 12:56:01 INFO - Installing pip.................done. 12:56:01 INFO - Return code: 0 12:56:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:56:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:56:01 INFO - Reading from file tmpfile_stdout 12:56:01 INFO - Output received: 12:56:01 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) 12:56:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:56:01 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')]} 12:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:01 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')]} 12:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:01 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 0xdb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1122480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f820>, '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 0x1120520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11209b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671', '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 12:56:01 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 12:56:01 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 12:56:01 INFO - Using env: {'DISPLAY': ':0', 12:56:01 INFO - 'HOME': '/home/cltbld', 12:56:01 INFO - 'LANG': 'en_US.UTF-8', 12:56:01 INFO - 'LANGUAGE': 'en_US:en', 12:56:01 INFO - 'LOGNAME': 'cltbld', 12:56:01 INFO - 'MAIL': '/var/mail/cltbld', 12:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:01 INFO - 'MOZ_NO_REMOTE': '1', 12:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:01 INFO - 'NO_EM_RESTART': '1', 12:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:01 INFO - 'PWD': '/builds/slave/test', 12:56:01 INFO - 'SHELL': '/bin/bash', 12:56:01 INFO - 'SHLVL': '1', 12:56:01 INFO - 'TERM': 'linux', 12:56:01 INFO - 'TMOUT': '86400', 12:56:01 INFO - 'USER': 'cltbld', 12:56:01 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671', 12:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:01 INFO - '_': '/tools/buildbot/bin/python'} 12:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:01 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 12:56:01 INFO - Cleaning up... 12:56:01 INFO - Return code: 0 12:56:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:56:01 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')]} 12:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:01 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')]} 12:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:01 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 0xdb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1122480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f820>, '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 0x1120520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11209b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671', '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 12:56:01 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 12:56:01 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 12:56:01 INFO - Using env: {'DISPLAY': ':0', 12:56:01 INFO - 'HOME': '/home/cltbld', 12:56:01 INFO - 'LANG': 'en_US.UTF-8', 12:56:01 INFO - 'LANGUAGE': 'en_US:en', 12:56:01 INFO - 'LOGNAME': 'cltbld', 12:56:01 INFO - 'MAIL': '/var/mail/cltbld', 12:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:01 INFO - 'MOZ_NO_REMOTE': '1', 12:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:01 INFO - 'NO_EM_RESTART': '1', 12:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:01 INFO - 'PWD': '/builds/slave/test', 12:56:01 INFO - 'SHELL': '/bin/bash', 12:56:01 INFO - 'SHLVL': '1', 12:56:01 INFO - 'TERM': 'linux', 12:56:01 INFO - 'TMOUT': '86400', 12:56:01 INFO - 'USER': 'cltbld', 12:56:01 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671', 12:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:01 INFO - '_': '/tools/buildbot/bin/python'} 12:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:02 INFO - Downloading/unpacking psutil>=3.1.1 12:56:02 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 12:56:02 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 12:56:02 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 12:56:02 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 12:56:02 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 12:56:02 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 12:56:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:56:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:56:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:56:04 INFO - Installing collected packages: psutil 12:56:04 INFO - Running setup.py install for psutil 12:56:04 INFO - building 'psutil._psutil_linux' extension 12:56:04 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 12:56:04 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 12:56:04 INFO - building 'psutil._psutil_posix' extension 12:56:04 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 12:56:04 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 12:56:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:56:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:56:04 INFO - Successfully installed psutil 12:56:04 INFO - Cleaning up... 12:56:04 INFO - Return code: 0 12:56:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:04 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 0xdb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1122480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f820>, '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 0x1120520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11209b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671', '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 12:56:04 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 12:56:04 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 12:56:04 INFO - Using env: {'DISPLAY': ':0', 12:56:04 INFO - 'HOME': '/home/cltbld', 12:56:04 INFO - 'LANG': 'en_US.UTF-8', 12:56:04 INFO - 'LANGUAGE': 'en_US:en', 12:56:04 INFO - 'LOGNAME': 'cltbld', 12:56:04 INFO - 'MAIL': '/var/mail/cltbld', 12:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:04 INFO - 'MOZ_NO_REMOTE': '1', 12:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:04 INFO - 'NO_EM_RESTART': '1', 12:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:04 INFO - 'PWD': '/builds/slave/test', 12:56:04 INFO - 'SHELL': '/bin/bash', 12:56:04 INFO - 'SHLVL': '1', 12:56:04 INFO - 'TERM': 'linux', 12:56:04 INFO - 'TMOUT': '86400', 12:56:04 INFO - 'USER': 'cltbld', 12:56:04 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671', 12:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:04 INFO - '_': '/tools/buildbot/bin/python'} 12:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:56:05 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 12:56:05 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 12:56:05 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 12:56:05 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 12:56:05 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 12:56:05 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 12:56:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:56:07 INFO - Installing collected packages: mozsystemmonitor 12:56:07 INFO - Running setup.py install for mozsystemmonitor 12:56:07 INFO - Successfully installed mozsystemmonitor 12:56:07 INFO - Cleaning up... 12:56:07 INFO - Return code: 0 12:56:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:56:07 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')]} 12:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:07 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')]} 12:56:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:07 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 0xdb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1122480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f820>, '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 0x1120520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11209b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671', '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 12:56:07 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 12:56:07 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 12:56:07 INFO - Using env: {'DISPLAY': ':0', 12:56:07 INFO - 'HOME': '/home/cltbld', 12:56:07 INFO - 'LANG': 'en_US.UTF-8', 12:56:07 INFO - 'LANGUAGE': 'en_US:en', 12:56:07 INFO - 'LOGNAME': 'cltbld', 12:56:07 INFO - 'MAIL': '/var/mail/cltbld', 12:56:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:07 INFO - 'MOZ_NO_REMOTE': '1', 12:56:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:07 INFO - 'NO_EM_RESTART': '1', 12:56:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:07 INFO - 'PWD': '/builds/slave/test', 12:56:07 INFO - 'SHELL': '/bin/bash', 12:56:07 INFO - 'SHLVL': '1', 12:56:07 INFO - 'TERM': 'linux', 12:56:07 INFO - 'TMOUT': '86400', 12:56:07 INFO - 'USER': 'cltbld', 12:56:07 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671', 12:56:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:07 INFO - '_': '/tools/buildbot/bin/python'} 12:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:07 INFO - Downloading/unpacking jsonschema==2.5.1 12:56:07 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 12:56:07 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 12:56:07 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 12:56:07 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 12:56:07 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 12:56:07 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 12:56:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:56:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:56:09 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 12:56:09 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 12:56:09 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 12:56:09 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 12:56:09 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 12:56:09 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 12:56:09 INFO - Downloading functools32-3.2.3-2.tar.gz 12:56:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:56:09 INFO - warning: no files found matching '*.txt' 12:56:09 INFO - no previously-included directories found matching 'build' 12:56:09 INFO - no previously-included directories found matching 'dist' 12:56:09 INFO - no previously-included directories found matching '.git*' 12:56:09 INFO - Installing collected packages: jsonschema, functools32 12:56:09 INFO - Running setup.py install for functools32 12:56:09 INFO - warning: no files found matching '*.txt' 12:56:09 INFO - no previously-included directories found matching 'build' 12:56:09 INFO - no previously-included directories found matching 'dist' 12:56:09 INFO - no previously-included directories found matching '.git*' 12:56:09 INFO - Successfully installed jsonschema functools32 12:56:09 INFO - Cleaning up... 12:56:10 INFO - Return code: 0 12:56:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:56: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')]} 12:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56: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')]} 12:56:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xdb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1122480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f820>, '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 0x1120520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11209b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671', '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 12:56:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:56:10 INFO - Using env: {'DISPLAY': ':0', 12:56:10 INFO - 'HOME': '/home/cltbld', 12:56:10 INFO - 'LANG': 'en_US.UTF-8', 12:56:10 INFO - 'LANGUAGE': 'en_US:en', 12:56:10 INFO - 'LOGNAME': 'cltbld', 12:56:10 INFO - 'MAIL': '/var/mail/cltbld', 12:56:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:10 INFO - 'MOZ_NO_REMOTE': '1', 12:56:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:10 INFO - 'NO_EM_RESTART': '1', 12:56:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:10 INFO - 'PWD': '/builds/slave/test', 12:56:10 INFO - 'SHELL': '/bin/bash', 12:56:10 INFO - 'SHLVL': '1', 12:56:10 INFO - 'TERM': 'linux', 12:56:10 INFO - 'TMOUT': '86400', 12:56:10 INFO - 'USER': 'cltbld', 12:56:10 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671', 12:56:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:10 INFO - '_': '/tools/buildbot/bin/python'} 12:56:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:56:10 INFO - Cleaning up... 12:56:10 INFO - Return code: 0 12:56:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:56: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')]} 12:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56: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')]} 12:56:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xdb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1122480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f820>, '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 0x1120520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11209b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671', '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 12:56:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:56:10 INFO - Using env: {'DISPLAY': ':0', 12:56:10 INFO - 'HOME': '/home/cltbld', 12:56:10 INFO - 'LANG': 'en_US.UTF-8', 12:56:10 INFO - 'LANGUAGE': 'en_US:en', 12:56:10 INFO - 'LOGNAME': 'cltbld', 12:56:10 INFO - 'MAIL': '/var/mail/cltbld', 12:56:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:10 INFO - 'MOZ_NO_REMOTE': '1', 12:56:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:10 INFO - 'NO_EM_RESTART': '1', 12:56:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:10 INFO - 'PWD': '/builds/slave/test', 12:56:10 INFO - 'SHELL': '/bin/bash', 12:56:10 INFO - 'SHLVL': '1', 12:56:10 INFO - 'TERM': 'linux', 12:56:10 INFO - 'TMOUT': '86400', 12:56:10 INFO - 'USER': 'cltbld', 12:56:10 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671', 12:56:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:10 INFO - '_': '/tools/buildbot/bin/python'} 12:56:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:10 INFO - Downloading/unpacking blobuploader==1.2.4 12:56:10 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 12:56:10 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 12:56:10 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 12:56:10 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 12:56:10 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 12:56:10 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 12:56:12 INFO - Downloading blobuploader-1.2.4.tar.gz 12:56:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:56:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:56:12 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 12:56:12 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 12:56:12 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 12:56:12 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 12:56:12 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 12:56:12 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 12:56:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:56:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:56:13 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 12:56:13 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 12:56:13 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 12:56:13 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 12:56:13 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 12:56:13 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 12:56:13 INFO - Downloading docopt-0.6.1.tar.gz 12:56:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:56:13 INFO - Installing collected packages: blobuploader, requests, docopt 12:56:13 INFO - Running setup.py install for blobuploader 12:56:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:56:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:56:13 INFO - Running setup.py install for requests 12:56:13 INFO - Running setup.py install for docopt 12:56:13 INFO - Successfully installed blobuploader requests docopt 12:56:13 INFO - Cleaning up... 12:56:13 INFO - Return code: 0 12:56:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:56: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')]} 12:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56: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')]} 12:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:13 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 0xdb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1122480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f820>, '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 0x1120520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11209b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671', '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 12:56:13 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 12:56:13 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 12:56:13 INFO - Using env: {'DISPLAY': ':0', 12:56:13 INFO - 'HOME': '/home/cltbld', 12:56:13 INFO - 'LANG': 'en_US.UTF-8', 12:56:13 INFO - 'LANGUAGE': 'en_US:en', 12:56:13 INFO - 'LOGNAME': 'cltbld', 12:56:13 INFO - 'MAIL': '/var/mail/cltbld', 12:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:13 INFO - 'MOZ_NO_REMOTE': '1', 12:56:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:13 INFO - 'NO_EM_RESTART': '1', 12:56:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:13 INFO - 'PWD': '/builds/slave/test', 12:56:13 INFO - 'SHELL': '/bin/bash', 12:56:13 INFO - 'SHLVL': '1', 12:56:13 INFO - 'TERM': 'linux', 12:56:13 INFO - 'TMOUT': '86400', 12:56:13 INFO - 'USER': 'cltbld', 12:56:13 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671', 12:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:13 INFO - '_': '/tools/buildbot/bin/python'} 12:56:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:56:14 INFO - Running setup.py (path:/tmp/pip-lDst2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:56:14 INFO - Running setup.py (path:/tmp/pip-1DU4jU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:56:14 INFO - Running setup.py (path:/tmp/pip-0S2FkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:56:14 INFO - Running setup.py (path:/tmp/pip-zMAdot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:56:14 INFO - Running setup.py (path:/tmp/pip-nDeZsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:56:14 INFO - Running setup.py (path:/tmp/pip-dcu3kZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:56:14 INFO - Running setup.py (path:/tmp/pip-CqEykQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:56:14 INFO - Running setup.py (path:/tmp/pip-tv9h45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:56:14 INFO - Running setup.py (path:/tmp/pip-Dm1BXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:56:14 INFO - Running setup.py (path:/tmp/pip-lh7Bok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:56:14 INFO - Running setup.py (path:/tmp/pip-Yeyzh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:56:14 INFO - Running setup.py (path:/tmp/pip-1TImH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:56:15 INFO - Running setup.py (path:/tmp/pip-5wyn1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:56:15 INFO - Running setup.py (path:/tmp/pip-IlCxJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:56:15 INFO - Running setup.py (path:/tmp/pip-8CqOQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:56:15 INFO - Running setup.py (path:/tmp/pip-xamn6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:56:15 INFO - Running setup.py (path:/tmp/pip-cHIc6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:56:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:56:15 INFO - Running setup.py install for manifestparser 12:56:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:56:15 INFO - Running setup.py install for mozcrash 12:56:15 INFO - Running setup.py install for mozdebug 12:56:15 INFO - Running setup.py install for mozdevice 12:56:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:56:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:56:15 INFO - Running setup.py install for mozfile 12:56:15 INFO - Running setup.py install for mozhttpd 12:56:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:56:16 INFO - Running setup.py install for mozinfo 12:56:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:56:16 INFO - Running setup.py install for mozInstall 12:56:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:56:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:56:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:56:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:56:16 INFO - Running setup.py install for mozleak 12:56:16 INFO - Running setup.py install for mozlog 12:56:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:56:16 INFO - Running setup.py install for moznetwork 12:56:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:56:16 INFO - Running setup.py install for mozprocess 12:56:16 INFO - Running setup.py install for mozprofile 12:56:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:56:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:56:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:56:16 INFO - Running setup.py install for mozrunner 12:56:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:56:16 INFO - Running setup.py install for mozscreenshot 12:56:16 INFO - Running setup.py install for moztest 12:56:17 INFO - Running setup.py install for mozversion 12:56:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:56:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:56:17 INFO - Cleaning up... 12:56:17 INFO - Return code: 0 12:56:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:56: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')]} 12:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56: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')]} 12:56:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:17 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 0xdb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1122480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f820>, '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 0x1120520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11209b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671', '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 12:56:17 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 12:56:17 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 12:56:17 INFO - Using env: {'DISPLAY': ':0', 12:56:17 INFO - 'HOME': '/home/cltbld', 12:56:17 INFO - 'LANG': 'en_US.UTF-8', 12:56:17 INFO - 'LANGUAGE': 'en_US:en', 12:56:17 INFO - 'LOGNAME': 'cltbld', 12:56:17 INFO - 'MAIL': '/var/mail/cltbld', 12:56:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:17 INFO - 'MOZ_NO_REMOTE': '1', 12:56:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:17 INFO - 'NO_EM_RESTART': '1', 12:56:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:17 INFO - 'PWD': '/builds/slave/test', 12:56:17 INFO - 'SHELL': '/bin/bash', 12:56:17 INFO - 'SHLVL': '1', 12:56:17 INFO - 'TERM': 'linux', 12:56:17 INFO - 'TMOUT': '86400', 12:56:17 INFO - 'USER': 'cltbld', 12:56:17 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671', 12:56:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:17 INFO - '_': '/tools/buildbot/bin/python'} 12:56:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:56:17 INFO - Running setup.py (path:/tmp/pip-ExxgGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:56:17 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)) 12:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:56:17 INFO - Running setup.py (path:/tmp/pip-aDiX7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:56:17 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)) 12:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:56:17 INFO - Running setup.py (path:/tmp/pip-exo004-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:56:17 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)) 12:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:56:17 INFO - Running setup.py (path:/tmp/pip-St5lFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:56:17 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)) 12:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:56:17 INFO - Running setup.py (path:/tmp/pip-b3kZPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:56:17 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)) 12:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:56:17 INFO - Running setup.py (path:/tmp/pip-fwiPAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:56:17 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)) 12:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:56:17 INFO - Running setup.py (path:/tmp/pip-lzqEdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:56:17 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)) 12:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:56:17 INFO - Running setup.py (path:/tmp/pip-frJ5t5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:56:18 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)) 12:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:56:18 INFO - Running setup.py (path:/tmp/pip-lLKywd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:56:18 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)) 12:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:56:18 INFO - Running setup.py (path:/tmp/pip-52Ifrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:56:18 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)) 12:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:56:18 INFO - Running setup.py (path:/tmp/pip-ZP425y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:56:18 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)) 12:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:56:18 INFO - Running setup.py (path:/tmp/pip-eNc5Q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:56:18 INFO - Running setup.py (path:/tmp/pip-urpQVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:56:18 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)) 12:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:56:18 INFO - Running setup.py (path:/tmp/pip-stoTQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:56:18 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)) 12:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:56:18 INFO - Running setup.py (path:/tmp/pip-CiKDCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:56:18 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)) 12:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:56:18 INFO - Running setup.py (path:/tmp/pip-5u0N3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:56:18 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)) 12:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:56:18 INFO - Running setup.py (path:/tmp/pip-kJmHpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:56:18 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)) 12:56:18 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)) 12:56:18 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)) 12:56:18 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)) 12:56:18 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)) 12:56:18 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)) 12:56:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:20 INFO - Downloading blessings-1.6.tar.gz 12:56:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:56:20 INFO - Installing collected packages: blessings 12:56:20 INFO - Running setup.py install for blessings 12:56:20 INFO - Successfully installed blessings 12:56:20 INFO - Cleaning up... 12:56:20 INFO - Return code: 0 12:56:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:56:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:56:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:56:21 INFO - Reading from file tmpfile_stdout 12:56:21 INFO - Current package versions: 12:56:21 INFO - argparse == 1.2.1 12:56:21 INFO - blessings == 1.6 12:56:21 INFO - blobuploader == 1.2.4 12:56:21 INFO - docopt == 0.6.1 12:56:21 INFO - functools32 == 3.2.3-2 12:56:21 INFO - jsonschema == 2.5.1 12:56:21 INFO - manifestparser == 1.1 12:56:21 INFO - mozInstall == 1.12 12:56:21 INFO - mozcrash == 1.0 12:56:21 INFO - mozdebug == 0.1 12:56:21 INFO - mozdevice == 0.49 12:56:21 INFO - mozfile == 1.2 12:56:21 INFO - mozhttpd == 0.7 12:56:21 INFO - mozinfo == 0.9 12:56:21 INFO - mozleak == 0.1 12:56:21 INFO - mozlog == 3.4 12:56:21 INFO - moznetwork == 0.27 12:56:21 INFO - mozprocess == 0.24 12:56:21 INFO - mozprofile == 0.28 12:56:21 INFO - mozrunner == 6.13 12:56:21 INFO - mozscreenshot == 0.1 12:56:21 INFO - mozsystemmonitor == 0.3 12:56:21 INFO - moztest == 0.8 12:56:21 INFO - mozversion == 1.4 12:56:21 INFO - psutil == 3.1.1 12:56:21 INFO - requests == 1.2.3 12:56:21 INFO - wsgiref == 0.1.2 12:56:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:56:21 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')]} 12:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:21 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')]} 12:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:21 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 0xdb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1122480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f820>, '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 0x1120520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11209b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671', '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 12:56:21 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 12:56:21 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 12:56:21 INFO - Using env: {'DISPLAY': ':0', 12:56:21 INFO - 'HOME': '/home/cltbld', 12:56:21 INFO - 'LANG': 'en_US.UTF-8', 12:56:21 INFO - 'LANGUAGE': 'en_US:en', 12:56:21 INFO - 'LOGNAME': 'cltbld', 12:56:21 INFO - 'MAIL': '/var/mail/cltbld', 12:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:21 INFO - 'MOZ_NO_REMOTE': '1', 12:56:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:21 INFO - 'NO_EM_RESTART': '1', 12:56:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:21 INFO - 'PWD': '/builds/slave/test', 12:56:21 INFO - 'SHELL': '/bin/bash', 12:56:21 INFO - 'SHLVL': '1', 12:56:21 INFO - 'TERM': 'linux', 12:56:21 INFO - 'TMOUT': '86400', 12:56:21 INFO - 'USER': 'cltbld', 12:56:21 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671', 12:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:21 INFO - '_': '/tools/buildbot/bin/python'} 12:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:21 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)) 12:56:21 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)) 12:56:21 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)) 12:56:21 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)) 12:56:21 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)) 12:56:21 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)) 12:56:21 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)) 12:56:21 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)) 12:56:21 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)) 12:56:21 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)) 12:56:21 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)) 12:56:21 INFO - Cleaning up... 12:56:21 INFO - Return code: 0 12:56:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:56:21 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')]} 12:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:21 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')]} 12:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:21 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 0xdb01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1122480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f820>, '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 0x1120520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11209b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671', '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 12:56:21 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 12:56:21 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 12:56:21 INFO - Using env: {'DISPLAY': ':0', 12:56:21 INFO - 'HOME': '/home/cltbld', 12:56:21 INFO - 'LANG': 'en_US.UTF-8', 12:56:21 INFO - 'LANGUAGE': 'en_US:en', 12:56:21 INFO - 'LOGNAME': 'cltbld', 12:56:21 INFO - 'MAIL': '/var/mail/cltbld', 12:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:21 INFO - 'MOZ_NO_REMOTE': '1', 12:56:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:21 INFO - 'NO_EM_RESTART': '1', 12:56:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:21 INFO - 'PWD': '/builds/slave/test', 12:56:21 INFO - 'SHELL': '/bin/bash', 12:56:21 INFO - 'SHLVL': '1', 12:56:21 INFO - 'TERM': 'linux', 12:56:21 INFO - 'TMOUT': '86400', 12:56:21 INFO - 'USER': 'cltbld', 12:56:21 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671', 12:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:21 INFO - '_': '/tools/buildbot/bin/python'} 12:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:56:21 INFO - Cleaning up... 12:56:21 INFO - Return code: 0 12:56:21 INFO - Running post-action listener: _resource_record_post_action 12:56:21 INFO - Running post-action listener: _start_resource_monitoring 12:56:21 INFO - Starting resource monitoring. 12:56:21 INFO - [mozharness: 2017-01-09 20:56:21.676424Z] Finished create-virtualenv step (success) 12:56:21 INFO - [mozharness: 2017-01-09 20:56:21.676876Z] Running install step. 12:56:21 INFO - Running pre-action listener: _resource_record_pre_action 12:56:21 INFO - Running main action method: install 12:56:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:56:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:56:21 INFO - Reading from file tmpfile_stdout 12:56:21 INFO - Detecting whether we're running mozinstall >=1.0... 12:56:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:56:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:56:21 INFO - Reading from file tmpfile_stdout 12:56:21 INFO - Output received: 12:56:21 INFO - Usage: mozinstall [options] installer 12:56:21 INFO - Options: 12:56:21 INFO - -h, --help show this help message and exit 12:56:21 INFO - -d DEST, --destination=DEST 12:56:21 INFO - Directory to install application into. [default: 12:56:21 INFO - "/builds/slave/test"] 12:56:21 INFO - --app=APP Application being installed. [default: firefox] 12:56:21 INFO - mkdir: /builds/slave/test/build/application 12:56:21 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'] 12:56:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:56:38 INFO - Reading from file tmpfile_stdout 12:56:38 INFO - Output received: 12:56:38 INFO - /builds/slave/test/build/application/firefox/firefox 12:56:38 INFO - Running post-action listener: _resource_record_post_action 12:56:38 INFO - [mozharness: 2017-01-09 20:56:38.068361Z] Finished install step (success) 12:56:38 INFO - [mozharness: 2017-01-09 20:56:38.068636Z] Running run-tests step. 12:56:38 INFO - Running pre-action listener: _resource_record_pre_action 12:56:38 INFO - Running main action method: run_tests 12:56:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:56:38 INFO - Python 2.7.3 12:56:38 INFO - Return code: 0 12:56:38 INFO - grabbing minidump binary from tooltool 12:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:56:38 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 0x111f820>, '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 0x1120520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11209b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:56:38 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 12:56:38 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 12:56:38 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 12:56:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:56:38 INFO - Return code: 0 12:56:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:56:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:56:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:56:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:56:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:56:38 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/bxe2kBhIQlyjhN5GRPT4vA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 12:56:38 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/bxe2kBhIQlyjhN5GRPT4vA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 12:56:38 INFO - Using env: {'DISPLAY': ':0', 12:56:38 INFO - 'HOME': '/home/cltbld', 12:56:38 INFO - 'LANG': 'en_US.UTF-8', 12:56:38 INFO - 'LANGUAGE': 'en_US:en', 12:56:38 INFO - 'LOGNAME': 'cltbld', 12:56:38 INFO - 'MAIL': '/var/mail/cltbld', 12:56:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:56:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:38 INFO - 'MOZ_NO_REMOTE': '1', 12:56:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:38 INFO - 'NO_EM_RESTART': '1', 12:56:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:38 INFO - 'PWD': '/builds/slave/test', 12:56:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:56:38 INFO - 'SHELL': '/bin/bash', 12:56:38 INFO - 'SHLVL': '1', 12:56:38 INFO - 'TERM': 'linux', 12:56:38 INFO - 'TMOUT': '86400', 12:56:38 INFO - 'USER': 'cltbld', 12:56:38 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671', 12:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:38 INFO - '_': '/tools/buildbot/bin/python'} 12:56:38 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/bxe2kBhIQlyjhN5GRPT4vA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 12:56:38 INFO - mozversion application_buildid: 20170109202529 12:56:38 INFO - mozversion application_changeset: 0f9d69253ac67887b64f5efeffaebebb5929b1a7 12:56:38 INFO - mozversion application_display_name: Nightly 12:56:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:56:38 INFO - mozversion application_name: Firefox 12:56:38 INFO - mozversion application_remotingname: firefox 12:56:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:56:38 INFO - mozversion application_vendor: Mozilla 12:56:38 INFO - mozversion application_version: 53.0a1 12:56:38 INFO - mozversion platform_buildid: 20170109202529 12:56:38 INFO - mozversion platform_changeset: 0f9d69253ac67887b64f5efeffaebebb5929b1a7 12:56:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:56:38 INFO - mozversion platform_version: 53.0a1 12:56:38 INFO - using testdate: 1483995398 12:56:38 INFO - actual date: 1483995398 12:56:38 INFO - starting webserver on 'localhost:41458' 12:56:38 INFO - SUITE-START | Running 2 tests 12:56:38 INFO - TEST-START | dromaeo_css 12:56:38 INFO - operating with platform_type : linux_ 12:56:38 INFO - Initialising browser for dromaeo_css test... 12:56:38 INFO - TEST-INFO | started process 4988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAsgA3r/profile http://localhost:41458/getInfo.html) 12:56:38 INFO - PROCESS | 4988 | 1483995398841 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:4906 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3761 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2794 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 12:56:43 INFO - PROCESS | 4988 | __metrics Screen width/height:1600/1200 12:56:43 INFO - PROCESS | 4988 | colorDepth:24 12:56:43 INFO - PROCESS | 4988 | Browser inner width/height: 1024/697 12:56:43 INFO - PROCESS | 4988 | __metrics 12:56:43 ERROR - PROCESS | 4988 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 12:56:44 INFO - TEST-INFO | 4988: exit 0 12:56:44 INFO - Browser initialized. 12:56:44 INFO - Running cycle 1/1 for dromaeo_css test... 12:56:44 INFO - TEST-INFO | started process 5107 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAsgA3r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:56:56 INFO - PROCESS | 5107 | RSS: Main: 158732288 12:56:56 INFO - PROCESS | 5107 | 13:00:00 INFO - PROCESS | 5107 | Cycle 1(1): loaded http://localhost:41458/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41458/tests/dromaeo/cssquery-ext.html) 13:00:02 INFO - PROCESS | 5107 | RSS: Main: 167047168 13:00:02 INFO - PROCESS | 5107 | 13:01:45 INFO - PROCESS | 5107 | ************************* 13:01:45 INFO - PROCESS | 5107 | A coding exception was thrown and uncaught in a Task. 13:01:45 INFO - PROCESS | 5107 | 13:01:45 INFO - PROCESS | 5107 | Full message: ReferenceError: fetch is not defined 13:01:45 INFO - PROCESS | 5107 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 13:01:45 INFO - PROCESS | 5107 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 13:01:45 INFO - PROCESS | 5107 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 13:01:45 INFO - PROCESS | 5107 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 13:01:45 INFO - PROCESS | 5107 | TaskImpl@resource://gre/modules/Task.jsm:277:3 13:01:45 INFO - PROCESS | 5107 | asyncFunction@resource://gre/modules/Task.jsm:252:14 13:01:45 INFO - PROCESS | 5107 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 13:01:45 INFO - PROCESS | 5107 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 13:01:45 INFO - PROCESS | 5107 | TaskImpl@resource://gre/modules/Task.jsm:277:3 13:01:45 INFO - PROCESS | 5107 | asyncFunction@resource://gre/modules/Task.jsm:252:14 13:01:45 INFO - PROCESS | 5107 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 13:01:45 INFO - PROCESS | 5107 | 13:01:45 INFO - PROCESS | 5107 | ************************* 13:03:04 INFO - PROCESS | 5107 | Cycle 1(1): loaded http://localhost:41458/tests/dromaeo/cssquery-ext.html (next: http://localhost:41458/tests/dromaeo/cssquery-jquery.html) 13:03:05 INFO - PROCESS | 5107 | RSS: Main: 163586048 13:03:05 INFO - PROCESS | 5107 | 13:06:07 INFO - PROCESS | 5107 | Cycle 1(1): loaded http://localhost:41458/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41458/tests/dromaeo/cssquery-mootools.html) 13:06:07 INFO - PROCESS | 5107 | RSS: Main: 168067072 13:06:07 INFO - PROCESS | 5107 | 13:09:10 INFO - PROCESS | 5107 | Cycle 1(1): loaded http://localhost:41458/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41458/tests/dromaeo/cssquery-prototype.html) 13:09:10 INFO - PROCESS | 5107 | RSS: Main: 163364864 13:09:10 INFO - PROCESS | 5107 | 13:12:13 INFO - PROCESS | 5107 | Cycle 1(1): loaded http://localhost:41458/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41458/tests/dromaeo/cssquery-yui.html) 13:12:14 INFO - PROCESS | 5107 | RSS: Main: 166506496 13:12:14 INFO - PROCESS | 5107 | 13:15:17 INFO - PROCESS | 5107 | Cycle 1(1): loaded http://localhost:41458/tests/dromaeo/cssquery-yui.html (next: http://localhost:41458/tests/dromaeo/cssquery-dojo.html) 13:15:17 INFO - PROCESS | 5107 | RSS: Main: 167096320 13:15:17 INFO - PROCESS | 5107 | 13:15:17 INFO - PROCESS | 5107 | __start_tp_report 13:15:17 INFO - PROCESS | 5107 | _x_x_mozilla_page_load 13:15:17 INFO - PROCESS | 5107 | _x_x_mozilla_page_load_details 13:15:17 INFO - PROCESS | 5107 | |i|pagename|runs| 13:15:17 INFO - PROCESS | 5107 | |0;dojo.html;2639.3137784176115;2648.2982009767416;2649.9602505962425;2681.6379788728514;2687.153546632812;4756.09634169508;4759.238521836507;4797.6161907047435;4826.0830442216;4828.324034635154;4766.4518580363265;4808.230683090706;4849.903001939959;4872.3909511311085;4919.163742163832;4402.119576084788;4457.84397546086;4461.750709801261;4546.204414227497;4593.713760147164;4086.570910054446;4552.590266875981;4568.954310456903;4578.450585929693;4581.1753884300815;4398.23030969579;4501.437320334958;4510;4553.180427523044;4602.194615942197;4404.669649776248;4412.514623391425;4423.7566933818625;4436.046250056221;4496.79764410599;4362.083962367907;4364.301711726141;4417.7349359038235;4423.137488189805;4459;4812.446568644581;4828.251620998751;4837.927431088537;4853.320535125085;4865.19724245499;5087.160618497944;5137.357830271216;5216.087184742692;5220.216967454874;5238.816641417532;5287.286216360819;5298.258243845865;5299.5760339172775;5308.230306605559;5361.919571206435;4920.1635721927005;4929.926051109236;4932.802687892444;4940.925886111711;4952.380952380989;5249.527542521191;5286.920696189561;5292.259083728281;5303.098473259555;5412.377576578665;5175.560077393388;5183.2743415921805;5183.533481986639;5191.169412893919;5219.164933610604;5142.614303927146;5282.788688452419;5295.152775555893;5299.682019078868;5323.733813309319;5127.846164615067;5133.974330128325;5136.357955255593;5189.247559103909;5230.08473517133;5174.767135478913;5182.663126896739;5183.118869792144;5213.869653258699;5241.790328386822;4415.757133357696;4418.977905110454;4422.513523512411;4425.75658338788;4461.977690111528;3757.7181711371754;3784.8864534064023;3799.145192331703;3831.7892515911335;3839.846406143779;4534.727916325031;4541.682082254277;4559.224931761609;4574.153781550423;4591.517890621437;5268.683878967274;5282.7622756976025;5284.339457567804;5291.523762861361;5294.258803767476;4457.687961842705;4469.575390337977;4495.325701144854;4533.977330113395;4574.313852922089;4670.346151538719;4699.718016918996;4706.835260765857;4722.693024953367;4723.055388922229;4883.560479556857;4887.340209071872;4903.338049363433;4925;4939.382577177853;5150.6137039721425;5188.118019936544;5279.47205279469;5284;5312.096943519534;4874.512548745097;4898.461169271449;4918.458969513279;4921.212605983025;4951.158303088556;5168.457311982338;5169.61227907916;5186.740662966761;5200.531952124327;5239;5159.922601160911;5217.8173763918085;5229.869253268699;5246.580273578181;5247.8163264287095;4893.975530122327;5067.366579177603;5092.439831618593;5095.133827249302;5172;5065.898682026265;5095.77069031887;5098.2352647103235;5103.464136265638;5116.130257856099;4953.925691114709;4959.504049595012;4971.130052240771;4990.126727822689;5011.9498805012945;5044.722540260174;5077.644564880571;5104.132297509358;5142.1258386073705;5174.6119041071315;4940.283658869372;4971.676841005323;4983.07813054586;4985.326980857538;5027.296178534935 13:15:17 INFO - PROCESS | 5107 | |1;ext.html;500.7195970256657;514.4135685318737;520.8489538033971;536.9650972686773;542.1001138110737;38392;39392.40911386328;39419.80290098552;39472.80263598678;39555.604443955555;39489.802550987275;39978.40032399516;39999.40000899989;40157.19685606286;40204.39693404594;7594.620268986542;7804.882926756103;7811.453198276123;9558.091981261769;9869.753256168582;9325.393849399801;9413.152816246537;9414.952925235364;9416;9434.716958491255;9761.902380976206;9782.706518804413;9878.851817222747;9881.16010139139;9906;9820.263480238975;9834.606615735362;9843;9850.60597576096;9864.506774661239;9498.19265362445;9552.761180970461;9579.856302155473;9581.377210481367;9582.370996930538;34962.47556286658;35054.824725876206;35180.47229291563;35353.64646353529;35400.82299588485;3600.945985810215;3654.3422184006868;3666.478411459241;3688.8524459021874;3712.832922518493;26501.602475962874;26523.07169249067;26538.33654158642;26658.600120998202;26940;3444.7071998880124;3495.5805303363504;3561.626029266916;3723.1250656095795;3760.7179461540495;199021.11746590503;199594;249507.79183769584;251123;251204;59693;60980;61020.38979610236;61079.69460152671;61087;49759.50240497549;50015.74992125089;50405.49594504008;50436;50458.692663417074;12593.559225427067;12710.173838700455;12768.425420856083;12820.166689165175;12871.935640321739;9870;9975.301728878909;10016.899831001743;10324.328918620266;10531.262811603114;19556.413307600797;19570.434365250745;19635.705464418046;19641.607167856564;19655.60688786245;7210.423166146696;7478.055705516605;7567.243275672498;7583.469157158946;7719.3052625264;760.7869796457001;761.4251240313528;768.5350363030398;775.0931410250021;780.1925007617089;28129.859350703115;28829.56755648667;28840.12539184943;29045;29128.417431651247;971.3394891473724;980.9558569864373;981.3768257156614;986.6004268271362;1121.6242558742913;14304.713905721826;15418.460353887784;15512;15562.299696513684;15718.21408929549;359391;363107;364781;364823;365297;52948.205776913375;53410.198847017324;53849.461505385225;53917.19124213061;54047.45952540503;1217.792975194219;1265.7278685082567;1276.9425375858295;1280.7182419867613;1285.2352850054203;26064.218073457825;26912.865435672695;27747.722522774515;27828.86085569559;28182.43635127245;36588.81705591455;36826.8158659205;36843;37080.81459592793;37499.81250093732;239925;239981;240401;240657;241556;24179.274621760673;24806.50386992286;24893;25894;39448.2110357797;38271.6172838268;38308.616913830505;38501.80749096237;39288.6071139285;39366.212675746894;31882;32127;32306.19234519062;33261.16847078746;33414;27780.44439111166;27876.16371508858;28183;28395.43209135847;29232.56151157777;31700;32077.518837216994;32331.676683233807;32373.514397283587;32576.34847302993;27114.864425677744;29447.705522944496;29577.704222957494;29647.703522965356;29893.103206903827;22826.885865570566;22860.31419057431;23060.654090188997;23090.884545577166;23173.304800856 13:15:17 INFO - PROCESS | 5107 | |2;jquery.html;359.6493418916557;371.9293334266489;372.68321926362586;384.1606090691837;393.22338381696136;16990;17783.288668453264;17805.64388712225;18321.45035648931;18348.44954651359;16822.0747858868;17022.489325320228;17331.133443327846;17409.390671326506;17429.128543572835;5066.797328106872;5280.498352656491;5286.788528458857;5294.364676238857;5296.682199068049;4118.258713431581;4592.632589392857;5267.55225805807;6158.445739883409;6219.19150510433;6146.784862529812;6154.046122850965;6169.352218017111;6191.752329906798;6222.782202622909;5335.706536140511;5369.704666243355;5407.891842163154;5409.2690339091505;5948.553858460611;5179.792808287664;5272.367315922075;5276.050310944029;5282.31329927107;5296.496832800878;11947.581834635834;17003.489895303162;19190.328338508225;21698.457538561503;21759.782402176093;1772.59230377014;1780.2344991653583;1808.9909550452296;1834.5688763140652;2127.8829664368454;8985.23625491834;9055.68305109318;9161.862572061424;9256.72229833106;9581;1704.565335839353;1709.3504468301965;1752.815954324803;1771.9822801771945;1783.4025601423539;79739;80121.19878801254;80353.59823200906;80530;82202;10222.386656800616;10364.896351036545;10479;10492.21308401873;10598.682039538671;14200.360983755756;14270.3578338975;14277.357518911675;14303;14316.355763990645;6860.622665753432;7038;7234.131904171533;7287;7339.926600733925;6555.836104097436;6556;6643.30245324234;6767.593944363354;6770.898436523456;4099.754014759124;4203.906984184134;4250.298700714409;4311.490978157683;4347.282698354799;1763.7178051511953;1772.6631939931372;1798.2087881332172;1822.3986084592052;1852.4720454670355;955.7658373698488;956.1729104324709;970.8111434825131;971.5482300730054;1002.9197664186847;15927.761083583755;15951.282192301142;17480.47558573245;17633.470995869888;17640.470785876445;933.7712260496222;954.3987288008649;979.7354714227118;985.69936169469;986.068165583531;9514.381565198379;9830.361026533252;9853.310268281295;9877.802443951081;9931.106200441995;472456;483888;493388;496666;504805;88261.55869220613;90335.54832225796;90484;90492.5475372619;90783;953.0755167487526;973.7127547373542;982.4547376206132;986.1913231150531;993.9155171810477;15003.549893503212;15038.6992260152;15113.31990060472;15286.694266114839;15593.610159746097;37581;37887.81056094702;37891.81054094712;37899.242015160096;38189;48123.75938120287;52134.21798673099;52298;52330.21504677357;54154.72922635519;6426.807195784134;6648.202215734143;7055.153381594037;7156.892646610409;7501.774946751606;9714.854277185706;12060;12153.331566763913;12431.564895228623;12749.617511474671;9802.607895684092;9890.406575605486;10005.899941000787;10092.293539452168;10172.542235599563;9738.561764720464;9739.464329461664;9794.902050979399;9892.15916647093;10141.949290253502;9875.901240987498;10057.547410366697;10115.848262275924;10135.442550659785;10141.949290253502;7010.894836577353;7226.494145409771;7278.454115941219;7390.852182956418;7450.6647200875;9842.75393115178;9999.55002024896;10062.245331600014;10067.446290453803;10416.791664166825 13:15:17 INFO - PROCESS | 5107 | |3;mootools.html;1353.560092969785;1365.1672479787328;1365.6039748472938;1368.2474638948581;1368.9247091409973;6613.735450581983;6796.25241223465;6991.16106067272;7399.482036257464;7442.627868606568;7003.299670032994;7106.21831598525;7116.644167791603;7273.12722473304;7287.380572651317;2059;2073.481629592602;2083.6978638097467;2085.4786303424144;2095.4970807006284;2013.4261735405412;2054.6301665700166;2072.6890966355018;2099.6325643012487;2104;2055.383384984506;2061.196133507933;2064.5870825834895;2074.222166687492;2080.8127268545827;2005.739253896984;2024.908879100444;2029.1071928351478;2030.2893987104544;2038.541328201143;2050.282401159597;2074.8651337663005;2075.9481012974647;2101.8633788803677;2103.463616777727;7341.375983041395;7365.594892280922;7377.3360397564475;7391.22392148822;7481.513701609378;4390.297552391602;4450.688451808374;4469.7541635210055;4471.686981911267;4487.932681009787;2645.5899335603012;2813.268550176969;2830.5754136879427;2847.515922293215;2852.144356692984;1077.5258886090096;1087.5758454202867;1096.7641956979287;1102.063246240697;1144.8168293073068;9440.905590944072;9503.477308748015;9517.286203534693;9518.762030949212;9706.805863882682;3634.436662317345;3798.5441746990537;3850.441685955521;3866.9806650966566;3917.2948869203815;7764.107127680276;7783.649735761905;7808.063032436144;7810.609469526615;7813.804654883674;4181.205570941512;4232.407462955189;4267.0825772459075;4280.400743895857;4285.678574106954;3966.5636779954184;3995.580464051233;4016.4376987221813;4039.73741706794;4068.3694027425795;3231;3254.902352929416;3280.3931272714626;3342.064222017839;3353.9664603353654;901.9684311049213;915.5239275576663;919.090100800203;930.8184903943666;944.126682818404;671.3521451799037;685.8491131950963;689.1557841644046;691.0636088100651;796.9442139050211;4541.772911354419;4548.363229147922;4851.2723091535845;4863.781129849165;5134.820281290137;910.4355299714219;930.7719608695777;952.457099453305;965.5799727118725;975.3660120921458;3189.840507974592;3400.336934297788;3430.091025878144;3463.8268086595567;3479.7738147020364;8648.913510864812;8749.518776467356;8844.425112367675;8904.332175086894;8920.955395223113;8710.43382180169;8798.076201998825;8863.379563430499;8886.51124188163;8890.377673562789;6892.414144797748;6905.136857892763;6918.446524277945;7003.8599228015155;7021.754238601625;4814.301926220748;4848;4961.404631444249;4964.478729733326;5131.538161565477;8001.479903806234;8061.596920153852;8080;8085.797855053671;8211.917880821115;8165.510069395856;8247.752567422987;8254.628541715758;8262.049864265446;8320.875186872081;6035.456808887221;6099.9390006099375;6127.877442451037;6169.321374648695;6266.091416744455;6747.359000894907;6813.727450901908;6828.5220034597105;6885.173779146535;6889.138857642794;6379.362063793584;6466.32103629131;6514.1531600891585;6527.412532872065;6558.442532384801;6367.745290188341;6385.393387628168;6399.8720025598295;6420.486361091195;6472.546921715435;5823.301203855564;5836.24128863262;5843.649381037151;5859.2090067842;5878.059510478303;4396.3845061690745;4410.0738844842945;4410.140022695544;4506.887327816831;4525.117602067565;4337.761423121632;4395.296752519582;4478.888027799331;4508;4525.321201819622 13:15:17 INFO - PROCESS | 5107 | |4;prototype.html;337.5493715889288;338.18328736102313;350.44979382369684;353.4521491687883;354.36037951497536;4983;4992.577115522077;4995.201727378141;5007.399112106547;5018.473060328668;4963.975180124104;4973.5026497350245;4974.468127629379;4980.662955819601;5002.574781143607;3768.773873567588;3790.431435284702;3857.7685338879755;3873.334466179542;3891.766494010354;3878.806059697018;3885.358915778893;3912.8043597819997;3914.4324073009398;3935.429362742401;3886.3871493330234;3898.259330727167;3899.4345819856103;3902.9266951588256;3905.672071495691;3577.8032208228537;3775.4336849472525;3937.8424863005444;3942.2706799242087;3948.486696729407;3249.0740139060254;3266.738660907122;3300.389427955836;3316.6020077590842;3327.2846338037198;4777.59390451812;4794.736289504076;4815.7847390200195;4822.71063736177;4832.1543729847135;4343.847965321199;4349.717268377545;4376.934345984812;4377.752340582919;4432.224360736858;5102.515261050195;5161.27742116104;5191.610629202787;5192.92210616841;5221.791128354861;3629.2197177606677;3640.4903313536124;3648.452732090181;3655.817209139559;3662.304162209172;5494.36814766303;5503.477169668915;5518.082161665223;5521.371195497338;5539.473749993744;3637.890863274106;3721.199942012426;3734.10381508436;3741.4387841823946;3785.5835858055593;3777.1501412182038;3793.412021136728;3794.5067141271456;3796.2217745362136;3797.6582107610448;4354.804033818486;4355.715064056111;4368.907773056736;4380;4384.188925048876;5133.5379815816;5286.920696189561;5295.602829787781;5296.761645725952;5306.646805064761;1265.6709255593612;1277.7158955249915;1279.0215485153865;1280.6670265730977;1285.53720660564;822.9917700823034;833.3666413525764;859.3984211052289;864.6627815152095;878.3675753457628;4457.799399027052;4599.3442360750105;4610.354550362952;4612.446506419251;4614.538546145426;5323.813666521731;5365.356157261153;5388.91916621251;5391.81128660495;5393.514583687487;4586.954130458719;4592.586667199968;4599.05719327537;4612.400387949612;4623.9075218495445;2637.3670319123657;2747.9450410991667;2778.2220978126156;2791;2807.6911539730613;4833.73414462208;4867.586255168279;4873.780679869415;4900.583450406684;4922.75386230687;5138.30632864566;5324.949894290726;5340.1309541660885;5349.518543331041;5353.7055461949185;5010.223415370623;5010.799568017312;5022.522860328263;5027.497250274943;5037.596992240538;5350.866228344323;5366.543843773323;5376.892462150657;5381.246625472515;5386.622936394415;5190.792368305377;5232.275295122212;5276.232462125077;5293.814716484904;5328;5038.042771873333;5068.974655126701;5078.593712503065;5079.044567841333;5080.907604864972;3728.96271037297;3735.9066023349633;3745.9250814984093;3747.9880432282584;3762.228743107711;5112.514311140436;5346.705931173823;5408.242846001484;5423.728813559385;5424.887897980983;5174.249733788655;5185;5188.221766734869;5189.896202076013;5196.532312091778;5119.0529751996;5177.534021938043;5194.818181363634;5205.713685747321;5235.240890070994;4850.6119510438375;5085.211792172219;5095.41402738675;5118;5124.948750512596;4939.975300123477;5090.923636145535;5101.225093430909;5194.221091715914;5210.895782084262;5076.847694569021;5081.655184816928;5086.237064440364;5094.7962081516325;5106.719130447861 13:15:17 INFO - PROCESS | 5107 | |5;yui.html;674.4435840431645;674.6525539347238;739.0687733455848;770.7995921060524;787.1223585701943;12823.871761282384;13891.930540347297;14077.225752583616;14324.355404006845;14572.781408278857;13614.523491677794;13650.249236292;13771.449142034307;13801;13995.160290382584;776.068717538954;794.9085855126648;794.9841003179932;795.32794788404;795.7732046366787;664.3887623386496;681.6148875885109;790.0479921694373;809.3969992355703;820.0241712362299;851.6465666748292;857.0743596915347;860.7805009722543;861.0743450790394;864.2481041493878;853.4580541356283;855.700504823313;856.5631527920743;856.5674334461088;857.691231156783;621.6270237857294;623.7598524568074;623.8908191066545;625.7246811402969;627.1658693937053;13610.59168224955;13852;13937.512187073506;14050.718985620333;14133.293335333296;13129.803052954214;13946.790798138036;13961.650958726012;14001.29993500321;14057.971014492754;10491.842622360671;10606.098481628993;10676.092532134779;10688.09151222147;10816.621418250323;3279.6064472263242;3316.4859446785545;3344.8327583620967;3347.866085356583;3370.9157271068175;65921.67039164821;65989;66331.66834165847;67428.32571674319;68235.31764682339;10430.42632655196;10491.895081049244;10581.153507719364;10600.787984240273;10673.519691613896;19651.705224421647;19663.311784087487;19722.11250493731;19754.70367944482;19966.800331996783;6796.184457864989;6799.286074962157;6799.388055075067;6838.384545390939;7033.788986330418;3600.6039335673054;3667.2298817248675;3690.6862916652385;3695.9260814784093;3699.204670995695;2963.4369469800668;3084.6452657944624;3093.783435159562;3109.518024706174;3112.2841746398453;505.6511007404879;507.50771751401084;512.3211744438634;513.6507175120954;523.3641126031889;612.5038718637918;632.3771085480797;647.4302613699914;647.4334956912701;649.5063751548857;9094.81810363789;9552.665656702122;9586.760330991641;9647.951760241154;9921.206303495703;606.1513880567242;622.5144387377852;631.5358211714387;632.7049123604844;634.2262439823409;4461.933071003938;4601.5168407317415;4612.907741845144;4613.769311534477;4666.556677115668;65634;65904.34095658982;66436.66781666157;68581.3141868585;68583.31416685869;49693.503064968885;56323.71838140783;57707;58613.4138658608;58936.15957606307;54175.999999999214;54193.1871021935;54659.453405465436;55311.723441382535;55663;8631.136886311318;8915.508959359136;8937.910620893708;8965.641374344954;9131.634734610541;35800.82099589486;35841.64158358383;36099.27801443904;36713;36813.44779828358;41804.790976044926;45515.089698205185;45917;46543.301850471595;47553.286700700206;10144.239182061227;10152.746181345525;10300.793984120426;10301.072903438726;10395.32430392022;11466.82799758021;11518;11913.761724765283;11936.224145430519;12454;11163.832542512031;11189.216754827085;11230.943845281048;11996.160268781101;12004.09969252327;10573.788524229627;10629.840552391566;10856.674299771019;10907.672769816918;11267.943660281646;10574.788504230026;10655.89344106549;11067.114630829676;11104.111671066457;11468.94265528667;9324.813503730024;9494.715158545254;9497.952510237405;9759.756006099904;10064;8648.221660050625;9226.538673066454;9250.911998400987;9273.30450216223;9517.476538790155 13:15:17 INFO - PROCESS | 5107 | __end_tp_report 13:15:17 INFO - PROCESS | 5107 | __start_cc_report 13:15:17 INFO - PROCESS | 5107 | _x_x_mozilla_cycle_collect,340 13:15:17 INFO - PROCESS | 5107 | __end_cc_report 13:15:17 INFO - PROCESS | 5107 | __startTimestamp1483996517388__endTimestamp 13:15:17 INFO - PROCESS | 5107 | 13:15:17 INFO - PROCESS | 5107 | ------- Summary: start ------- 13:15:17 INFO - PROCESS | 5107 | Number of tests: 6 13:15:17 INFO - PROCESS | 5107 | 13:15:17 INFO - PROCESS | 5107 | [#0] dojo.html Cycles:165 Average:4818.32 Median:4939.38 stddev:522.79 (10.6%) stddev-sans-first:495.66 13:15:17 INFO - PROCESS | 5107 | Values: 2639.3 2648.3 2650.0 2681.6 2687.2 4756.1 4759.2 4797.6 4826.1 4828.3 4766.5 4808.2 4849.9 4872.4 4919.2 4402.1 4457.8 4461.8 4546.2 4593.7 4086.6 4552.6 4569.0 4578.5 4581.2 4398.2 4501.4 4510.0 4553.2 4602.2 4404.7 4412.5 4423.8 4436.0 4496.8 4362.1 4364.3 4417.7 4423.1 4459.0 4812.4 4828.3 4837.9 4853.3 4865.2 5087.2 5137.4 5216.1 5220.2 5238.8 5287.3 5298.3 5299.6 5308.2 5361.9 4920.2 4929.9 4932.8 4940.9 4952.4 5249.5 5286.9 5292.3 5303.1 5412.4 5175.6 5183.3 5183.5 5191.2 5219.2 5142.6 5282.8 5295.2 5299.7 5323.7 5127.8 5134.0 5136.4 5189.2 5230.1 5174.8 5182.7 5183.1 5213.9 5241.8 4415.8 4419.0 4422.5 4425.8 4462.0 3757.7 3784.9 3799.1 3831.8 3839.8 4534.7 4541.7 4559.2 4574.2 4591.5 5268.7 5282.8 5284.3 5291.5 5294.3 4457.7 4469.6 4495.3 4534.0 4574.3 4670.3 4699.7 4706.8 4722.7 4723.1 4883.6 4887.3 4903.3 4925.0 4939.4 5150.6 5188.1 5279.5 5284.0 5312.1 4874.5 4898.5 4918.5 4921.2 4951.2 5168.5 5169.6 5186.7 5200.5 5239.0 5159.9 5217.8 5229.9 5246.6 5247.8 4894.0 5067.4 5092.4 5095.1 5172.0 5065.9 5095.8 5098.2 5103.5 5116.1 4953.9 4959.5 4971.1 4990.1 5011.9 5044.7 5077.6 5104.1 5142.1 5174.6 4940.3 4971.7 4983.1 4985.3 5027.3 13:15:17 INFO - PROCESS | 5107 | 13:15:17 INFO - PROCESS | 5107 | [#1] ext.html Cycles:180 Average:43555.47 Median:365060.00 stddev:74813.55 (20.5%) stddev-sans-first:74953.58 13:15:17 INFO - PROCESS | 5107 | Values: 500.7 514.4 520.8 537.0 542.1 38392.0 39392.4 39419.8 39472.8 39555.6 39489.8 39978.4 39999.4 40157.2 40204.4 7594.6 7804.9 7811.5 9558.1 9869.8 9325.4 9413.2 9415.0 9416.0 9434.7 9761.9 9782.7 9878.9 9881.2 9906.0 9820.3 9834.6 9843.0 9850.6 9864.5 9498.2 9552.8 9579.9 9581.4 9582.4 34962.5 35054.8 35180.5 35353.6 35400.8 3600.9 3654.3 3666.5 3688.9 3712.8 26501.6 26523.1 26538.3 26658.6 26940.0 3444.7 3495.6 3561.6 3723.1 3760.7 199021.1 199594.0 249507.8 251123.0 251204.0 59693.0 60980.0 61020.4 61079.7 61087.0 49759.5 50015.7 50405.5 50436.0 50458.7 12593.6 12710.2 12768.4 12820.2 12871.9 9870.0 9975.3 10016.9 10324.3 10531.3 19556.4 19570.4 19635.7 19641.6 19655.6 7210.4 7478.1 7567.2 7583.5 7719.3 760.8 761.4 768.5 775.1 780.2 28129.9 28829.6 28840.1 29045.0 29128.4 971.3 981.0 981.4 986.6 1121.6 14304.7 15418.5 15512.0 15562.3 15718.2 359391.0 363107.0 364781.0 364823.0 365297.0 52948.2 53410.2 53849.5 53917.2 54047.5 1217.8 1265.7 1276.9 1280.7 1285.2 26064.2 26912.9 27747.7 27828.9 28182.4 36588.8 36826.8 36843.0 37080.8 37499.8 239925.0 239981.0 240401.0 240657.0 241556.0 24179.3 24806.5 24893.0 25894.0 39448.2 38271.6 38308.6 38501.8 39288.6 39366.2 31882.0 32127.0 32306.2 33261.2 33414.0 27780.4 27876.2 28183.0 28395.4 29232.6 31700.0 32077.5 32331.7 32373.5 32576.3 27114.9 29447.7 29577.7 29647.7 29893.1 22826.9 22860.3 23060.7 23090.9 23173.3 13:15:17 INFO - PROCESS | 5107 | 13:15:17 INFO - PROCESS | 5107 | [#2] jquery.html Cycles:180 Average:27779.86 Median:28657.01 stddev:80900.51 (282.3%) stddev-sans-first:81101.25 13:15:17 INFO - PROCESS | 5107 | Values: 359.6 371.9 372.7 384.2 393.2 16990.0 17783.3 17805.6 18321.5 18348.4 16822.1 17022.5 17331.1 17409.4 17429.1 5066.8 5280.5 5286.8 5294.4 5296.7 4118.3 4592.6 5267.6 6158.4 6219.2 6146.8 6154.0 6169.4 6191.8 6222.8 5335.7 5369.7 5407.9 5409.3 5948.6 5179.8 5272.4 5276.1 5282.3 5296.5 11947.6 17003.5 19190.3 21698.5 21759.8 1772.6 1780.2 1809.0 1834.6 2127.9 8985.2 9055.7 9161.9 9256.7 9581.0 1704.6 1709.4 1752.8 1772.0 1783.4 79739.0 80121.2 80353.6 80530.0 82202.0 10222.4 10364.9 10479.0 10492.2 10598.7 14200.4 14270.4 14277.4 14303.0 14316.4 6860.6 7038.0 7234.1 7287.0 7339.9 6555.8 6556.0 6643.3 6767.6 6770.9 4099.8 4203.9 4250.3 4311.5 4347.3 1763.7 1772.7 1798.2 1822.4 1852.5 955.8 956.2 970.8 971.5 1002.9 15927.8 15951.3 17480.5 17633.5 17640.5 933.8 954.4 979.7 985.7 986.1 9514.4 9830.4 9853.3 9877.8 9931.1 472456.0 483888.0 493388.0 496666.0 504805.0 88261.6 90335.5 90484.0 90492.5 90783.0 953.1 973.7 982.5 986.2 993.9 15003.5 15038.7 15113.3 15286.7 15593.6 37581.0 37887.8 37891.8 37899.2 38189.0 48123.8 52134.2 52298.0 52330.2 54154.7 6426.8 6648.2 7055.2 7156.9 7501.8 9714.9 12060.0 12153.3 12431.6 12749.6 9802.6 9890.4 10005.9 10092.3 10172.5 9738.6 9739.5 9794.9 9892.2 10141.9 9875.9 10057.5 10115.8 10135.4 10141.9 7010.9 7226.5 7278.5 7390.9 7450.7 9842.8 9999.6 10062.2 10067.4 10416.8 13:15:17 INFO - PROCESS | 5107 | 13:15:17 INFO - PROCESS | 5107 | [#3] mootools.html Cycles:180 Average:4766.46 Median:5829.77 stddev:2595.67 (44.5%) stddev-sans-first:2590.28 13:15:17 INFO - PROCESS | 5107 | Values: 1353.6 1365.2 1365.6 1368.2 1368.9 6613.7 6796.3 6991.2 7399.5 7442.6 7003.3 7106.2 7116.6 7273.1 7287.4 2059.0 2073.5 2083.7 2085.5 2095.5 2013.4 2054.6 2072.7 2099.6 2104.0 2055.4 2061.2 2064.6 2074.2 2080.8 2005.7 2024.9 2029.1 2030.3 2038.5 2050.3 2074.9 2075.9 2101.9 2103.5 7341.4 7365.6 7377.3 7391.2 7481.5 4390.3 4450.7 4469.8 4471.7 4487.9 2645.6 2813.3 2830.6 2847.5 2852.1 1077.5 1087.6 1096.8 1102.1 1144.8 9440.9 9503.5 9517.3 9518.8 9706.8 3634.4 3798.5 3850.4 3867.0 3917.3 7764.1 7783.6 7808.1 7810.6 7813.8 4181.2 4232.4 4267.1 4280.4 4285.7 3966.6 3995.6 4016.4 4039.7 4068.4 3231.0 3254.9 3280.4 3342.1 3354.0 902.0 915.5 919.1 930.8 944.1 671.4 685.8 689.2 691.1 796.9 4541.8 4548.4 4851.3 4863.8 5134.8 910.4 930.8 952.5 965.6 975.4 3189.8 3400.3 3430.1 3463.8 3479.8 8648.9 8749.5 8844.4 8904.3 8921.0 8710.4 8798.1 8863.4 8886.5 8890.4 6892.4 6905.1 6918.4 7003.9 7021.8 4814.3 4848.0 4961.4 4964.5 5131.5 8001.5 8061.6 8080.0 8085.8 8211.9 8165.5 8247.8 8254.6 8262.0 8320.9 6035.5 6099.9 6127.9 6169.3 6266.1 6747.4 6813.7 6828.5 6885.2 6889.1 6379.4 6466.3 6514.2 6527.4 6558.4 6367.7 6385.4 6399.9 6420.5 6472.5 5823.3 5836.2 5843.6 5859.2 5878.1 4396.4 4410.1 4410.1 4506.9 4525.1 4337.8 4395.3 4478.9 4508.0 4525.3 13:15:17 INFO - PROCESS | 5107 | 13:15:17 INFO - PROCESS | 5107 | [#4] prototype.html Cycles:180 Average:4300.58 Median:4931.36 stddev:1261.50 (25.6%) stddev-sans-first:1229.47 13:15:17 INFO - PROCESS | 5107 | Values: 337.5 338.2 350.4 353.5 354.4 4983.0 4992.6 4995.2 5007.4 5018.5 4964.0 4973.5 4974.5 4980.7 5002.6 3768.8 3790.4 3857.8 3873.3 3891.8 3878.8 3885.4 3912.8 3914.4 3935.4 3886.4 3898.3 3899.4 3902.9 3905.7 3577.8 3775.4 3937.8 3942.3 3948.5 3249.1 3266.7 3300.4 3316.6 3327.3 4777.6 4794.7 4815.8 4822.7 4832.2 4343.8 4349.7 4376.9 4377.8 4432.2 5102.5 5161.3 5191.6 5192.9 5221.8 3629.2 3640.5 3648.5 3655.8 3662.3 5494.4 5503.5 5518.1 5521.4 5539.5 3637.9 3721.2 3734.1 3741.4 3785.6 3777.2 3793.4 3794.5 3796.2 3797.7 4354.8 4355.7 4368.9 4380.0 4384.2 5133.5 5286.9 5295.6 5296.8 5306.6 1265.7 1277.7 1279.0 1280.7 1285.5 823.0 833.4 859.4 864.7 878.4 4457.8 4599.3 4610.4 4612.4 4614.5 5323.8 5365.4 5388.9 5391.8 5393.5 4587.0 4592.6 4599.1 4612.4 4623.9 2637.4 2747.9 2778.2 2791.0 2807.7 4833.7 4867.6 4873.8 4900.6 4922.8 5138.3 5324.9 5340.1 5349.5 5353.7 5010.2 5010.8 5022.5 5027.5 5037.6 5350.9 5366.5 5376.9 5381.2 5386.6 5190.8 5232.3 5276.2 5293.8 5328.0 5038.0 5069.0 5078.6 5079.0 5080.9 3729.0 3735.9 3745.9 3748.0 3762.2 5112.5 5346.7 5408.2 5423.7 5424.9 5174.2 5185.0 5188.2 5189.9 5196.5 5119.1 5177.5 5194.8 5205.7 5235.2 4850.6 5085.2 5095.4 5118.0 5124.9 4940.0 5090.9 5101.2 5194.2 5210.9 5076.8 5081.7 5086.2 5094.8 5106.7 13:15:17 INFO - PROCESS | 5107 | 13:15:17 INFO - PROCESS | 5107 | [#5] yui.html Cycles:180 Average:15101.14 Median:48623.39 stddev:18884.13 (38.8%) stddev-sans-first:18906.03 13:15:17 INFO - PROCESS | 5107 | Values: 674.4 674.7 739.1 770.8 787.1 12823.9 13891.9 14077.2 14324.4 14572.8 13614.5 13650.2 13771.4 13801.0 13995.2 776.1 794.9 795.0 795.3 795.8 664.4 681.6 790.0 809.4 820.0 851.6 857.1 860.8 861.1 864.2 853.5 855.7 856.6 856.6 857.7 621.6 623.8 623.9 625.7 627.2 13610.6 13852.0 13937.5 14050.7 14133.3 13129.8 13946.8 13961.7 14001.3 14058.0 10491.8 10606.1 10676.1 10688.1 10816.6 3279.6 3316.5 3344.8 3347.9 3370.9 65921.7 65989.0 66331.7 67428.3 68235.3 10430.4 10491.9 10581.2 10600.8 10673.5 19651.7 19663.3 19722.1 19754.7 19966.8 6796.2 6799.3 6799.4 6838.4 7033.8 3600.6 3667.2 3690.7 3695.9 3699.2 2963.4 3084.6 3093.8 3109.5 3112.3 505.7 507.5 512.3 513.7 523.4 612.5 632.4 647.4 647.4 649.5 9094.8 9552.7 9586.8 9648.0 9921.2 606.2 622.5 631.5 632.7 634.2 4461.9 4601.5 4612.9 4613.8 4666.6 65634.0 65904.3 66436.7 68581.3 68583.3 49693.5 56323.7 57707.0 58613.4 58936.2 54176.0 54193.2 54659.5 55311.7 55663.0 8631.1 8915.5 8937.9 8965.6 9131.6 35800.8 35841.6 36099.3 36713.0 36813.4 41804.8 45515.1 45917.0 46543.3 47553.3 10144.2 10152.7 10300.8 10301.1 10395.3 11466.8 11518.0 11913.8 11936.2 12454.0 11163.8 11189.2 11230.9 11996.2 12004.1 10573.8 10629.8 10856.7 10907.7 11267.9 10574.8 10655.9 11067.1 11104.1 11468.9 9324.8 9494.7 9498.0 9759.8 10064.0 8648.2 9226.5 9250.9 9273.3 9517.5 13:15:17 INFO - PROCESS | 5107 | -------- Summary: end -------- 13:15:17 INFO - PROCESS | 5107 | 13:15:18 INFO - TEST-INFO | 5107: exit 0 13:15:18 INFO - TEST-OK | dromaeo_css | took 1119946ms 13:15:18 INFO - TEST-START | kraken 13:15:18 INFO - operating with platform_type : linux_ 13:15:18 INFO - Initialising browser for kraken test... 13:15:18 INFO - TEST-INFO | started process 5451 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZY3OIO/profile http://localhost:41458/getInfo.html) 13:15:18 INFO - PROCESS | 5451 | 1483996518753 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:4906 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3761 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2794 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 13:15:22 INFO - PROCESS | 5451 | __metrics Screen width/height:1600/1200 13:15:22 INFO - PROCESS | 5451 | colorDepth:24 13:15:22 INFO - PROCESS | 5451 | Browser inner width/height: 1024/697 13:15:22 INFO - PROCESS | 5451 | __metrics 13:15:23 ERROR - PROCESS | 5451 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 13:15:24 INFO - TEST-INFO | 5451: exit 0 13:15:24 INFO - Browser initialized. 13:15:24 INFO - Running cycle 1/1 for kraken test... 13:15:24 INFO - TEST-INFO | started process 5569 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZY3OIO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:15:36 INFO - PROCESS | 5569 | RSS: Main: 158629888 13:15:36 INFO - PROCESS | 5569 | 13:15:39 INFO - PROCESS | 5569 | Cycle 1(1): loaded http://localhost:41458/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41458/tests/kraken/driver.html?testName=audio-beat-detection) 13:15:40 INFO - PROCESS | 5569 | RSS: Main: 164683776 13:15:40 INFO - PROCESS | 5569 | 13:15:43 INFO - PROCESS | 5569 | Cycle 1(1): loaded http://localhost:41458/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41458/tests/kraken/driver.html?testName=audio-dft) 13:15:43 INFO - PROCESS | 5569 | RSS: Main: 163262464 13:15:43 INFO - PROCESS | 5569 | 13:15:46 INFO - PROCESS | 5569 | Cycle 1(1): loaded http://localhost:41458/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41458/tests/kraken/driver.html?testName=audio-fft) 13:15:47 INFO - PROCESS | 5569 | RSS: Main: 160141312 13:15:47 INFO - PROCESS | 5569 | 13:15:49 INFO - PROCESS | 5569 | Cycle 1(1): loaded http://localhost:41458/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41458/tests/kraken/driver.html?testName=audio-oscillator) 13:15:50 INFO - PROCESS | 5569 | RSS: Main: 161095680 13:15:50 INFO - PROCESS | 5569 | 13:15:52 INFO - PROCESS | 5569 | Cycle 1(1): loaded http://localhost:41458/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41458/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:15:52 INFO - PROCESS | 5569 | RSS: Main: 161267712 13:15:52 INFO - PROCESS | 5569 | 13:15:55 INFO - PROCESS | 5569 | Cycle 1(1): loaded http://localhost:41458/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41458/tests/kraken/driver.html?testName=imaging-darkroom) 13:15:56 INFO - PROCESS | 5569 | RSS: Main: 166191104 13:15:56 INFO - PROCESS | 5569 | 13:16:00 INFO - PROCESS | 5569 | Cycle 1(1): loaded http://localhost:41458/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41458/tests/kraken/driver.html?testName=imaging-desaturate) 13:16:00 INFO - PROCESS | 5569 | RSS: Main: 162250752 13:16:00 INFO - PROCESS | 5569 | 13:16:03 INFO - PROCESS | 5569 | Cycle 1(1): loaded http://localhost:41458/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41458/tests/kraken/driver.html?testName=json-parse-financial) 13:16:04 INFO - PROCESS | 5569 | RSS: Main: 163639296 13:16:04 INFO - PROCESS | 5569 | 13:16:05 INFO - PROCESS | 5569 | Cycle 1(1): loaded http://localhost:41458/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41458/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:16:06 INFO - PROCESS | 5569 | RSS: Main: 163983360 13:16:06 INFO - PROCESS | 5569 | 13:16:08 INFO - PROCESS | 5569 | Cycle 1(1): loaded http://localhost:41458/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41458/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:16:09 INFO - PROCESS | 5569 | RSS: Main: 163864576 13:16:09 INFO - PROCESS | 5569 | 13:16:11 INFO - PROCESS | 5569 | Cycle 1(1): loaded http://localhost:41458/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41458/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:16:12 INFO - PROCESS | 5569 | RSS: Main: 164294656 13:16:12 INFO - PROCESS | 5569 | 13:16:14 INFO - PROCESS | 5569 | Cycle 1(1): loaded http://localhost:41458/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41458/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:16:15 INFO - PROCESS | 5569 | RSS: Main: 164851712 13:16:15 INFO - PROCESS | 5569 | 13:16:18 INFO - PROCESS | 5569 | Cycle 1(1): loaded http://localhost:41458/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41458/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:16:19 INFO - PROCESS | 5569 | RSS: Main: 164667392 13:16:19 INFO - PROCESS | 5569 | 13:16:21 INFO - PROCESS | 5569 | Cycle 1(1): loaded http://localhost:41458/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41458/tests/kraken/driver.html?testName=ai-astar) 13:16:21 INFO - PROCESS | 5569 | RSS: Main: 166236160 13:16:21 INFO - PROCESS | 5569 | 13:16:21 INFO - PROCESS | 5569 | __start_tp_report 13:16:21 INFO - PROCESS | 5569 | _x_x_mozilla_page_load 13:16:21 INFO - PROCESS | 5569 | _x_x_mozilla_page_load_details 13:16:21 INFO - PROCESS | 5569 | |i|pagename|runs| 13:16:21 INFO - PROCESS | 5569 | |0;ai-astar;110;114;114;115;116;116;116;116;114;116 13:16:21 INFO - PROCESS | 5569 | |1;audio-beat-detection;156;130;130;177;125;124;125;125;159;131 13:16:21 INFO - PROCESS | 5569 | |2;audio-dft;166;166;167;167;163;167;163;162;163;165 13:16:21 INFO - PROCESS | 5569 | |3;audio-fft;78;77;77;106;77;79;78;76;92;76 13:16:21 INFO - PROCESS | 5569 | |4;audio-oscillator;84;84;113;86;85;86;111;87;85;107 13:16:21 INFO - PROCESS | 5569 | |5;imaging-gaussian-blur;118;118;118;118;118;122;117;119;118;118 13:16:21 INFO - PROCESS | 5569 | |6;imaging-darkroom;152;149;150;150;152;150;151;150;150;151 13:16:21 INFO - PROCESS | 5569 | |7;imaging-desaturate;97;96;96;96;101;97;95;96;96;103 13:16:21 INFO - PROCESS | 5569 | |8;json-parse-financial;64;65;66;64;64;65;66;65;66;65 13:16:21 INFO - PROCESS | 5569 | |9;json-stringify-tinderbox;67;67;67;68;68;67;67;68;67;68 13:16:21 INFO - PROCESS | 5569 | |10;stanford-crypto-aes;86;84;85;91;98;86;86;85;84;93 13:16:21 INFO - PROCESS | 5569 | |11;stanford-crypto-ccm;145;150;149;133;154;146;133;147;224;148 13:16:21 INFO - PROCESS | 5569 | |12;stanford-crypto-pbkdf2;185;182;188;181;180;180;178;185;178;181 13:16:21 INFO - PROCESS | 5569 | |13;stanford-crypto-sha256-iterative;72;70;70;74;71;70;87;70;70;69 13:16:21 INFO - PROCESS | 5569 | __end_tp_report 13:16:21 INFO - PROCESS | 5569 | __start_cc_report 13:16:21 INFO - PROCESS | 5569 | _x_x_mozilla_cycle_collect,843 13:16:21 INFO - PROCESS | 5569 | __end_cc_report 13:16:21 INFO - PROCESS | 5569 | __startTimestamp1483996581444__endTimestamp 13:16:21 INFO - PROCESS | 5569 | 13:16:21 INFO - PROCESS | 5569 | ------- Summary: start ------- 13:16:21 INFO - PROCESS | 5569 | Number of tests: 14 13:16:21 INFO - PROCESS | 5569 | 13:16:21 INFO - PROCESS | 5569 | [#0] ai-astar Cycles:10 Average:114.70 Median:116.00 stddev:1.89 (1.6%) stddev-sans-first:0.97 13:16:21 INFO - PROCESS | 5569 | Values: 110.0 114.0 114.0 115.0 116.0 116.0 116.0 116.0 114.0 116.0 13:16:21 INFO - PROCESS | 5569 | 13:16:21 INFO - PROCESS | 5569 | [#1] audio-beat-detection Cycles:10 Average:138.20 Median:130.50 stddev:18.75 (14.4%) stddev-sans-first:18.75 13:16:21 INFO - PROCESS | 5569 | Values: 156.0 130.0 130.0 177.0 125.0 124.0 125.0 125.0 159.0 131.0 13:16:21 INFO - PROCESS | 5569 | 13:16:21 INFO - PROCESS | 5569 | [#2] audio-dft Cycles:10 Average:164.90 Median:166.00 stddev:1.97 (1.2%) stddev-sans-first:2.05 13:16:21 INFO - PROCESS | 5569 | Values: 166.0 166.0 167.0 167.0 163.0 167.0 163.0 162.0 163.0 165.0 13:16:21 INFO - PROCESS | 5569 | 13:16:21 INFO - PROCESS | 5569 | [#3] audio-fft Cycles:10 Average:81.60 Median:77.50 stddev:9.79 (12.6%) stddev-sans-first:10.30 13:16:21 INFO - PROCESS | 5569 | Values: 78.0 77.0 77.0 106.0 77.0 79.0 78.0 76.0 92.0 76.0 13:16:21 INFO - PROCESS | 5569 | 13:16:21 INFO - PROCESS | 5569 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:85.00 stddev:12.22 (14.4%) stddev-sans-first:12.54 13:16:21 INFO - PROCESS | 5569 | Values: 84.0 84.0 113.0 86.0 85.0 86.0 111.0 87.0 85.0 107.0 13:16:21 INFO - PROCESS | 5569 | 13:16:21 INFO - PROCESS | 5569 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.00 stddev:1.35 (1.1%) stddev-sans-first:1.42 13:16:21 INFO - PROCESS | 5569 | Values: 118.0 118.0 118.0 118.0 118.0 122.0 117.0 119.0 118.0 118.0 13:16:21 INFO - PROCESS | 5569 | 13:16:21 INFO - PROCESS | 5569 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:150.50 stddev:0.97 (0.6%) stddev-sans-first:0.87 13:16:21 INFO - PROCESS | 5569 | Values: 152.0 149.0 150.0 150.0 152.0 150.0 151.0 150.0 150.0 151.0 13:16:21 INFO - PROCESS | 5569 | 13:16:21 INFO - PROCESS | 5569 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:96.00 stddev:2.58 (2.7%) stddev-sans-first:2.74 13:16:21 INFO - PROCESS | 5569 | Values: 97.0 96.0 96.0 96.0 101.0 97.0 95.0 96.0 96.0 103.0 13:16:21 INFO - PROCESS | 5569 | 13:16:21 INFO - PROCESS | 5569 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 13:16:21 INFO - PROCESS | 5569 | Values: 64.0 65.0 66.0 64.0 64.0 65.0 66.0 65.0 66.0 65.0 13:16:21 INFO - PROCESS | 5569 | 13:16:21 INFO - PROCESS | 5569 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 13:16:21 INFO - PROCESS | 5569 | Values: 67.0 67.0 67.0 68.0 68.0 67.0 67.0 68.0 67.0 68.0 13:16:21 INFO - PROCESS | 5569 | 13:16:21 INFO - PROCESS | 5569 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:86.00 stddev:4.66 (5.4%) stddev-sans-first:4.90 13:16:21 INFO - PROCESS | 5569 | Values: 86.0 84.0 85.0 91.0 98.0 86.0 86.0 85.0 84.0 93.0 13:16:21 INFO - PROCESS | 5569 | 13:16:21 INFO - PROCESS | 5569 | [#11] stanford-crypto-ccm Cycles:10 Average:152.90 Median:148.50 stddev:25.91 (17.4%) stddev-sans-first:27.32 13:16:21 INFO - PROCESS | 5569 | Values: 145.0 150.0 149.0 133.0 154.0 146.0 133.0 147.0 224.0 148.0 13:16:21 INFO - PROCESS | 5569 | 13:16:21 INFO - PROCESS | 5569 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.80 Median:181.50 stddev:3.26 (1.8%) stddev-sans-first:3.24 13:16:21 INFO - PROCESS | 5569 | Values: 185.0 182.0 188.0 181.0 180.0 180.0 178.0 185.0 178.0 181.0 13:16:21 INFO - PROCESS | 5569 | 13:16:21 INFO - PROCESS | 5569 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:70.50 stddev:5.36 (7.6%) stddev-sans-first:5.68 13:16:21 INFO - PROCESS | 5569 | Values: 72.0 70.0 70.0 74.0 71.0 70.0 87.0 70.0 70.0 69.0 13:16:21 INFO - PROCESS | 5569 | -------- Summary: end -------- 13:16:21 INFO - PROCESS | 5569 | 13:16:22 INFO - TEST-INFO | 5569: exit 0 13:16:22 INFO - TEST-OK | kraken | took 64355ms 13:16:22 INFO - SUITE-END | took 1184s 13:16:23 INFO - Completed test suite (00:19:44) 13:16:23 INFO - javascript benchmark 13:16:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6382.993350308645, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2639.3137784176115, 2648.2982009767416, 2649.9602505962425, 2681.6379788728514, 2687.153546632812, 4756.09634169508, 4759.238521836507, 4797.6161907047435, 4826.0830442216, 4828.324034635154, 4766.4518580363265, 4808.230683090706, 4849.903001939959, 4872.3909511311085, 4919.163742163832, 4402.119576084788, 4457.84397546086, 4461.750709801261, 4546.204414227497, 4593.713760147164, 4086.570910054446, 4552.590266875981, 4568.954310456903, 4578.450585929693, 4581.1753884300815, 4398.23030969579, 4501.437320334958, 4510.0, 4553.180427523044, 4602.194615942197, 4404.669649776248, 4412.514623391425, 4423.7566933818625, 4436.046250056221, 4496.79764410599, 4362.083962367907, 4364.301711726141, 4417.7349359038235, 4423.137488189805, 4459.0, 4812.446568644581, 4828.251620998751, 4837.927431088537, 4853.320535125085, 4865.19724245499, 5087.160618497944, 5137.357830271216, 5216.087184742692, 5220.216967454874, 5238.816641417532, 5287.286216360819, 5298.258243845865, 5299.5760339172775, 5308.230306605559, 5361.919571206435, 4920.1635721927005, 4929.926051109236, 4932.802687892444, 4940.925886111711, 4952.380952380989, 5249.527542521191, 5286.920696189561, 5292.259083728281, 5303.098473259555, 5412.377576578665, 5175.560077393388, 5183.2743415921805, 5183.533481986639, 5191.169412893919, 5219.164933610604, 5142.614303927146, 5282.788688452419, 5295.152775555893, 5299.682019078868, 5323.733813309319, 5127.846164615067, 5133.974330128325, 5136.357955255593, 5189.247559103909, 5230.08473517133, 5174.767135478913, 5182.663126896739, 5183.118869792144, 5213.869653258699, 5241.790328386822, 4415.757133357696, 4418.977905110454, 4422.513523512411, 4425.75658338788, 4461.977690111528, 3757.7181711371754, 3784.8864534064023, 3799.145192331703, 3831.7892515911335, 3839.846406143779, 4534.727916325031, 4541.682082254277, 4559.224931761609, 4574.153781550423, 4591.517890621437, 5268.683878967274, 5282.7622756976025, 5284.339457567804, 5291.523762861361, 5294.258803767476, 4457.687961842705, 4469.575390337977, 4495.325701144854, 4533.977330113395, 4574.313852922089, 4670.346151538719, 4699.718016918996, 4706.835260765857, 4722.693024953367, 4723.055388922229, 4883.560479556857, 4887.340209071872, 4903.338049363433, 4925.0, 4939.382577177853, 5150.6137039721425, 5188.118019936544, 5279.47205279469, 5284.0, 5312.096943519534, 4874.512548745097, 4898.461169271449, 4918.458969513279, 4921.212605983025, 4951.158303088556, 5168.457311982338, 5169.61227907916, 5186.740662966761, 5200.531952124327, 5239.0, 5159.922601160911, 5217.8173763918085, 5229.869253268699, 5246.580273578181, 5247.8163264287095, 4893.975530122327, 5067.366579177603, 5092.439831618593, 5095.133827249302, 5172.0, 5065.898682026265, 5095.77069031887, 5098.2352647103235, 5103.464136265638, 5116.130257856099, 4953.925691114709, 4959.504049595012, 4971.130052240771, 4990.126727822689, 5011.9498805012945, 5044.722540260174, 5077.644564880571, 5104.132297509358, 5142.1258386073705, 5174.6119041071315, 4940.283658869372, 4971.676841005323, 4983.07813054586, 4985.326980857538, 5027.296178534935], "value": 4783.538220959582, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.7195970256657, 514.4135685318737, 520.8489538033971, 536.9650972686773, 542.1001138110737, 38392.0, 39392.40911386328, 39419.80290098552, 39472.80263598678, 39555.604443955555, 39489.802550987275, 39978.40032399516, 39999.40000899989, 40157.19685606286, 40204.39693404594, 7594.620268986542, 7804.882926756103, 7811.453198276123, 9558.091981261769, 9869.753256168582, 9325.393849399801, 9413.152816246537, 9414.952925235364, 9416.0, 9434.716958491255, 9761.902380976206, 9782.706518804413, 9878.851817222747, 9881.16010139139, 9906.0, 9820.263480238975, 9834.606615735362, 9843.0, 9850.60597576096, 9864.506774661239, 9498.19265362445, 9552.761180970461, 9579.856302155473, 9581.377210481367, 9582.370996930538, 34962.47556286658, 35054.824725876206, 35180.47229291563, 35353.64646353529, 35400.82299588485, 3600.945985810215, 3654.3422184006868, 3666.478411459241, 3688.8524459021874, 3712.832922518493, 26501.602475962874, 26523.07169249067, 26538.33654158642, 26658.600120998202, 26940.0, 3444.7071998880124, 3495.5805303363504, 3561.626029266916, 3723.1250656095795, 3760.7179461540495, 199021.11746590503, 199594.0, 249507.79183769584, 251123.0, 251204.0, 59693.0, 60980.0, 61020.38979610236, 61079.69460152671, 61087.0, 49759.50240497549, 50015.74992125089, 50405.49594504008, 50436.0, 50458.692663417074, 12593.559225427067, 12710.173838700455, 12768.425420856083, 12820.166689165175, 12871.935640321739, 9870.0, 9975.301728878909, 10016.899831001743, 10324.328918620266, 10531.262811603114, 19556.413307600797, 19570.434365250745, 19635.705464418046, 19641.607167856564, 19655.60688786245, 7210.423166146696, 7478.055705516605, 7567.243275672498, 7583.469157158946, 7719.3052625264, 760.7869796457001, 761.4251240313528, 768.5350363030398, 775.0931410250021, 780.1925007617089, 28129.859350703115, 28829.56755648667, 28840.12539184943, 29045.0, 29128.417431651247, 971.3394891473724, 980.9558569864373, 981.3768257156614, 986.6004268271362, 1121.6242558742913, 14304.713905721826, 15418.460353887784, 15512.0, 15562.299696513684, 15718.21408929549, 359391.0, 363107.0, 364781.0, 364823.0, 365297.0, 52948.205776913375, 53410.198847017324, 53849.461505385225, 53917.19124213061, 54047.45952540503, 1217.792975194219, 1265.7278685082567, 1276.9425375858295, 1280.7182419867613, 1285.2352850054203, 26064.218073457825, 26912.865435672695, 27747.722522774515, 27828.86085569559, 28182.43635127245, 36588.81705591455, 36826.8158659205, 36843.0, 37080.81459592793, 37499.81250093732, 239925.0, 239981.0, 240401.0, 240657.0, 241556.0, 24179.274621760673, 24806.50386992286, 24893.0, 25894.0, 39448.2110357797, 38271.6172838268, 38308.616913830505, 38501.80749096237, 39288.6071139285, 39366.212675746894, 31882.0, 32127.0, 32306.19234519062, 33261.16847078746, 33414.0, 27780.44439111166, 27876.16371508858, 28183.0, 28395.43209135847, 29232.56151157777, 31700.0, 32077.518837216994, 32331.676683233807, 32373.514397283587, 32576.34847302993, 27114.864425677744, 29447.705522944496, 29577.704222957494, 29647.703522965356, 29893.103206903827, 22826.885865570566, 22860.31419057431, 23060.654090188997, 23090.884545577166, 23173.304800856], "value": 17387.88885606183, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.6493418916557, 371.9293334266489, 372.68321926362586, 384.1606090691837, 393.22338381696136, 16990.0, 17783.288668453264, 17805.64388712225, 18321.45035648931, 18348.44954651359, 16822.0747858868, 17022.489325320228, 17331.133443327846, 17409.390671326506, 17429.128543572835, 5066.797328106872, 5280.498352656491, 5286.788528458857, 5294.364676238857, 5296.682199068049, 4118.258713431581, 4592.632589392857, 5267.55225805807, 6158.445739883409, 6219.19150510433, 6146.784862529812, 6154.046122850965, 6169.352218017111, 6191.752329906798, 6222.782202622909, 5335.706536140511, 5369.704666243355, 5407.891842163154, 5409.2690339091505, 5948.553858460611, 5179.792808287664, 5272.367315922075, 5276.050310944029, 5282.31329927107, 5296.496832800878, 11947.581834635834, 17003.489895303162, 19190.328338508225, 21698.457538561503, 21759.782402176093, 1772.59230377014, 1780.2344991653583, 1808.9909550452296, 1834.5688763140652, 2127.8829664368454, 8985.23625491834, 9055.68305109318, 9161.862572061424, 9256.72229833106, 9581.0, 1704.565335839353, 1709.3504468301965, 1752.815954324803, 1771.9822801771945, 1783.4025601423539, 79739.0, 80121.19878801254, 80353.59823200906, 80530.0, 82202.0, 10222.386656800616, 10364.896351036545, 10479.0, 10492.21308401873, 10598.682039538671, 14200.360983755756, 14270.3578338975, 14277.357518911675, 14303.0, 14316.355763990645, 6860.622665753432, 7038.0, 7234.131904171533, 7287.0, 7339.926600733925, 6555.836104097436, 6556.0, 6643.30245324234, 6767.593944363354, 6770.898436523456, 4099.754014759124, 4203.906984184134, 4250.298700714409, 4311.490978157683, 4347.282698354799, 1763.7178051511953, 1772.6631939931372, 1798.2087881332172, 1822.3986084592052, 1852.4720454670355, 955.7658373698488, 956.1729104324709, 970.8111434825131, 971.5482300730054, 1002.9197664186847, 15927.761083583755, 15951.282192301142, 17480.47558573245, 17633.470995869888, 17640.470785876445, 933.7712260496222, 954.3987288008649, 979.7354714227118, 985.69936169469, 986.068165583531, 9514.381565198379, 9830.361026533252, 9853.310268281295, 9877.802443951081, 9931.106200441995, 472456.0, 483888.0, 493388.0, 496666.0, 504805.0, 88261.55869220613, 90335.54832225796, 90484.0, 90492.5475372619, 90783.0, 953.0755167487526, 973.7127547373542, 982.4547376206132, 986.1913231150531, 993.9155171810477, 15003.549893503212, 15038.6992260152, 15113.31990060472, 15286.694266114839, 15593.610159746097, 37581.0, 37887.81056094702, 37891.81054094712, 37899.242015160096, 38189.0, 48123.75938120287, 52134.21798673099, 52298.0, 52330.21504677357, 54154.72922635519, 6426.807195784134, 6648.202215734143, 7055.153381594037, 7156.892646610409, 7501.774946751606, 9714.854277185706, 12060.0, 12153.331566763913, 12431.564895228623, 12749.617511474671, 9802.607895684092, 9890.406575605486, 10005.899941000787, 10092.293539452168, 10172.542235599563, 9738.561764720464, 9739.464329461664, 9794.902050979399, 9892.15916647093, 10141.949290253502, 9875.901240987498, 10057.547410366697, 10115.848262275924, 10135.442550659785, 10141.949290253502, 7010.894836577353, 7226.494145409771, 7278.454115941219, 7390.852182956418, 7450.6647200875, 9842.75393115178, 9999.55002024896, 10062.245331600014, 10067.446290453803, 10416.791664166825], "value": 8370.228263071886, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.560092969785, 1365.1672479787328, 1365.6039748472938, 1368.2474638948581, 1368.9247091409973, 6613.735450581983, 6796.25241223465, 6991.16106067272, 7399.482036257464, 7442.627868606568, 7003.299670032994, 7106.21831598525, 7116.644167791603, 7273.12722473304, 7287.380572651317, 2059.0, 2073.481629592602, 2083.6978638097467, 2085.4786303424144, 2095.4970807006284, 2013.4261735405412, 2054.6301665700166, 2072.6890966355018, 2099.6325643012487, 2104.0, 2055.383384984506, 2061.196133507933, 2064.5870825834895, 2074.222166687492, 2080.8127268545827, 2005.739253896984, 2024.908879100444, 2029.1071928351478, 2030.2893987104544, 2038.541328201143, 2050.282401159597, 2074.8651337663005, 2075.9481012974647, 2101.8633788803677, 2103.463616777727, 7341.375983041395, 7365.594892280922, 7377.3360397564475, 7391.22392148822, 7481.513701609378, 4390.297552391602, 4450.688451808374, 4469.7541635210055, 4471.686981911267, 4487.932681009787, 2645.5899335603012, 2813.268550176969, 2830.5754136879427, 2847.515922293215, 2852.144356692984, 1077.5258886090096, 1087.5758454202867, 1096.7641956979287, 1102.063246240697, 1144.8168293073068, 9440.905590944072, 9503.477308748015, 9517.286203534693, 9518.762030949212, 9706.805863882682, 3634.436662317345, 3798.5441746990537, 3850.441685955521, 3866.9806650966566, 3917.2948869203815, 7764.107127680276, 7783.649735761905, 7808.063032436144, 7810.609469526615, 7813.804654883674, 4181.205570941512, 4232.407462955189, 4267.0825772459075, 4280.400743895857, 4285.678574106954, 3966.5636779954184, 3995.580464051233, 4016.4376987221813, 4039.73741706794, 4068.3694027425795, 3231.0, 3254.902352929416, 3280.3931272714626, 3342.064222017839, 3353.9664603353654, 901.9684311049213, 915.5239275576663, 919.090100800203, 930.8184903943666, 944.126682818404, 671.3521451799037, 685.8491131950963, 689.1557841644046, 691.0636088100651, 796.9442139050211, 4541.772911354419, 4548.363229147922, 4851.2723091535845, 4863.781129849165, 5134.820281290137, 910.4355299714219, 930.7719608695777, 952.457099453305, 965.5799727118725, 975.3660120921458, 3189.840507974592, 3400.336934297788, 3430.091025878144, 3463.8268086595567, 3479.7738147020364, 8648.913510864812, 8749.518776467356, 8844.425112367675, 8904.332175086894, 8920.955395223113, 8710.43382180169, 8798.076201998825, 8863.379563430499, 8886.51124188163, 8890.377673562789, 6892.414144797748, 6905.136857892763, 6918.446524277945, 7003.8599228015155, 7021.754238601625, 4814.301926220748, 4848.0, 4961.404631444249, 4964.478729733326, 5131.538161565477, 8001.479903806234, 8061.596920153852, 8080.0, 8085.797855053671, 8211.917880821115, 8165.510069395856, 8247.752567422987, 8254.628541715758, 8262.049864265446, 8320.875186872081, 6035.456808887221, 6099.9390006099375, 6127.877442451037, 6169.321374648695, 6266.091416744455, 6747.359000894907, 6813.727450901908, 6828.5220034597105, 6885.173779146535, 6889.138857642794, 6379.362063793584, 6466.32103629131, 6514.1531600891585, 6527.412532872065, 6558.442532384801, 6367.745290188341, 6385.393387628168, 6399.8720025598295, 6420.486361091195, 6472.546921715435, 5823.301203855564, 5836.24128863262, 5843.649381037151, 5859.2090067842, 5878.059510478303, 4396.3845061690745, 4410.0738844842945, 4410.140022695544, 4506.887327816831, 4525.117602067565, 4337.761423121632, 4395.296752519582, 4478.888027799331, 4508.0, 4525.321201819622], "value": 3875.5227766059897, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.5493715889288, 338.18328736102313, 350.44979382369684, 353.4521491687883, 354.36037951497536, 4983.0, 4992.577115522077, 4995.201727378141, 5007.399112106547, 5018.473060328668, 4963.975180124104, 4973.5026497350245, 4974.468127629379, 4980.662955819601, 5002.574781143607, 3768.773873567588, 3790.431435284702, 3857.7685338879755, 3873.334466179542, 3891.766494010354, 3878.806059697018, 3885.358915778893, 3912.8043597819997, 3914.4324073009398, 3935.429362742401, 3886.3871493330234, 3898.259330727167, 3899.4345819856103, 3902.9266951588256, 3905.672071495691, 3577.8032208228537, 3775.4336849472525, 3937.8424863005444, 3942.2706799242087, 3948.486696729407, 3249.0740139060254, 3266.738660907122, 3300.389427955836, 3316.6020077590842, 3327.2846338037198, 4777.59390451812, 4794.736289504076, 4815.7847390200195, 4822.71063736177, 4832.1543729847135, 4343.847965321199, 4349.717268377545, 4376.934345984812, 4377.752340582919, 4432.224360736858, 5102.515261050195, 5161.27742116104, 5191.610629202787, 5192.92210616841, 5221.791128354861, 3629.2197177606677, 3640.4903313536124, 3648.452732090181, 3655.817209139559, 3662.304162209172, 5494.36814766303, 5503.477169668915, 5518.082161665223, 5521.371195497338, 5539.473749993744, 3637.890863274106, 3721.199942012426, 3734.10381508436, 3741.4387841823946, 3785.5835858055593, 3777.1501412182038, 3793.412021136728, 3794.5067141271456, 3796.2217745362136, 3797.6582107610448, 4354.804033818486, 4355.715064056111, 4368.907773056736, 4380.0, 4384.188925048876, 5133.5379815816, 5286.920696189561, 5295.602829787781, 5296.761645725952, 5306.646805064761, 1265.6709255593612, 1277.7158955249915, 1279.0215485153865, 1280.6670265730977, 1285.53720660564, 822.9917700823034, 833.3666413525764, 859.3984211052289, 864.6627815152095, 878.3675753457628, 4457.799399027052, 4599.3442360750105, 4610.354550362952, 4612.446506419251, 4614.538546145426, 5323.813666521731, 5365.356157261153, 5388.91916621251, 5391.81128660495, 5393.514583687487, 4586.954130458719, 4592.586667199968, 4599.05719327537, 4612.400387949612, 4623.9075218495445, 2637.3670319123657, 2747.9450410991667, 2778.2220978126156, 2791.0, 2807.6911539730613, 4833.73414462208, 4867.586255168279, 4873.780679869415, 4900.583450406684, 4922.75386230687, 5138.30632864566, 5324.949894290726, 5340.1309541660885, 5349.518543331041, 5353.7055461949185, 5010.223415370623, 5010.799568017312, 5022.522860328263, 5027.497250274943, 5037.596992240538, 5350.866228344323, 5366.543843773323, 5376.892462150657, 5381.246625472515, 5386.622936394415, 5190.792368305377, 5232.275295122212, 5276.232462125077, 5293.814716484904, 5328.0, 5038.042771873333, 5068.974655126701, 5078.593712503065, 5079.044567841333, 5080.907604864972, 3728.96271037297, 3735.9066023349633, 3745.9250814984093, 3747.9880432282584, 3762.228743107711, 5112.514311140436, 5346.705931173823, 5408.242846001484, 5423.728813559385, 5424.887897980983, 5174.249733788655, 5185.0, 5188.221766734869, 5189.896202076013, 5196.532312091778, 5119.0529751996, 5177.534021938043, 5194.818181363634, 5205.713685747321, 5235.240890070994, 4850.6119510438375, 5085.211792172219, 5095.41402738675, 5118.0, 5124.948750512596, 4939.975300123477, 5090.923636145535, 5101.225093430909, 5194.221091715914, 5210.895782084262, 5076.847694569021, 5081.655184816928, 5086.237064440364, 5094.7962081516325, 5106.719130447861], "value": 3907.239045939428, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.4435840431645, 674.6525539347238, 739.0687733455848, 770.7995921060524, 787.1223585701943, 12823.871761282384, 13891.930540347297, 14077.225752583616, 14324.355404006845, 14572.781408278857, 13614.523491677794, 13650.249236292, 13771.449142034307, 13801.0, 13995.160290382584, 776.068717538954, 794.9085855126648, 794.9841003179932, 795.32794788404, 795.7732046366787, 664.3887623386496, 681.6148875885109, 790.0479921694373, 809.3969992355703, 820.0241712362299, 851.6465666748292, 857.0743596915347, 860.7805009722543, 861.0743450790394, 864.2481041493878, 853.4580541356283, 855.700504823313, 856.5631527920743, 856.5674334461088, 857.691231156783, 621.6270237857294, 623.7598524568074, 623.8908191066545, 625.7246811402969, 627.1658693937053, 13610.59168224955, 13852.0, 13937.512187073506, 14050.718985620333, 14133.293335333296, 13129.803052954214, 13946.790798138036, 13961.650958726012, 14001.29993500321, 14057.971014492754, 10491.842622360671, 10606.098481628993, 10676.092532134779, 10688.09151222147, 10816.621418250323, 3279.6064472263242, 3316.4859446785545, 3344.8327583620967, 3347.866085356583, 3370.9157271068175, 65921.67039164821, 65989.0, 66331.66834165847, 67428.32571674319, 68235.31764682339, 10430.42632655196, 10491.895081049244, 10581.153507719364, 10600.787984240273, 10673.519691613896, 19651.705224421647, 19663.311784087487, 19722.11250493731, 19754.70367944482, 19966.800331996783, 6796.184457864989, 6799.286074962157, 6799.388055075067, 6838.384545390939, 7033.788986330418, 3600.6039335673054, 3667.2298817248675, 3690.6862916652385, 3695.9260814784093, 3699.204670995695, 2963.4369469800668, 3084.6452657944624, 3093.783435159562, 3109.518024706174, 3112.2841746398453, 505.6511007404879, 507.50771751401084, 512.3211744438634, 513.6507175120954, 523.3641126031889, 612.5038718637918, 632.3771085480797, 647.4302613699914, 647.4334956912701, 649.5063751548857, 9094.81810363789, 9552.665656702122, 9586.760330991641, 9647.951760241154, 9921.206303495703, 606.1513880567242, 622.5144387377852, 631.5358211714387, 632.7049123604844, 634.2262439823409, 4461.933071003938, 4601.5168407317415, 4612.907741845144, 4613.769311534477, 4666.556677115668, 65634.0, 65904.34095658982, 66436.66781666157, 68581.3141868585, 68583.31416685869, 49693.503064968885, 56323.71838140783, 57707.0, 58613.4138658608, 58936.15957606307, 54175.999999999214, 54193.1871021935, 54659.453405465436, 55311.723441382535, 55663.0, 8631.136886311318, 8915.508959359136, 8937.910620893708, 8965.641374344954, 9131.634734610541, 35800.82099589486, 35841.64158358383, 36099.27801443904, 36713.0, 36813.44779828358, 41804.790976044926, 45515.089698205185, 45917.0, 46543.301850471595, 47553.286700700206, 10144.239182061227, 10152.746181345525, 10300.793984120426, 10301.072903438726, 10395.32430392022, 11466.82799758021, 11518.0, 11913.761724765283, 11936.224145430519, 12454.0, 11163.832542512031, 11189.216754827085, 11230.943845281048, 11996.160268781101, 12004.09969252327, 10573.788524229627, 10629.840552391566, 10856.674299771019, 10907.672769816918, 11267.943660281646, 10574.788504230026, 10655.89344106549, 11067.114630829676, 11104.111671066457, 11468.94265528667, 9324.813503730024, 9494.715158545254, 9497.952510237405, 9759.756006099904, 10064.0, 8648.221660050625, 9226.538673066454, 9250.911998400987, 9273.30450216223, 9517.476538790155], "value": 6414.493249957635, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1585.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 114.0, 115.0, 116.0, 116.0, 116.0, 116.0, 114.0, 116.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 130.0, 130.0, 177.0, 125.0, 124.0, 125.0, 125.0, 159.0, 131.0], "value": 138.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 167.0, 167.0, 163.0, 167.0, 163.0, 162.0, 163.0, 165.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 106.0, 77.0, 79.0, 78.0, 76.0, 92.0, 76.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 113.0, 86.0, 85.0, 86.0, 111.0, 87.0, 85.0, 107.0], "value": 92.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 122.0, 117.0, 119.0, 118.0, 118.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 149.0, 150.0, 150.0, 152.0, 150.0, 151.0, 150.0, 150.0, 151.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 101.0, 97.0, 95.0, 96.0, 96.0, 103.0], "value": 97.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 66.0, 64.0, 64.0, 65.0, 66.0, 65.0, 66.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 68.0, 68.0, 67.0, 67.0, 68.0, 67.0, 68.0], "value": 67.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 91.0, 98.0, 86.0, 86.0, 85.0, 84.0, 93.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 150.0, 149.0, 133.0, 154.0, 146.0, 133.0, 147.0, 224.0, 148.0], "value": 152.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 182.0, 188.0, 181.0, 180.0, 180.0, 178.0, 185.0, 178.0, 181.0], "value": 181.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 70.0, 74.0, 71.0, 70.0, 87.0, 70.0, 70.0, 69.0], "value": 72.3, "unit": "score"}]}]} 13:16:23 INFO - Return code: 0 13:16:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:16:23 ERROR - # TBPL SUCCESS # 13:16:23 INFO - Running post-action listener: _resource_record_post_action 13:16:23 INFO - [mozharness: 2017-01-09 21:16:23.266364Z] Finished run-tests step (success) 13:16:23 INFO - Running post-run listener: _resource_record_post_run 13:16:23 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 630784; Write bytes: 395829248; Read time: 164; Write time: 292224 13:16:23 INFO - TinderboxPrint: CPU usage
13.5% 13:16:23 INFO - TinderboxPrint: I/O read bytes / time
630,784 / 164 13:16:23 INFO - TinderboxPrint: I/O write bytes / time
395,829,248 / 292,224 13:16:23 INFO - TinderboxPrint: CPU idle
8,290.6 (86.5%) 13:16:23 INFO - TinderboxPrint: CPU user
1,229.6 (12.8%) 13:16:23 INFO - TinderboxPrint: Swap in / out
0 / 0 13:16:23 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 100048896; Read time: 0; Write time: 88860 13:16:23 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 626688; Write bytes: 295780352; Read time: 144; Write time: 203364 13:16:23 INFO - Running post-run listener: _upload_blobber_files 13:16:23 INFO - Blob upload gear active. 13:16:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:16:23 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 13:16:23 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'] 13:16:23 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 13:16:24 INFO - (blobuploader) - INFO - Open directory for files ... 13:16:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:16:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:16:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:16:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:16:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:16:25 INFO - (blobuploader) - INFO - Done attempting. 13:16:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:16:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:16:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:16:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:16:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:16:27 INFO - (blobuploader) - INFO - Done attempting. 13:16:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:16:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:16:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:16:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:16:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:16:32 INFO - (blobuploader) - INFO - Done attempting. 13:16:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:16:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:16:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:16:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:16:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:16:33 INFO - (blobuploader) - INFO - Done attempting. 13:16:33 INFO - (blobuploader) - INFO - Iteration through files over. 13:16:33 INFO - Return code: 0 13:16:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:16:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:16:33 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/318a099c097b66d88700a50fa5bfe2972077761543b4070d635e70d8a7995930fb9d36512d3caba78a35ee6187e968d57a007c454cb50913768d54c3a6dce92f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/880ffff25f57c7f7f0f85390bf0d5684b9bef98a5a7122b5fec30b3c7aa8c05451ba1ff3bf23dea646045dc57456b8d5c470d69c2f12ca6c3121cf24cb7afafa", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eaef618a0a380a494e074d46177a01fb47075077d99950be9be619c10aff4b9228eaecae5b9a527bf2278d58df6664c0f6251643d606779fd970117fbbed2bc1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c5bd202978f50fda8e5ac4d72524d11ddcbdb6a58461667fbec733c4376cd9d14c4acd557288752605fedc57a0659db93a65f46399bc37e1f9694a6acc98a73"} 13:16:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:16:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:16:33 INFO - Contents: 13:16:33 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/318a099c097b66d88700a50fa5bfe2972077761543b4070d635e70d8a7995930fb9d36512d3caba78a35ee6187e968d57a007c454cb50913768d54c3a6dce92f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/880ffff25f57c7f7f0f85390bf0d5684b9bef98a5a7122b5fec30b3c7aa8c05451ba1ff3bf23dea646045dc57456b8d5c470d69c2f12ca6c3121cf24cb7afafa", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eaef618a0a380a494e074d46177a01fb47075077d99950be9be619c10aff4b9228eaecae5b9a527bf2278d58df6664c0f6251643d606779fd970117fbbed2bc1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c5bd202978f50fda8e5ac4d72524d11ddcbdb6a58461667fbec733c4376cd9d14c4acd557288752605fedc57a0659db93a65f46399bc37e1f9694a6acc98a73"} 13:16:33 INFO - Running post-run listener: copy_logs_to_upload_dir 13:16:33 INFO - Copying logs to upload dir... 13:16:33 INFO - mkdir: /builds/slave/test/build/upload/logs 13:16:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.996103 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-01-09 13:16:33.138379) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 13:16:33.141965) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671 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/318a099c097b66d88700a50fa5bfe2972077761543b4070d635e70d8a7995930fb9d36512d3caba78a35ee6187e968d57a007c454cb50913768d54c3a6dce92f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/880ffff25f57c7f7f0f85390bf0d5684b9bef98a5a7122b5fec30b3c7aa8c05451ba1ff3bf23dea646045dc57456b8d5c470d69c2f12ca6c3121cf24cb7afafa", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eaef618a0a380a494e074d46177a01fb47075077d99950be9be619c10aff4b9228eaecae5b9a527bf2278d58df6664c0f6251643d606779fd970117fbbed2bc1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c5bd202978f50fda8e5ac4d72524d11ddcbdb6a58461667fbec733c4376cd9d14c4acd557288752605fedc57a0659db93a65f46399bc37e1f9694a6acc98a73"} build_url:https://queue.taskcluster.net/v1/task/bxe2kBhIQlyjhN5GRPT4vA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011167 build_url: 'https://queue.taskcluster.net/v1/task/bxe2kBhIQlyjhN5GRPT4vA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/318a099c097b66d88700a50fa5bfe2972077761543b4070d635e70d8a7995930fb9d36512d3caba78a35ee6187e968d57a007c454cb50913768d54c3a6dce92f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/880ffff25f57c7f7f0f85390bf0d5684b9bef98a5a7122b5fec30b3c7aa8c05451ba1ff3bf23dea646045dc57456b8d5c470d69c2f12ca6c3121cf24cb7afafa", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eaef618a0a380a494e074d46177a01fb47075077d99950be9be619c10aff4b9228eaecae5b9a527bf2278d58df6664c0f6251643d606779fd970117fbbed2bc1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c5bd202978f50fda8e5ac4d72524d11ddcbdb6a58461667fbec733c4376cd9d14c4acd557288752605fedc57a0659db93a65f46399bc37e1f9694a6acc98a73"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 13:16:33.168055) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 13:16:33.168409) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1483995341.874419-1711007671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004435 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 13:16:33.255370) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 13:16:33.255942) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 13:16:33.256525) ========= ========= Total master_lag: 0.16 =========