builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1494351232.16 results: success (0) revision: b9bd73036a925e44f44ee87e779fbbdb2dbe618c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-09 10:33:52.164014) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-09 10:33:52.164702) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-09 10:33:52.165185) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-09 10:33:52.188014) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 10:33:52.188352) ========= 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=62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-09 10:33:52-- 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% 42.6M=0s 2017-05-09 10:33:52 (42.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081890 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 10:33:52.287155) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 10:33:52.287750) ========= 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=62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019354 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 10:33:52.338365) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 10:33:52.338706) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b9bd73036a925e44f44ee87e779fbbdb2dbe618c --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 b9bd73036a925e44f44ee87e779fbbdb2dbe618c --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=62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-09 10:33:52,384 truncating revision to first 12 chars 2017-05-09 10:33:52,384 Setting DEBUG logging. 2017-05-09 10:33:52,384 attempt 1/10 2017-05-09 10:33:52,384 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b9bd73036a92?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-09 10:33:52,681 unpacking tar archive at: mozilla-central-b9bd73036a92/testing/mozharness/ program finished with exit code 0 elapsedTime=0.585121 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 10:33:52.938992) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-09 10:33:52.939253) ========= script_repo_revision: b9bd73036a925e44f44ee87e779fbbdb2dbe618c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-09 10:33:52.939619) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-09 10:33:52.939879) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-09 10:33:52.950242) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-05-09 10:33:52.950609) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:33:53 INFO - MultiFileLogger online at 20170509 10:33:53 in /builds/slave/test 10:33:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 10:33:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:33:53 INFO - {'append_to_log': False, 10:33:53 INFO - 'base_work_dir': '/builds/slave/test', 10:33:53 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 10:33:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:33:53 INFO - 'branch': 'Firefox-Non-PGO', 10:33:53 INFO - 'buildbot_json_path': 'buildprops.json', 10:33:53 INFO - 'config_files': ('talos/linux_config.py',), 10:33:53 INFO - 'default_actions': ('clobber', 10:33:53 INFO - 'read-buildbot-config', 10:33:53 INFO - 'download-and-extract', 10:33:53 INFO - 'populate-webroot', 10:33:53 INFO - 'create-virtualenv', 10:33:53 INFO - 'install', 10:33:53 INFO - 'run-tests'), 10:33:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:33:53 INFO - 'download_minidump_stackwalk': True, 10:33:53 INFO - 'download_symbols': 'ondemand', 10:33:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:33:53 INFO - 'tooltool.py': '/tools/tooltool.py', 10:33:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:33:53 INFO - '/tools/misc-python/virtualenv.py')}, 10:33:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:33:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:33:53 INFO - 'gecko_profile': False, 10:33:53 INFO - 'gecko_profile_interval': 0, 10:33:53 INFO - 'installer_path': 'installer.exe', 10:33:53 INFO - 'log_level': 'info', 10:33:53 INFO - 'log_name': 'talos', 10:33:53 INFO - 'log_to_console': True, 10:33:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:33:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:33:53 INFO - 'opt_config_files': (), 10:33:53 INFO - 'pip_index': False, 10:33:53 INFO - 'suite': 'dromaeojs', 10:33:53 INFO - 'system_bits': '32', 10:33:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:33:53 INFO - 'title': 'talos-linux64-ix-018', 10:33:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:33:53 INFO - 'use_talos_json': True, 10:33:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:33:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:33:53 INFO - 'work_dir': 'build'} 10:33:53 INFO - [mozharness: 2017-05-09 17:33:53.096848Z] Running clobber step. 10:33:53 INFO - Running pre-action listener: _resource_record_pre_action 10:33:53 INFO - Running main action method: clobber 10:33:53 INFO - rmtree: /builds/slave/test/build 10:33:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:33:54 INFO - Running post-action listener: _resource_record_post_action 10:33:54 INFO - [mozharness: 2017-05-09 17:33:54.547450Z] Finished clobber step (success) 10:33:54 INFO - [mozharness: 2017-05-09 17:33:54.547549Z] Running read-buildbot-config step. 10:33:54 INFO - Running pre-action listener: _resource_record_pre_action 10:33:54 INFO - Running main action method: read_buildbot_config 10:33:54 INFO - Using buildbot properties: 10:33:54 INFO - { 10:33:54 INFO - "project": "", 10:33:54 INFO - "product": "firefox", 10:33:54 INFO - "who": "archaeopteryx@coole-files.de", 10:33:54 INFO - "installer_path": "public/build/target.tar.bz2", 10:33:54 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:33:54 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 10:33:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 10:33:54 INFO - "stage_platform": "linux64", 10:33:54 INFO - "basedir": "/builds/slave/test", 10:33:54 INFO - "buildnumber": 1138, 10:33:54 INFO - "platform": "ubuntu64_hw", 10:33:54 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:33:54 INFO - "slavebuilddir": "test", 10:33:54 INFO - "taskId": "eC4JREyNSL-EOvvGXw8bsQ", 10:33:54 INFO - "branch": "mozilla-central", 10:33:54 INFO - "script_repo_revision": "production", 10:33:54 INFO - "revision": "b9bd73036a925e44f44ee87e779fbbdb2dbe618c", 10:33:54 INFO - "slavename": "talos-linux64-ix-018", 10:33:54 INFO - "repo_path": "mozilla-central" 10:33:54 INFO - } 10:33:54 INFO - Finding installer, test and symbols from parent task. 10:33:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eC4JREyNSL-EOvvGXw8bsQ'}, attempt #1 10:33:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eC4JREyNSL-EOvvGXw8bsQ'}, attempt #1 10:33:55 INFO - Task dependencies: FRvYA01qRpywlEklhoWTpA 10:33:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FRvYA01qRpywlEklhoWTpA'}, attempt #1 10:33:55 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FRvYA01qRpywlEklhoWTpA/artifacts/public/build/target.tar.bz2 10:33:55 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FRvYA01qRpywlEklhoWTpA/artifacts/public/build/test_packages.json 10:33:55 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FRvYA01qRpywlEklhoWTpA/artifacts/public/build/target.crashreporter-symbols.zip 10:33:55 INFO - Running post-action listener: _resource_record_post_action 10:33:55 INFO - [mozharness: 2017-05-09 17:33:55.927776Z] Finished read-buildbot-config step (success) 10:33:55 INFO - [mozharness: 2017-05-09 17:33:55.927994Z] Running download-and-extract step. 10:33:55 INFO - Running pre-action listener: _resource_record_pre_action 10:33:55 INFO - Running main action method: download_and_extract 10:33:55 INFO - mkdir: /builds/slave/test/build/tests 10:33:55 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')]} 10:33:55 INFO - trying https://queue.taskcluster.net/v1/task/FRvYA01qRpywlEklhoWTpA/artifacts/public/build/target.test_packages.json 10:33:55 INFO - Downloading https://queue.taskcluster.net/v1/task/FRvYA01qRpywlEklhoWTpA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:33:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FRvYA01qRpywlEklhoWTpA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:33:56 INFO - Downloaded 986 bytes. 10:33:56 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:33:56 INFO - Using the following test package requirements: 10:33:56 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:33:56 INFO - u'common': [u'target.common.tests.zip'], 10:33:56 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:33:56 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:33:56 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:33:56 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:33:56 INFO - u'mozbase': [u'target.common.tests.zip'], 10:33:56 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:33:56 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:33:56 INFO - u'web-platform': [u'target.common.tests.zip', 10:33:56 INFO - u'target.web-platform.tests.zip'], 10:33:56 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:33:56 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:33:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FRvYA01qRpywlEklhoWTpA/artifacts/public/build/target.common.tests.zip 10:33:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FRvYA01qRpywlEklhoWTpA/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:33:56 INFO - Fetch https://queue.taskcluster.net/v1/task/FRvYA01qRpywlEklhoWTpA/artifacts/public/build/target.common.tests.zip into memory 10:33:58 INFO - Content-Length response header: 58448971 10:33:58 INFO - Bytes received: 58448971 10:34:08 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:34:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FRvYA01qRpywlEklhoWTpA/artifacts/public/build/target.common.tests.zip 10:34:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FRvYA01qRpywlEklhoWTpA/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:34:08 INFO - Fetch https://queue.taskcluster.net/v1/task/FRvYA01qRpywlEklhoWTpA/artifacts/public/build/target.common.tests.zip into memory 10:34:10 INFO - Content-Length response header: 58448971 10:34:10 INFO - Bytes received: 58448971 10:34:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FRvYA01qRpywlEklhoWTpA/artifacts/public/build/target.talos.tests.zip 10:34:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FRvYA01qRpywlEklhoWTpA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:34:20 INFO - Fetch https://queue.taskcluster.net/v1/task/FRvYA01qRpywlEklhoWTpA/artifacts/public/build/target.talos.tests.zip into memory 10:34:21 INFO - Content-Length response header: 14409362 10:34:21 INFO - Bytes received: 14409362 10:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:22 INFO - trying https://queue.taskcluster.net/v1/task/FRvYA01qRpywlEklhoWTpA/artifacts/public/build/target.tar.bz2 10:34:22 INFO - Downloading https://queue.taskcluster.net/v1/task/FRvYA01qRpywlEklhoWTpA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:34:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FRvYA01qRpywlEklhoWTpA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:34:24 INFO - Downloaded 63016965 bytes. 10:34:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FRvYA01qRpywlEklhoWTpA/artifacts/public/build/target.tar.bz2 10:34:24 INFO - mkdir: /builds/slave/test/properties 10:34:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:34:24 INFO - Writing to file /builds/slave/test/properties/build_url 10:34:24 INFO - Contents: 10:34:24 INFO - build_url:https://queue.taskcluster.net/v1/task/FRvYA01qRpywlEklhoWTpA/artifacts/public/build/target.tar.bz2 10:34:24 INFO - Running post-action listener: _resource_record_post_action 10:34:24 INFO - Running post-action listener: set_extra_try_arguments 10:34:24 INFO - [mozharness: 2017-05-09 17:34:24.541123Z] Finished download-and-extract step (success) 10:34:24 INFO - [mozharness: 2017-05-09 17:34:24.541352Z] Running populate-webroot step. 10:34:24 INFO - Running pre-action listener: _resource_record_pre_action 10:34:24 INFO - Running main action method: populate_webroot 10:34:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:34:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:34:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:34:24 INFO - '--tppagecycles', 10:34:24 INFO - '7'], 10:34:24 INFO - 'tests': ['tsvgm']}}, 10:34:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:34:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:34:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:34:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:34:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:34:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:34:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:34:24 INFO - 'talos_options': ['--disable-e10s'], 10:34:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:34:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:34:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:34:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:34:24 INFO - 'talos_options': ['--disable-e10s'], 10:34:24 INFO - 'tests': ['damp', 'tps']}, 10:34:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:34:24 INFO - 'tests': ['damp', 'tps']}, 10:34:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:34:24 INFO - 'tests': ['dromaeo_dom']}, 10:34:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:34:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:34:24 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:34:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:34:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:34:24 INFO - 'tests': ['a11yr', 10:34:24 INFO - 'ts_paint', 10:34:24 INFO - 'tpaint', 10:34:24 INFO - 'sessionrestore', 10:34:24 INFO - 'sessionrestore_no_auto_restore', 10:34:24 INFO - 'tabpaint']}, 10:34:24 INFO - 'other-e10s': {'tests': ['a11yr', 10:34:24 INFO - 'ts_paint', 10:34:24 INFO - 'tpaint', 10:34:24 INFO - 'sessionrestore', 10:34:24 INFO - 'sessionrestore_no_auto_restore', 10:34:24 INFO - 'tabpaint']}, 10:34:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:34:24 INFO - 'ts_paint', 10:34:24 INFO - 'tpaint', 10:34:24 INFO - 'sessionrestore', 10:34:24 INFO - 'sessionrestore_no_auto_restore', 10:34:24 INFO - 'tabpaint']}, 10:34:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:34:24 INFO - 'ts_paint', 10:34:24 INFO - 'tpaint', 10:34:24 INFO - 'sessionrestore', 10:34:24 INFO - 'sessionrestore_no_auto_restore', 10:34:24 INFO - 'tabpaint']}, 10:34:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:34:24 INFO - 'tests': ['a11yr', 10:34:24 INFO - 'ts_paint', 10:34:24 INFO - 'tpaint', 10:34:24 INFO - 'sessionrestore', 10:34:24 INFO - 'sessionrestore_no_auto_restore', 10:34:24 INFO - 'tabpaint']}, 10:34:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:34:24 INFO - 'tests': ['a11yr', 10:34:24 INFO - 'ts_paint', 10:34:24 INFO - 'tpaint', 10:34:24 INFO - 'sessionrestore', 10:34:24 INFO - 'sessionrestore_no_auto_restore', 10:34:24 INFO - 'tabpaint']}, 10:34:24 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 10:34:24 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 10:34:24 INFO - 'bloom_basic_ref']}, 10:34:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:34:24 INFO - 'tests': ['tsvgx', 10:34:24 INFO - 'tsvgr_opacity', 10:34:24 INFO - 'tart', 10:34:24 INFO - 'tscrollx', 10:34:24 INFO - 'cart', 10:34:24 INFO - 'tsvg_static']}, 10:34:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:34:24 INFO - 'tsvgr_opacity', 10:34:24 INFO - 'tart', 10:34:24 INFO - 'tscrollx', 10:34:24 INFO - 'cart', 10:34:24 INFO - 'tsvg_static']}, 10:34:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:34:24 INFO - 'talos_options': ['--disable-e10s'], 10:34:24 INFO - 'tests': ['tp5o']}, 10:34:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:34:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:34:24 INFO - 'talos_options': ['--disable-e10s', 10:34:24 INFO - '--xperf_path', 10:34:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:34:24 INFO - 'tests': ['tp5n']}, 10:34:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:34:24 INFO - 'talos_options': ['--xperf_path', 10:34:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:34:24 INFO - 'tests': ['tp5n']}}, 10:34:24 INFO - 'talos.zip': {'path': '', 10:34:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:34:24 INFO - Running post-action listener: _resource_record_post_action 10:34:24 INFO - [mozharness: 2017-05-09 17:34:24.557428Z] Finished populate-webroot step (success) 10:34:24 INFO - [mozharness: 2017-05-09 17:34:24.557518Z] Running create-virtualenv step. 10:34:24 INFO - Running pre-action listener: _resource_record_pre_action 10:34:24 INFO - Running main action method: create_virtualenv 10:34:24 INFO - Creating virtualenv /builds/slave/test/build/venv 10:34:24 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 10:34:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:34:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:34:24 INFO - Using real prefix '/usr' 10:34:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:34:25 INFO - Installing distribute.............................................................................................................................................................................................done. 10:34:27 INFO - Installing pip.................done. 10:34:27 INFO - Return code: 0 10:34:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:34:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:34:27 INFO - Reading from file tmpfile_stdout 10:34:27 INFO - Output received: 10:34:27 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) 10:34:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:34:27 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')]} 10:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:27 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')]} 10:34:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:27 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 0x1eb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2224770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2221a30>, '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 0x22227f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2222ca0>, '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': '62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279', '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 10:34:27 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 10:34:27 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 10:34:27 INFO - Using env: {'DISPLAY': ':0', 10:34:27 INFO - 'HOME': '/home/cltbld', 10:34:27 INFO - 'LANG': 'en_US.UTF-8', 10:34:27 INFO - 'LANGUAGE': 'en_US:en', 10:34:27 INFO - 'LOGNAME': 'cltbld', 10:34:27 INFO - 'MAIL': '/var/mail/cltbld', 10:34:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:27 INFO - 'MOZ_NO_REMOTE': '1', 10:34:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:27 INFO - 'NO_EM_RESTART': '1', 10:34:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:27 INFO - 'PWD': '/builds/slave/test', 10:34:27 INFO - 'SHELL': '/bin/bash', 10:34:27 INFO - 'SHLVL': '1', 10:34:27 INFO - 'TERM': 'linux', 10:34:27 INFO - 'TMOUT': '86400', 10:34:27 INFO - 'USER': 'cltbld', 10:34:27 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279', 10:34:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:27 INFO - '_': '/tools/buildbot/bin/python'} 10:34:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:27 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 10:34:27 INFO - Cleaning up... 10:34:27 INFO - Return code: 0 10:34:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:34:27 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')]} 10:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:27 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')]} 10:34:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:27 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 0x1eb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2224770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2221a30>, '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 0x22227f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2222ca0>, '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': '62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279', '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 10:34:27 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 10:34:27 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 10:34:27 INFO - Using env: {'DISPLAY': ':0', 10:34:27 INFO - 'HOME': '/home/cltbld', 10:34:27 INFO - 'LANG': 'en_US.UTF-8', 10:34:27 INFO - 'LANGUAGE': 'en_US:en', 10:34:27 INFO - 'LOGNAME': 'cltbld', 10:34:27 INFO - 'MAIL': '/var/mail/cltbld', 10:34:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:27 INFO - 'MOZ_NO_REMOTE': '1', 10:34:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:27 INFO - 'NO_EM_RESTART': '1', 10:34:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:27 INFO - 'PWD': '/builds/slave/test', 10:34:27 INFO - 'SHELL': '/bin/bash', 10:34:27 INFO - 'SHLVL': '1', 10:34:27 INFO - 'TERM': 'linux', 10:34:27 INFO - 'TMOUT': '86400', 10:34:27 INFO - 'USER': 'cltbld', 10:34:27 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279', 10:34:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:27 INFO - '_': '/tools/buildbot/bin/python'} 10:34:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:27 INFO - Downloading/unpacking psutil>=3.1.1 10:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:34:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:34:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:34:28 INFO - Installing collected packages: psutil 10:34:28 INFO - Running setup.py install for psutil 10:34:29 INFO - building 'psutil._psutil_linux' extension 10:34:29 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 10:34:29 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 10:34:29 INFO - building 'psutil._psutil_posix' extension 10:34:29 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 10:34:29 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 10:34:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:34:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:34:29 INFO - Successfully installed psutil 10:34:29 INFO - Cleaning up... 10:34:29 INFO - Return code: 0 10:34:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2224770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2221a30>, '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 0x22227f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2222ca0>, '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': '62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279', '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 10:34:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:34:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:34:29 INFO - Using env: {'DISPLAY': ':0', 10:34:29 INFO - 'HOME': '/home/cltbld', 10:34:29 INFO - 'LANG': 'en_US.UTF-8', 10:34:29 INFO - 'LANGUAGE': 'en_US:en', 10:34:29 INFO - 'LOGNAME': 'cltbld', 10:34:29 INFO - 'MAIL': '/var/mail/cltbld', 10:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:29 INFO - 'MOZ_NO_REMOTE': '1', 10:34:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:29 INFO - 'NO_EM_RESTART': '1', 10:34:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:29 INFO - 'PWD': '/builds/slave/test', 10:34:29 INFO - 'SHELL': '/bin/bash', 10:34:29 INFO - 'SHLVL': '1', 10:34:29 INFO - 'TERM': 'linux', 10:34:29 INFO - 'TMOUT': '86400', 10:34:29 INFO - 'USER': 'cltbld', 10:34:29 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279', 10:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:29 INFO - '_': '/tools/buildbot/bin/python'} 10:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:34:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:34:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:34:30 INFO - Installing collected packages: mozsystemmonitor 10:34:30 INFO - Running setup.py install for mozsystemmonitor 10:34:31 INFO - Successfully installed mozsystemmonitor 10:34:31 INFO - Cleaning up... 10:34:31 INFO - Return code: 0 10:34:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:34:31 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')]} 10:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:31 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')]} 10:34:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1eb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2224770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2221a30>, '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 0x22227f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2222ca0>, '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': '62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279', '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 10:34:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:34:31 INFO - Using env: {'DISPLAY': ':0', 10:34:31 INFO - 'HOME': '/home/cltbld', 10:34:31 INFO - 'LANG': 'en_US.UTF-8', 10:34:31 INFO - 'LANGUAGE': 'en_US:en', 10:34:31 INFO - 'LOGNAME': 'cltbld', 10:34:31 INFO - 'MAIL': '/var/mail/cltbld', 10:34:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:31 INFO - 'MOZ_NO_REMOTE': '1', 10:34:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:31 INFO - 'NO_EM_RESTART': '1', 10:34:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:31 INFO - 'PWD': '/builds/slave/test', 10:34:31 INFO - 'SHELL': '/bin/bash', 10:34:31 INFO - 'SHLVL': '1', 10:34:31 INFO - 'TERM': 'linux', 10:34:31 INFO - 'TMOUT': '86400', 10:34:31 INFO - 'USER': 'cltbld', 10:34:31 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279', 10:34:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:31 INFO - '_': '/tools/buildbot/bin/python'} 10:34:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:31 INFO - Downloading/unpacking jsonschema==2.5.1 10:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:34:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:34:32 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 10:34:32 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 10:34:32 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 10:34:32 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 10:34:32 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 10:34:32 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 10:34:32 INFO - Downloading functools32-3.2.3-2.tar.gz 10:34:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:34:32 INFO - warning: no files found matching '*.txt' 10:34:32 INFO - no previously-included directories found matching 'build' 10:34:32 INFO - no previously-included directories found matching 'dist' 10:34:32 INFO - no previously-included directories found matching '.git*' 10:34:32 INFO - Installing collected packages: jsonschema, functools32 10:34:32 INFO - Running setup.py install for functools32 10:34:32 INFO - warning: no files found matching '*.txt' 10:34:32 INFO - no previously-included directories found matching 'build' 10:34:32 INFO - no previously-included directories found matching 'dist' 10:34:32 INFO - no previously-included directories found matching '.git*' 10:34:32 INFO - Successfully installed jsonschema functools32 10:34:32 INFO - Cleaning up... 10:34:32 INFO - Return code: 0 10:34:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:32 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 0x1eb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2224770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2221a30>, '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 0x22227f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2222ca0>, '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': '62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279', '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 10:34:32 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 10:34:32 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 10:34:32 INFO - Using env: {'DISPLAY': ':0', 10:34:32 INFO - 'HOME': '/home/cltbld', 10:34:32 INFO - 'LANG': 'en_US.UTF-8', 10:34:32 INFO - 'LANGUAGE': 'en_US:en', 10:34:32 INFO - 'LOGNAME': 'cltbld', 10:34:32 INFO - 'MAIL': '/var/mail/cltbld', 10:34:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:32 INFO - 'MOZ_NO_REMOTE': '1', 10:34:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:32 INFO - 'NO_EM_RESTART': '1', 10:34:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:32 INFO - 'PWD': '/builds/slave/test', 10:34:32 INFO - 'SHELL': '/bin/bash', 10:34:32 INFO - 'SHLVL': '1', 10:34:32 INFO - 'TERM': 'linux', 10:34:32 INFO - 'TMOUT': '86400', 10:34:32 INFO - 'USER': 'cltbld', 10:34:32 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279', 10:34:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:32 INFO - '_': '/tools/buildbot/bin/python'} 10:34:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:34:32 INFO - Cleaning up... 10:34:33 INFO - Return code: 0 10:34:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1eb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2224770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2221a30>, '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 0x22227f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2222ca0>, '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': '62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279', '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 10:34:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:34:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:34:33 INFO - Using env: {'DISPLAY': ':0', 10:34:33 INFO - 'HOME': '/home/cltbld', 10:34:33 INFO - 'LANG': 'en_US.UTF-8', 10:34:33 INFO - 'LANGUAGE': 'en_US:en', 10:34:33 INFO - 'LOGNAME': 'cltbld', 10:34:33 INFO - 'MAIL': '/var/mail/cltbld', 10:34:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:33 INFO - 'MOZ_NO_REMOTE': '1', 10:34:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:33 INFO - 'NO_EM_RESTART': '1', 10:34:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:33 INFO - 'PWD': '/builds/slave/test', 10:34:33 INFO - 'SHELL': '/bin/bash', 10:34:33 INFO - 'SHLVL': '1', 10:34:33 INFO - 'TERM': 'linux', 10:34:33 INFO - 'TMOUT': '86400', 10:34:33 INFO - 'USER': 'cltbld', 10:34:33 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279', 10:34:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:33 INFO - '_': '/tools/buildbot/bin/python'} 10:34:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:33 INFO - Downloading/unpacking blobuploader==1.2.4 10:34:33 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 10:34:33 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 10:34:33 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 10:34:33 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 10:34:33 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 10:34:33 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 10:34:34 INFO - Downloading blobuploader-1.2.4.tar.gz 10:34:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:34:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:34:34 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 10:34:34 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 10:34:34 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 10:34:34 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 10:34:34 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 10:34:34 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 10:34:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:34:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:34:34 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 10:34:34 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 10:34:34 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 10:34:34 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 10:34:34 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 10:34:34 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 10:34:34 INFO - Downloading docopt-0.6.1.tar.gz 10:34:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:34:34 INFO - Installing collected packages: blobuploader, requests, docopt 10:34:34 INFO - Running setup.py install for blobuploader 10:34:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:34:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:34:35 INFO - Running setup.py install for requests 10:34:35 INFO - Running setup.py install for docopt 10:34:35 INFO - Successfully installed blobuploader requests docopt 10:34:35 INFO - Cleaning up... 10:34:35 INFO - Return code: 0 10:34:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:35 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 0x1eb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2224770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2221a30>, '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 0x22227f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2222ca0>, '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': '62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279', '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 10:34:35 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 10:34:35 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 10:34:35 INFO - Using env: {'DISPLAY': ':0', 10:34:35 INFO - 'HOME': '/home/cltbld', 10:34:35 INFO - 'LANG': 'en_US.UTF-8', 10:34:35 INFO - 'LANGUAGE': 'en_US:en', 10:34:35 INFO - 'LOGNAME': 'cltbld', 10:34:35 INFO - 'MAIL': '/var/mail/cltbld', 10:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:35 INFO - 'MOZ_NO_REMOTE': '1', 10:34:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:35 INFO - 'NO_EM_RESTART': '1', 10:34:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:35 INFO - 'PWD': '/builds/slave/test', 10:34:35 INFO - 'SHELL': '/bin/bash', 10:34:35 INFO - 'SHLVL': '1', 10:34:35 INFO - 'TERM': 'linux', 10:34:35 INFO - 'TMOUT': '86400', 10:34:35 INFO - 'USER': 'cltbld', 10:34:35 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279', 10:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:35 INFO - '_': '/tools/buildbot/bin/python'} 10:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:34:35 INFO - Running setup.py (path:/tmp/pip-2BxutZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:34:35 INFO - Running setup.py (path:/tmp/pip-QhUo7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:34:35 INFO - Running setup.py (path:/tmp/pip-Tf0CJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:34:35 INFO - Running setup.py (path:/tmp/pip-lE9UE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:34:36 INFO - Running setup.py (path:/tmp/pip-Y7NOEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:34:36 INFO - Running setup.py (path:/tmp/pip-PkuFuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:34:36 INFO - Running setup.py (path:/tmp/pip-SsBcCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:34:36 INFO - Running setup.py (path:/tmp/pip-Q0KzWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:34:36 INFO - Running setup.py (path:/tmp/pip-my8ZWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:34:36 INFO - Running setup.py (path:/tmp/pip-_cvKCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:34:36 INFO - Running setup.py (path:/tmp/pip-0LafHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:34:36 INFO - Running setup.py (path:/tmp/pip-j1DMZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:34:36 INFO - Running setup.py (path:/tmp/pip-AOcs_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:34:36 INFO - Running setup.py (path:/tmp/pip-BEgEj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:34:36 INFO - Running setup.py (path:/tmp/pip-H3_cBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:34:36 INFO - Running setup.py (path:/tmp/pip-DWgLKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:34:36 INFO - Running setup.py (path:/tmp/pip-SPWBrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:34:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:34:36 INFO - Running setup.py install for manifestparser 10:34:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:34:37 INFO - Running setup.py install for mozcrash 10:34:37 INFO - Running setup.py install for mozdebug 10:34:37 INFO - Running setup.py install for mozdevice 10:34:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:34:37 INFO - Running setup.py install for mozfile 10:34:37 INFO - Running setup.py install for mozhttpd 10:34:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:34:37 INFO - Running setup.py install for mozinfo 10:34:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:34:37 INFO - Running setup.py install for mozInstall 10:34:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:34:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:34:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:34:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:34:37 INFO - Running setup.py install for mozleak 10:34:37 INFO - Running setup.py install for mozlog 10:34:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:34:38 INFO - Running setup.py install for moznetwork 10:34:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:34:38 INFO - Running setup.py install for mozprocess 10:34:38 INFO - Running setup.py install for mozprofile 10:34:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:34:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:34:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:34:38 INFO - Running setup.py install for mozrunner 10:34:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:34:38 INFO - Running setup.py install for mozscreenshot 10:34:38 INFO - Running setup.py install for moztest 10:34:38 INFO - Running setup.py install for mozversion 10:34:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:34:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:34:38 INFO - Cleaning up... 10:34:38 INFO - Return code: 0 10:34:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:34: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')]} 10:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34: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')]} 10:34:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:38 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 0x1eb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2224770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2221a30>, '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 0x22227f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2222ca0>, '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': '62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279', '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 10:34:38 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 10:34:38 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 10:34:38 INFO - Using env: {'DISPLAY': ':0', 10:34:38 INFO - 'HOME': '/home/cltbld', 10:34:38 INFO - 'LANG': 'en_US.UTF-8', 10:34:38 INFO - 'LANGUAGE': 'en_US:en', 10:34:38 INFO - 'LOGNAME': 'cltbld', 10:34:38 INFO - 'MAIL': '/var/mail/cltbld', 10:34:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:38 INFO - 'MOZ_NO_REMOTE': '1', 10:34:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:38 INFO - 'NO_EM_RESTART': '1', 10:34:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:38 INFO - 'PWD': '/builds/slave/test', 10:34:38 INFO - 'SHELL': '/bin/bash', 10:34:38 INFO - 'SHLVL': '1', 10:34:38 INFO - 'TERM': 'linux', 10:34:38 INFO - 'TMOUT': '86400', 10:34:38 INFO - 'USER': 'cltbld', 10:34:38 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279', 10:34:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:38 INFO - '_': '/tools/buildbot/bin/python'} 10:34:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:34:39 INFO - Running setup.py (path:/tmp/pip-QKzkuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:34:39 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)) 10:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:34:39 INFO - Running setup.py (path:/tmp/pip-OPldS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:34:39 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)) 10:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:34:39 INFO - Running setup.py (path:/tmp/pip-GtrYZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:34:39 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)) 10:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:34:39 INFO - Running setup.py (path:/tmp/pip-X3d0Es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:34:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 10:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:34:39 INFO - Running setup.py (path:/tmp/pip-GHT5xD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:34:39 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)) 10:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:34:39 INFO - Running setup.py (path:/tmp/pip-1EM5pT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:34:39 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)) 10:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:34:39 INFO - Running setup.py (path:/tmp/pip-bnFdUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:34:39 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)) 10:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:34:39 INFO - Running setup.py (path:/tmp/pip-s4P1yH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:34:39 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)) 10:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:34:39 INFO - Running setup.py (path:/tmp/pip-Dho9qz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:34:39 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)) 10:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:34:39 INFO - Running setup.py (path:/tmp/pip-t6FzOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:34:39 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)) 10:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:34:39 INFO - Running setup.py (path:/tmp/pip-XgeJ94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:34:39 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)) 10:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:34:39 INFO - Running setup.py (path:/tmp/pip-bN5dhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:34:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:34:39 INFO - Running setup.py (path:/tmp/pip-htrArr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:34:39 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)) 10:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:34:39 INFO - Running setup.py (path:/tmp/pip-AoFxU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:34:40 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)) 10:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:34:40 INFO - Running setup.py (path:/tmp/pip-FjQoW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:34:40 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)) 10:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:34:40 INFO - Running setup.py (path:/tmp/pip-9yLxF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:34:40 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)) 10:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:34:40 INFO - Running setup.py (path:/tmp/pip-pbId08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:34:40 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)) 10:34:40 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)) 10:34:40 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)) 10:34:40 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)) 10:34:40 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:34:40 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:34:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:41 INFO - Downloading blessings-1.6.tar.gz 10:34:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:34:41 INFO - Installing collected packages: blessings 10:34:41 INFO - Running setup.py install for blessings 10:34:41 INFO - Successfully installed blessings 10:34:41 INFO - Cleaning up... 10:34:41 INFO - Return code: 0 10:34:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:34:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:34:41 INFO - Reading from file tmpfile_stdout 10:34:41 INFO - Current package versions: 10:34:41 INFO - argparse == 1.2.1 10:34:41 INFO - blessings == 1.6 10:34:41 INFO - blobuploader == 1.2.4 10:34:41 INFO - docopt == 0.6.1 10:34:41 INFO - functools32 == 3.2.3-2 10:34:41 INFO - jsonschema == 2.5.1 10:34:41 INFO - manifestparser == 1.1 10:34:41 INFO - mozInstall == 1.12 10:34:41 INFO - mozcrash == 1.0 10:34:41 INFO - mozdebug == 0.1 10:34:41 INFO - mozdevice == 0.50 10:34:41 INFO - mozfile == 1.2 10:34:41 INFO - mozhttpd == 0.7 10:34:41 INFO - mozinfo == 0.9 10:34:41 INFO - mozleak == 0.1 10:34:41 INFO - mozlog == 3.4 10:34:41 INFO - moznetwork == 0.27 10:34:41 INFO - mozprocess == 0.25 10:34:41 INFO - mozprofile == 0.28 10:34:41 INFO - mozrunner == 6.13 10:34:41 INFO - mozscreenshot == 0.1 10:34:41 INFO - mozsystemmonitor == 0.3 10:34:41 INFO - moztest == 0.8 10:34:41 INFO - mozversion == 1.4 10:34:41 INFO - psutil == 3.1.1 10:34:41 INFO - requests == 1.2.3 10:34:41 INFO - wsgiref == 0.1.2 10:34:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:41 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 0x1eb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2224770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2221a30>, '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 0x22227f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2222ca0>, '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': '62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279', '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 10:34:41 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 10:34:41 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 10:34:41 INFO - Using env: {'DISPLAY': ':0', 10:34:41 INFO - 'HOME': '/home/cltbld', 10:34:41 INFO - 'LANG': 'en_US.UTF-8', 10:34:41 INFO - 'LANGUAGE': 'en_US:en', 10:34:41 INFO - 'LOGNAME': 'cltbld', 10:34:41 INFO - 'MAIL': '/var/mail/cltbld', 10:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:41 INFO - 'MOZ_NO_REMOTE': '1', 10:34:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:41 INFO - 'NO_EM_RESTART': '1', 10:34:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:41 INFO - 'PWD': '/builds/slave/test', 10:34:41 INFO - 'SHELL': '/bin/bash', 10:34:41 INFO - 'SHLVL': '1', 10:34:41 INFO - 'TERM': 'linux', 10:34:41 INFO - 'TMOUT': '86400', 10:34:41 INFO - 'USER': 'cltbld', 10:34:41 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279', 10:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:41 INFO - '_': '/tools/buildbot/bin/python'} 10:34:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:42 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)) 10:34:42 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)) 10:34:42 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)) 10:34:42 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)) 10:34:42 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)) 10:34:42 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)) 10:34:42 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)) 10:34:42 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)) 10:34:42 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)) 10:34:42 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)) 10:34:42 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)) 10:34:42 INFO - Cleaning up... 10:34:42 INFO - Return code: 0 10:34:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:34:42 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')]} 10:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:42 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')]} 10:34:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:42 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 0x1eb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2224770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2221a30>, '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 0x22227f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2222ca0>, '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': '62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279', '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 10:34:42 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 10:34:42 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 10:34:42 INFO - Using env: {'DISPLAY': ':0', 10:34:42 INFO - 'HOME': '/home/cltbld', 10:34:42 INFO - 'LANG': 'en_US.UTF-8', 10:34:42 INFO - 'LANGUAGE': 'en_US:en', 10:34:42 INFO - 'LOGNAME': 'cltbld', 10:34:42 INFO - 'MAIL': '/var/mail/cltbld', 10:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:42 INFO - 'MOZ_NO_REMOTE': '1', 10:34:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:42 INFO - 'NO_EM_RESTART': '1', 10:34:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:42 INFO - 'PWD': '/builds/slave/test', 10:34:42 INFO - 'SHELL': '/bin/bash', 10:34:42 INFO - 'SHLVL': '1', 10:34:42 INFO - 'TERM': 'linux', 10:34:42 INFO - 'TMOUT': '86400', 10:34:42 INFO - 'USER': 'cltbld', 10:34:42 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279', 10:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:42 INFO - '_': '/tools/buildbot/bin/python'} 10:34:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:34:42 INFO - Cleaning up... 10:34:42 INFO - Return code: 0 10:34:42 INFO - Running post-action listener: _resource_record_post_action 10:34:42 INFO - Running post-action listener: _start_resource_monitoring 10:34:42 INFO - Starting resource monitoring. 10:34:42 INFO - [mozharness: 2017-05-09 17:34:42.299892Z] Finished create-virtualenv step (success) 10:34:42 INFO - [mozharness: 2017-05-09 17:34:42.300402Z] Running install step. 10:34:42 INFO - Running pre-action listener: _resource_record_pre_action 10:34:42 INFO - Running main action method: install 10:34:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:34:42 INFO - Reading from file tmpfile_stdout 10:34:42 INFO - Detecting whether we're running mozinstall >=1.0... 10:34:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:34:42 INFO - Reading from file tmpfile_stdout 10:34:42 INFO - Output received: 10:34:42 INFO - Usage: mozinstall [options] installer 10:34:42 INFO - Options: 10:34:42 INFO - -h, --help show this help message and exit 10:34:42 INFO - -d DEST, --destination=DEST 10:34:42 INFO - Directory to install application into. [default: 10:34:42 INFO - "/builds/slave/test"] 10:34:42 INFO - --app=APP Application being installed. [default: firefox] 10:34:42 INFO - mkdir: /builds/slave/test/build/application 10:34:42 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'] 10:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:34:58 INFO - Reading from file tmpfile_stdout 10:34:58 INFO - Output received: 10:34:58 INFO - /builds/slave/test/build/application/firefox/firefox 10:34:58 INFO - Running post-action listener: _resource_record_post_action 10:34:58 INFO - [mozharness: 2017-05-09 17:34:58.444033Z] Finished install step (success) 10:34:58 INFO - [mozharness: 2017-05-09 17:34:58.444309Z] Running run-tests step. 10:34:58 INFO - Running pre-action listener: _resource_record_pre_action 10:34:58 INFO - Running main action method: run_tests 10:34:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:34:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:34:58 INFO - Python 2.7.3 10:34:58 INFO - Return code: 0 10:34:58 INFO - grabbing minidump binary from tooltool 10:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:58 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 0x2221a30>, '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 0x22227f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2222ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:34:58 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 10:34:58 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 10:34:58 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 10:34:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:34:58 INFO - Return code: 0 10:34:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:34:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:34:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:34:58 INFO - ENV: RUST_BACKTRACE is now 1 10:34:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:34:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:34:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FRvYA01qRpywlEklhoWTpA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:34:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FRvYA01qRpywlEklhoWTpA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:34:58 INFO - Using env: {'DISPLAY': ':0', 10:34:58 INFO - 'HOME': '/home/cltbld', 10:34:58 INFO - 'LANG': 'en_US.UTF-8', 10:34:58 INFO - 'LANGUAGE': 'en_US:en', 10:34:58 INFO - 'LOGNAME': 'cltbld', 10:34:58 INFO - 'MAIL': '/var/mail/cltbld', 10:34:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:34:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:58 INFO - 'MOZ_NO_REMOTE': '1', 10:34:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:34:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:58 INFO - 'NO_EM_RESTART': '1', 10:34:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:58 INFO - 'PWD': '/builds/slave/test', 10:34:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:34:58 INFO - 'RUST_BACKTRACE': '1', 10:34:58 INFO - 'SHELL': '/bin/bash', 10:34:58 INFO - 'SHLVL': '1', 10:34:58 INFO - 'TERM': 'linux', 10:34:58 INFO - 'TMOUT': '86400', 10:34:58 INFO - 'USER': 'cltbld', 10:34:58 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279', 10:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:58 INFO - '_': '/tools/buildbot/bin/python'} 10:34:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FRvYA01qRpywlEklhoWTpA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:34:58 INFO - mozversion application_buildid: 20170509170718 10:34:58 INFO - mozversion application_changeset: b9bd73036a925e44f44ee87e779fbbdb2dbe618c 10:34:58 INFO - mozversion application_display_name: Nightly 10:34:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:34:58 INFO - mozversion application_name: Firefox 10:34:58 INFO - mozversion application_remotingname: firefox 10:34:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:34:58 INFO - mozversion application_vendor: Mozilla 10:34:58 INFO - mozversion application_version: 55.0a1 10:34:58 INFO - mozversion platform_buildid: 20170509170718 10:34:58 INFO - mozversion platform_changeset: b9bd73036a925e44f44ee87e779fbbdb2dbe618c 10:34:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:34:58 INFO - mozversion platform_version: 55.0a1 10:34:58 INFO - using testdate: 1494351298 10:34:58 INFO - actual date: 1494351298 10:34:58 INFO - starting webserver on 'localhost:50324' 10:34:58 INFO - SUITE-START | Running 2 tests 10:34:58 INFO - TEST-START | dromaeo_css 10:34:58 INFO - operating with platform_type : linux_ 10:34:58 INFO - Initialising browser for dromaeo_css test... 10:34:58 INFO - TEST-INFO | started process 12289 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeIO9NT/profile http://localhost:50324/getInfo.html) 10:35:02 INFO - PID 12289 | __metrics Screen width/height:1600/1200 10:35:02 INFO - PID 12289 | colorDepth:24 10:35:02 INFO - PID 12289 | Browser inner width/height: 1024/695 10:35:02 INFO - PID 12289 | __metrics 10:35:03 INFO - PID 12289 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:35:03 INFO - PID 12289 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:35:04 INFO - TEST-INFO | 12289: exit 0 10:35:04 INFO - Browser initialized. 10:35:04 INFO - Running cycle 1/1 for dromaeo_css test... 10:35:04 INFO - TEST-INFO | started process 12383 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeIO9NT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:35:16 INFO - PID 12383 | RSS: Main: 148946944 10:35:16 INFO - PID 12383 | 10:38:22 INFO - PID 12383 | Cycle 1(1): loaded http://localhost:50324/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50324/tests/dromaeo/cssquery-ext.html) 10:38:24 INFO - PID 12383 | RSS: Main: 268587008 10:38:24 INFO - PID 12383 | 10:41:26 INFO - PID 12383 | Cycle 1(1): loaded http://localhost:50324/tests/dromaeo/cssquery-ext.html (next: http://localhost:50324/tests/dromaeo/cssquery-jquery.html) 10:41:27 INFO - PID 12383 | RSS: Main: 232050688 10:41:27 INFO - PID 12383 | 10:44:28 INFO - PID 12383 | Cycle 1(1): loaded http://localhost:50324/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50324/tests/dromaeo/cssquery-mootools.html) 10:44:29 INFO - PID 12383 | RSS: Main: 179281920 10:44:29 INFO - PID 12383 | 10:47:31 INFO - PID 12383 | Cycle 1(1): loaded http://localhost:50324/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50324/tests/dromaeo/cssquery-prototype.html) 10:47:32 INFO - PID 12383 | RSS: Main: 220995584 10:47:32 INFO - PID 12383 | 10:50:35 INFO - PID 12383 | Cycle 1(1): loaded http://localhost:50324/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50324/tests/dromaeo/cssquery-yui.html) 10:50:36 INFO - PID 12383 | RSS: Main: 179597312 10:50:36 INFO - PID 12383 | 10:53:38 INFO - PID 12383 | Cycle 1(1): loaded http://localhost:50324/tests/dromaeo/cssquery-yui.html (next: http://localhost:50324/tests/dromaeo/cssquery-dojo.html) 10:53:38 INFO - PID 12383 | RSS: Main: 267083776 10:53:38 INFO - PID 12383 | 10:53:38 INFO - PID 12383 | __start_tp_report 10:53:38 INFO - PID 12383 | _x_x_mozilla_page_load 10:53:38 INFO - PID 12383 | _x_x_mozilla_page_load_details 10:53:38 INFO - PID 12383 | |i|pagename|runs| 10:53:38 INFO - PID 12383 | |0;dojo.html;2676.1837639519945;2683.2352779457833;2721.9319517012086;2729.413176167125;2729.426820367722;5127.435982041981;5219.608529360295;5268.394134674513;5284.212206460365;5309.283246761686;5242.790288388469;5251.317328747267;5273.5781137509;5318.2554442378005;5335.039692855285;4383.3424986252;4575.130725162225;4641.9535804641855;4696.577308042276;4748.5726284634375;4672.15901137795;4701.788419521113;4715.12770137524;4729.834455794048;4769.689970151946;4572.908541829145;4629.097326021393;4631.4673812511655;4643.419572553431;4686.015936653307;4682.41469816273;4684.601808846252;4691.179043667345;4714.528547145258;4752.9762351188365;4640.466346370177;4666.2067448533835;4678.625709943196;4688.5077066907825;4735.763211839394;5128.205128205134;5131.7690703918415;5178.922316165261;5190.11767999441;5211.739413029333;5590.440955904418;5644.209810626516;5700.7149642518125;5705.885882282331;5707.286589176353;5709.571782116358;5711.257536520226;5730.140478928194;5730.484256416942;5736.913946290809;5176.7411629418375;5290.338707661504;5305.283786688825;5305.973470132702;5354.116570765858;5685.0619647758485;5797.681127537941;5798.072308430716;5908.675022873697;5910.438508341701;5458.699771512525;5500.257465242141;5520.089185284463;5522.834314970557;5621.241132447068;5725.59920805548;5741.425857414225;5742.856428589319;5778.393268706809;5781.046127389018;5660.886782264414;5663.377028526858;5664.830055098354;5666.46168613981;5698.62958907678;5643.80246691372;5646.20953066571;5648.548116150698;5659.801906933238;5666.320041594952;4598.103369842848;4612.677112602153;4651.697639653412;4657.650676199299;4702.835400760957;4025.8590949317218;4035.1727895781296;4040.7171497995446;4063.79681015948;4079.673626109904;4788.970371370172;4796.2805579163405;4799.544043315949;4801.9039619208115;4843.660943733905;5521.696306703089;5612.775488980476;5672.262605861211;5682.943170568324;5750.88498230033;4838.467768545457;4850.805967761321;4852.1508735971765;4852.854414367504;4895.31465594817;5119.098096924665;5123.718195499283;5129.179331306973;5132;5172.508611681884;5179.507946745053;5218.765155567932;5270.920936185884;5291.9206211906085;5303.9204411934625;5657.943420565742;5671.262735844314;5701.686407247641;5711.200431939449;5718.571107167062;5242.16125419931;5245.423003469692;5246.842594722164;5249;5250.894982100413;5422.620416570802;5514.503694667499;5529.944700552943;5555.694436805853;5618.101103823368;5625.09998400254;5654;5664.122061080539;5706.115552089433;5715.142728590745;5465;5468.207109969112;5468.699221542854;5469.343678758574;5473.151661492475;5321.228421878884;5396.83809485716;5467.6719396836315;5470.452954704498;5528.530074943675;5444.12893936984;5446.482584154499;5453.15476101205;5491.066518691752;5507.7246137693755;5551.666899986014;5556.361018482926;5566.805161819317;5568.331800184003;5569.55443564522;5279.287296215115;5365.087935050972;5381.596380271417;5424.159255315432;5463.535599474089 10:53:38 INFO - PID 12383 | |1;ext.html;596.7284885377154;635.098160611931;655.2039272284173;1023.442223987926;1031.6028329093306;24489.142879999203;30264.243393915163;31264.21839454015;31355.529667054983;31417.21456963577;32971.34057318852;33333.833330833375;33367.332653346915;33407;33515;4328.718633288826;4486.259767138435;6742.898856517144;6943.861122777542;6944.375006249436;6026.909596356037;6625.933740662604;6632.403083722464;6675.866482670343;6676.132102826626;6710.597364158141;6711.362420570038;6711.5301928865;6716.6977486013;6880.862382752367;6619.437347825441;6621.834454138637;6636.900446493307;6640.833979150511;6673.265940746514;6805.6597170141295;6857.245702972669;6869;6870.45036397087;6875.518713690044;29822.254443638867;29903.700962990526;29961.45713043072;29973;30060.69939300601;3054.618172728409;3090.9690903090905;3092.072378286505;3092.1032900459063;3092.149658843836;23804.642930356058;23877;23918;23920;23986;2856.757175640073;2858;2859.9714002859914;2872.942541149186;2872.9856350718323;134432;134584.32707836397;134597;134650.3267483666;134746.326268369;39578.80210598986;39616.60383396129;39677.20645587072;39711.80144099261;39736.40395394072;41372.37941430881;41395;41447.792761036;41461.170776584906;41464.585354146075;11584.47869845842;11697.824532632018;11699.415029248503;11711.121665875093;11711.355875426763;8069.677212911418;8208.220219079178;9346.626134954526;9361.812763744687;9363.25093992479;10969.561217551209;11158.163137764537;11177.385243811506;11278.943605281922;11298.20912536131;4696.976515117402;4749.64377671676;4811.927821082687;4818.180909245437;4820.758962051954;877.2455688108222;895.5566994337714;904.8054668246359;927.3601215161517;928.7492377058156;19495.76989838807;19587.706184407245;20537.691934620994;21044.89477552633;21120.894395527925;931.1479995803899;974.4153507895348;987.2990176974429;994.6717583197527;998.5356809083811;10913.508892099875;11049.613263535737;11113.83329250062;11140.944295278472;11175.608853690082;152984;155654;155775;156023.21988389984;156137;37493.250134997696;37641.435378469345;37646.811765941;37671.24657506835;37700.245995079946;1191.5253986932555;1230.864604893461;1232.0328542094412;1232.0820988363726;1233.0875152387348;19022.7146592804;19167.71248431247;19177.61644767069;19992.50018749543;20338.288159914333;28674.713252867205;28676.283092922844;28718.282042948256;28759.424811503235;28800.42399152047;110323.44838275758;110421;110657.44671276915;111118;111492;21960.23139190121;22440;27069;27937;28024.159275221777;31154;31886.52170217495;32392.67607323991;32925.83537082299;33594.664053359156;25019.374515636526;25516.362090947874;25892.22323330303;26236.817114009944;27293.044743433886;25694.614580781676;25730.485390291717;26068.34829129287;26583.544139262547;27002.32494187661;27809.304767380978;27907;29643;31231.219219518785;31304.373912522078;26276.4744705101;26609.467810644066;27066.32334191661;27090.593641095005;27209;20712.48218794482;21921.232756853435;22059.889700551394;22074.22740204085;22091 10:53:38 INFO - PID 12383 | |2;jquery.html;410.4684433658412;415.36034506859437;425.3449687481278;430.9310510318349;437.14319932931454;16784.244708988095;17175.742363864552;17474.91262543687;17490.912545437288;17520.64958700825;16362.590935226624;16628.002319860785;16752.497425077236;16819.747703784422;16999;5306.044911915863;5308.469153084699;5472.288602481672;5479.780808767665;5486.259354987065;5406.270153529283;5492.642978206404;5501.174823776426;5502.119660854264;5503.3395992480955;5250.133727934905;5343.7328133593355;5456.727163641802;5475.917861232065;5480.232767412565;5365.195220716884;5412.323459567554;5458.808941687062;5460.672359658433;5466.34403871534;4807.375041244616;4911.9754401227765;4970.229614409736;4977.502249774993;4986.650934434591;20102.195912163497;20243.898780506002;20365.49086272855;20392.796072039237;20535.8973205133;1657.2790835986384;1674.9413770517974;1677.656080503494;1677.7483377493475;1679.8656107511492;13859;14331.498397556139;14397.712045759132;14513.129212247299;14545.418183272763;2007.9397618071482;2045.1001559314002;2100.096958307927;2103.5582527669208;2106.104905415192;71683.64158179228;72064.91902621517;72172;72588;72970.27029729688;10552.103071238877;10743.462826858626;10769;10955.178361622751;10982.176336774774;15238;15259.313330900137;15266.618334541503;15280.770788438182;15291.311890964933;7071.328223818729;7193;7265.09186351706;7397.371223446067;7455.030845990095;6452.516061295421;6566.212054553389;6732.124823772878;6740.764073257413;6769.765977227503;6621.503387245976;6809.931900681029;6813.931860681429;6849;6862.176538815374;2054.907529161191;2066.225165562914;2070.171931227521;2092.61286661968;2101.53766171442;858.793889466536;859.4113032572708;869.2654706772767;892.2727976698969;898.4160295807646;16143.838561614233;16361;16395.918020409823;16562.751558726628;17119.828801712072;875.3434923807145;879.2921698033017;893.1515060692368;894.0612357025097;907.8774365460711;8747.387682862138;8829.911700883038;8994.28045756338;10684.893151068545;11445.370504622326;315488;323091;323177;323212;324902;71974.64012679903;72447;73299.63350183216;73339.63330183421;74646;1081.929674571166;1111.6553868300853;1112.1769890281296;1125.1617544928918;1128.7798879218637;16612.58468538296;16622.916885415496;17034.14829258557;17344;17387;36617.45073823842;37757.56060984754;38501.6149838498;38841.805790970866;40128.79935600303;45482.54517454783;45514.31728524141;45633.771831140635;46049;46639.53360466487;7828.686852525835;7943.642536086006;7945.324647405036;8011.759647210593;8341.624626891926;11812;11954.282743035446;12102;12177.269363838199;12482.251064936132;9540.284478663989;9625.71122866315;10097.646582369582;10188.490575471345;10632.956608884635;9546.904530954602;9642.903570964201;10101.49492525356;10178;10197.74505637365;9959.502024898871;10103.54534045955;10186.898131018595;10296.948515257676;10718.678439646823;7945.880811787712;7980.441369104339;8190.600900626174;8202.58987050657;8241.670333186605;10377.221708371751;10382.792344152924;10514.684559463229;10561;10793.838092428778 10:53:38 INFO - PID 12383 | |3;mootools.html;1078.320657985469;1200.471792411339;1273.8025606031063;1280.3726174174653;1286.665466978586;8304.335653147742;9849.162821160202;10235.385876847386;10236.641717539887;10253.743656408593;10012.199024078074;10106.747331316721;10120.240981926367;10120.291579589431;10128.848067278997;1816.6094289727705;2082.4273324835676;2119.448943274752;2119.682047692843;2122.7877212278727;1813.918373673188;2197.165077270643;2265.3996690876847;2267.5124848157643;2272.6931864198286;2232.854864433815;2261.7172853393326;2263.5586060718165;2267.7958983691547;2270.421042634126;2155.3210738617286;2158.4927542027613;2158.967615485769;2163.9567208655894;2165.1231251343233;2143.3141394753684;2163.7511686156136;2222.533268013719;2223.321886824518;2224.7552769195377;9830.803383932353;9831.950840245825;9919.156871665917;9935.453550054744;9944.453055081967;5145.562627176694;5332.520073193431;5337.813176538842;5338.866528336784;5345.786168553253;3199.1842080269384;3401.5918089829133;3404.642512536173;3456.1186897341267;3457.619661837196;922.6171138977317;943.6697155995415;997.8952210017916;1002.0580654185043;1002.5037606384814;14914.925425372912;14933.328000240015;14934.850651493454;14953;14964.176970266632;5020.949790502122;5104.591632669451;5185.34753285053;5205.2192171173865;5308.177232528887;12369.62891113268;12404.503819847285;12406.503739850305;12408.317542535067;12412.56556020535;5541.113421852484;5665;5669.659820410789;5674.205611214434;5675.0068737971515;4990.800367985313;5097.8725531862;5097.923531147036;5105.387353517527;5121.948780512147;3728.8508459661853;3791.677707394847;3824.2542704172974;3827.4641550182996;3901.6098390160755;1089.3082892363407;1100.1583788401879;1105.209775010855;1105.7677887643524;1134.2230572058002;655.1057806094647;674.8987651852261;675.8006388115517;691.3708525242106;698.2563569798149;4982.153033984159;4997.175466048061;5024.924825925768;5196.740162991835;5266.157414813688;532.5526557691558;799.9920000800034;806.1253539909147;809.7368355284556;824.1881746479713;3649.8357573908706;3761.887143385703;3762.887113386603;3764.265968136187;3895.3183192941688;12472.812907806208;12758.298293593942;13113.147645403018;13153.408096635674;13222.933885330704;12813.551525696555;12876.613701588967;13054.151480153949;13095.934520327337;13225.603231903058;7206.135263768381;7256.492045556866;7348.191698913115;7348.81627959316;7352.411807055422;5360.2227676987395;5371.5971302153275;5482.945170548243;5497.972510137423;5583.804566840141;11121.944390277997;11642.24325418845;11672;11704.824427633423;11743.706407339885;11822.995045421236;11996.460159293027;12024.579139730067;12036.398180091135;12060.095492837896;7233.348998590152;7439.40484761207;7453.217412171643;7455.664495097625;7460.589667568336;9138.13187747163;9268.397554158959;9435.339526233098;9436.480993545421;9439.905600944177;8045.557494337868;8085.555294458626;8086.676532938616;8151.103378628465;8159.3880458967005;7764.456488045783;7915;7944.523328600302;8056.234657707509;8166.550839703873;7099.503034787722;7233.348998590152;7242.275772422716;7256.818579535343;7258.237885022208;4853.708777473363;4877.219644856806;4946.134426475424;5061.924071139009;5152.145227718093;5102.10713125209;5201.375834899836;5296;5316.6012549058205;5329.589062999761 10:53:38 INFO - PID 12383 | |4;prototype.html;334.44983002960146;359.64035964035963;377.7525720652972;382.8124219132624;386.8761996161226;5096.159133742933;5200.947990520093;5352.973235133819;5359.5444387227035;5365.329333833266;5189.143791274445;5265.86835329117;5269.525742683158;5286.577073834093;5300.469953004697;4169.62473377396;4175.895602609929;4178.7283826551175;4179.561146079664;4191.2665283575325;3960.584138665442;4073.450084238634;4177.895552611194;4200.096979149483;4200.600942910419;4061.9593804062024;4158.937615935748;4179.373094035904;4180.017695841475;4193.916121677565;4170.70805043647;4180.853670121546;4182.769947652878;4186.120914607936;4201.684873634459;3574.6782789548806;3591.712662986955;3815.7328986970924;3822.140018495844;3824.5410550733814;5143.04853602081;5148.176291793295;5156.226566015091;5163.612729045337;5191.922121168185;4905.166121759309;4908;4925.285833554115;4929.827456039057;4930.580900623451;5463.371712253102;5515.7242137892945;5588.497035266805;5619.887602247933;5624.409437009096;4254.149170165979;4260.21186080573;4262.87211383659;4272.060146767737;4273.29490634045;5872.941270587325;5887.499562537189;5889.499392551638;5897.380775018604;5898.705064746746;4329.264025115738;4352.455943007124;4373.846915358011;4378.365137055109;4396.956030439655;4182.749035057906;4403.9779801100785;4414.161309351213;4424.6681498887065;4436.800343984529;4741.534402110952;4762.285657151455;4878.07316609843;4878.463369029404;4884.975575122102;5571.192177134293;5598.076317407582;5599.412061733541;5599.944000560024;5605.5515558755205;1321.187469706124;1370.6025252676811;1529.8393668664853;1550.139672481761;1554.1918202534619;909.4997751236793;924.7503174142944;928.6471140966389;929.4887811703536;931.2782593490099;4827.589654879304;4882.170031094723;4890.486498917634;4891.779869905863;4914.483979182206;5793.565482588822;5798.9130163047585;5802.65184088956;5821.970890145522;5835.766569337264;4739.881502962385;4855.393075865517;4858.562729354375;4863.756812159449;4870.683405578697;3025.1529571719952;3043.695630436983;3044.4367791958557;3046.207985923676;3064.739497142768;5326.174442961347;5340.332458442695;5351.25082488452;5353.411124776271;5375.543078838343;5667.574931880125;5924.970375148183;5958.731857066442;5974.402559744078;5983.910241346383;5423.48142520095;5444.482774136451;5446.2375267462585;5454.809081682122;5470.91793623096;5668.404817494269;5846.064629659234;5861.32594751609;5861.479563787442;5877.177195192762;5753.510951569164;5782.959067367914;5789.45000224978;5805.82582522525;5806.129080637938;5421.05131601976;5450.781968721207;5462.8361149165585;5466.781328746805;5475.507204351468;3800.714946379088;3894.6300101490315;3920.3727403615285;3934.252492026506;3938.2123575284486;5542;5629.240052593012;5682.715864206856;5825.79609713658;5839.941600583939;5590.580706446952;5603.635763675348;5605.103183490622;5632.887342253214;5640.830775076754;5500.50495455395;5567.4432556744005;5604.8318550443555;5623.8875222496135;5635.351934527582;5501.394846566955;5551.944480555143;5555.22226888244;5555.555555555627;5562.860928476821;5603.7758489659955;5607;5621.634593751393;5625.296837895263;5627.380988091389;5390.326209223847;5442.455754424526;5505.724713764376;5505.9724701376235;5508.724563771715 10:53:38 INFO - PID 12383 | |5;yui.html;697.5256825358754;706.7738323736403;711.2709472790389;727.7671145233525;739.1536690489392;13017.544385946494;13900.791488127687;13910.304484775772;13911.304434778245;13915.025948183618;12967.870321296808;14888.851111488882;15086.849131508681;15204.315805788738;15235.847641523582;872.2498651159997;887.414306557672;891.189017993626;891.2914233184633;891.79488717595;905.6603773584906;907.9546022698871;908.3232991421401;908.5457271364318;908.5684299957501;954.9283803714715;959.5681943125586;959.788846453779;960.1550635440802;960.3853533738413;884.5886662701843;904.0597778310549;916.6562539047857;952.2334520710825;952.6141912525438;671.6171782084214;671.8219671786932;671.8454755406235;672.2336536348566;673.9090222819906;13588;13763.587092387244;13807.585772426843;13825.51610693631;13877.791833122512;15457.458988935447;15712.21438928049;15986.680266394724;16102.114383708891;16103.677926441405;11782.116341274439;12030.578929737418;12034.63896083119;12045.337506437143;12065.396730163544;2723.550614148663;2724.741149590786;2732.617433559303;2752.779777617786;2753.7796976241852;68654.65672671655;70426;71466.285337147;72235.63882180607;72960;12293.016558675285;12345.506179752709;12461.626151215478;12702.11085224044;12727;22193.22323718662;22484.100635974377;22675.773242267365;22703.091876325092;22709;6244.313125556185;6282.120503129566;6293.465055470337;6300.086487459384;6307.621542707452;2989.491786396318;2994.685558016377;3063.6323641163203;3067.4018566379787;3067.601211842491;3519.1729943463265;3641.7450778445254;3645.671889529955;3648.9635103648625;3655.1775850433974;711.8291610013663;714.17156098925;719.6725489902082;720.7909706185252;723.2767232767233;555.7026990560031;556.9582281328917;558.804418453538;560.7476635514035;562.971851407428;8914.509701966324;9035.864462033074;9177.21993630549;9194.678186263449;9767.316287859781;580.5935844908581;584.243404790797;586.1003359842621;586.6978506069378;605.4339192854695;4420.955790442054;4466.553344665507;4472.843450479218;4485.551444855553;4494.662900282492;62610.373896261364;63760.36239637637;63824.36175638277;64624.35375646183;64800;54555;55370.33888983337;55408.72295638496;55414.16878746822;57540.424595754346;36510.63489365125;50902.745486273074;53795.19307210317;54084.72957635108;54651.9011074171;9195.862062069207;10199.439030853078;10311.587536498457;10398.324108932895;10640.52117654692;26517.60223596686;26586.867065664548;26587.734122658527;27453.862730686218;27936.580951286152;31500.68499315069;31568.684313156573;31587.684123158473;31944.52083218707;32631.836840815646;12671.619851404472;12756.74486510246;12789;12876.935615321863;12910.935445322713;15206.315715793036;15227.923860380628;15234.238288085773;15410.92294538565;15483.5354939352;13610.863891361356;13733.244671543162;13795.310234488436;13931.860681393056;14026.579202623938;13642.93178534101;13741.381637826122;13749.656258593615;13807.51673691416;13852.238126902714;13367.866321336662;13380.464781408635;13401.128926619738;13420;13460.93269533646;9638.243278789347;9674.22606191489;9772.9022709772;9992.15066719337;10094.24293178;10254.179665626583;10319.535620897228;10565.260431769702;10634.09610183112;10847.728806779895 10:53:38 INFO - PID 12383 | __end_tp_report 10:53:38 INFO - PID 12383 | __start_cc_report 10:53:38 INFO - PID 12383 | _x_x_mozilla_cycle_collect,1390 10:53:38 INFO - PID 12383 | __end_cc_report 10:53:38 INFO - PID 12383 | __startTimestamp1494352418316__endTimestamp 10:53:38 INFO - PID 12383 | 10:53:38 INFO - PID 12383 | ------- Summary: start ------- 10:53:38 INFO - PID 12383 | Number of tests: 6 10:53:38 INFO - PID 12383 | 10:53:38 INFO - PID 12383 | [#0] dojo.html Cycles:165 Average:5172.86 Median:5309.28 stddev:616.40 (11.6%) stddev-sans-first:586.35 10:53:38 INFO - PID 12383 | Values: 2676.2 2683.2 2721.9 2729.4 2729.4 5127.4 5219.6 5268.4 5284.2 5309.3 5242.8 5251.3 5273.6 5318.3 5335.0 4383.3 4575.1 4642.0 4696.6 4748.6 4672.2 4701.8 4715.1 4729.8 4769.7 4572.9 4629.1 4631.5 4643.4 4686.0 4682.4 4684.6 4691.2 4714.5 4753.0 4640.5 4666.2 4678.6 4688.5 4735.8 5128.2 5131.8 5178.9 5190.1 5211.7 5590.4 5644.2 5700.7 5705.9 5707.3 5709.6 5711.3 5730.1 5730.5 5736.9 5176.7 5290.3 5305.3 5306.0 5354.1 5685.1 5797.7 5798.1 5908.7 5910.4 5458.7 5500.3 5520.1 5522.8 5621.2 5725.6 5741.4 5742.9 5778.4 5781.0 5660.9 5663.4 5664.8 5666.5 5698.6 5643.8 5646.2 5648.5 5659.8 5666.3 4598.1 4612.7 4651.7 4657.7 4702.8 4025.9 4035.2 4040.7 4063.8 4079.7 4789.0 4796.3 4799.5 4801.9 4843.7 5521.7 5612.8 5672.3 5682.9 5750.9 4838.5 4850.8 4852.2 4852.9 4895.3 5119.1 5123.7 5129.2 5132.0 5172.5 5179.5 5218.8 5270.9 5291.9 5303.9 5657.9 5671.3 5701.7 5711.2 5718.6 5242.2 5245.4 5246.8 5249.0 5250.9 5422.6 5514.5 5529.9 5555.7 5618.1 5625.1 5654.0 5664.1 5706.1 5715.1 5465.0 5468.2 5468.7 5469.3 5473.2 5321.2 5396.8 5467.7 5470.5 5528.5 5444.1 5446.5 5453.2 5491.1 5507.7 5551.7 5556.4 5566.8 5568.3 5569.6 5279.3 5365.1 5381.6 5424.2 5463.5 10:53:38 INFO - PID 12383 | 10:53:38 INFO - PID 12383 | [#1] ext.html Cycles:180 Average:27315.55 Median:29732.63 stddev:34786.95 (117.0%) stddev-sans-first:34826.67 10:53:38 INFO - PID 12383 | Values: 596.7 635.1 655.2 1023.4 1031.6 24489.1 30264.2 31264.2 31355.5 31417.2 32971.3 33333.8 33367.3 33407.0 33515.0 4328.7 4486.3 6742.9 6943.9 6944.4 6026.9 6625.9 6632.4 6675.9 6676.1 6710.6 6711.4 6711.5 6716.7 6880.9 6619.4 6621.8 6636.9 6640.8 6673.3 6805.7 6857.2 6869.0 6870.5 6875.5 29822.3 29903.7 29961.5 29973.0 30060.7 3054.6 3091.0 3092.1 3092.1 3092.1 23804.6 23877.0 23918.0 23920.0 23986.0 2856.8 2858.0 2860.0 2872.9 2873.0 134432.0 134584.3 134597.0 134650.3 134746.3 39578.8 39616.6 39677.2 39711.8 39736.4 41372.4 41395.0 41447.8 41461.2 41464.6 11584.5 11697.8 11699.4 11711.1 11711.4 8069.7 8208.2 9346.6 9361.8 9363.3 10969.6 11158.2 11177.4 11278.9 11298.2 4697.0 4749.6 4811.9 4818.2 4820.8 877.2 895.6 904.8 927.4 928.7 19495.8 19587.7 20537.7 21044.9 21120.9 931.1 974.4 987.3 994.7 998.5 10913.5 11049.6 11113.8 11140.9 11175.6 152984.0 155654.0 155775.0 156023.2 156137.0 37493.3 37641.4 37646.8 37671.2 37700.2 1191.5 1230.9 1232.0 1232.1 1233.1 19022.7 19167.7 19177.6 19992.5 20338.3 28674.7 28676.3 28718.3 28759.4 28800.4 110323.4 110421.0 110657.4 111118.0 111492.0 21960.2 22440.0 27069.0 27937.0 28024.2 31154.0 31886.5 32392.7 32925.8 33594.7 25019.4 25516.4 25892.2 26236.8 27293.0 25694.6 25730.5 26068.3 26583.5 27002.3 27809.3 27907.0 29643.0 31231.2 31304.4 26276.5 26609.5 27066.3 27090.6 27209.0 20712.5 21921.2 22059.9 22074.2 22091.0 10:53:38 INFO - PID 12383 | 10:53:38 INFO - PID 12383 | [#2] jquery.html Cycles:180 Average:22641.41 Median:39485.30 stddev:53527.77 (135.6%) stddev-sans-first:53651.91 10:53:38 INFO - PID 12383 | Values: 410.5 415.4 425.3 430.9 437.1 16784.2 17175.7 17474.9 17490.9 17520.6 16362.6 16628.0 16752.5 16819.7 16999.0 5306.0 5308.5 5472.3 5479.8 5486.3 5406.3 5492.6 5501.2 5502.1 5503.3 5250.1 5343.7 5456.7 5475.9 5480.2 5365.2 5412.3 5458.8 5460.7 5466.3 4807.4 4912.0 4970.2 4977.5 4986.7 20102.2 20243.9 20365.5 20392.8 20535.9 1657.3 1674.9 1677.7 1677.7 1679.9 13859.0 14331.5 14397.7 14513.1 14545.4 2007.9 2045.1 2100.1 2103.6 2106.1 71683.6 72064.9 72172.0 72588.0 72970.3 10552.1 10743.5 10769.0 10955.2 10982.2 15238.0 15259.3 15266.6 15280.8 15291.3 7071.3 7193.0 7265.1 7397.4 7455.0 6452.5 6566.2 6732.1 6740.8 6769.8 6621.5 6809.9 6813.9 6849.0 6862.2 2054.9 2066.2 2070.2 2092.6 2101.5 858.8 859.4 869.3 892.3 898.4 16143.8 16361.0 16395.9 16562.8 17119.8 875.3 879.3 893.2 894.1 907.9 8747.4 8829.9 8994.3 10684.9 11445.4 315488.0 323091.0 323177.0 323212.0 324902.0 71974.6 72447.0 73299.6 73339.6 74646.0 1081.9 1111.7 1112.2 1125.2 1128.8 16612.6 16622.9 17034.1 17344.0 17387.0 36617.5 37757.6 38501.6 38841.8 40128.8 45482.5 45514.3 45633.8 46049.0 46639.5 7828.7 7943.6 7945.3 8011.8 8341.6 11812.0 11954.3 12102.0 12177.3 12482.3 9540.3 9625.7 10097.6 10188.5 10633.0 9546.9 9642.9 10101.5 10178.0 10197.7 9959.5 10103.5 10186.9 10296.9 10718.7 7945.9 7980.4 8190.6 8202.6 8241.7 10377.2 10382.8 10514.7 10561.0 10793.8 10:53:38 INFO - PID 12383 | 10:53:38 INFO - PID 12383 | [#3] mootools.html Cycles:180 Average:6180.09 Median:4865.46 stddev:4020.59 (82.6%) stddev-sans-first:4013.59 10:53:38 INFO - PID 12383 | Values: 1078.3 1200.5 1273.8 1280.4 1286.7 8304.3 9849.2 10235.4 10236.6 10253.7 10012.2 10106.7 10120.2 10120.3 10128.8 1816.6 2082.4 2119.4 2119.7 2122.8 1813.9 2197.2 2265.4 2267.5 2272.7 2232.9 2261.7 2263.6 2267.8 2270.4 2155.3 2158.5 2159.0 2164.0 2165.1 2143.3 2163.8 2222.5 2223.3 2224.8 9830.8 9832.0 9919.2 9935.5 9944.5 5145.6 5332.5 5337.8 5338.9 5345.8 3199.2 3401.6 3404.6 3456.1 3457.6 922.6 943.7 997.9 1002.1 1002.5 14914.9 14933.3 14934.9 14953.0 14964.2 5020.9 5104.6 5185.3 5205.2 5308.2 12369.6 12404.5 12406.5 12408.3 12412.6 5541.1 5665.0 5669.7 5674.2 5675.0 4990.8 5097.9 5097.9 5105.4 5121.9 3728.9 3791.7 3824.3 3827.5 3901.6 1089.3 1100.2 1105.2 1105.8 1134.2 655.1 674.9 675.8 691.4 698.3 4982.2 4997.2 5024.9 5196.7 5266.2 532.6 800.0 806.1 809.7 824.2 3649.8 3761.9 3762.9 3764.3 3895.3 12472.8 12758.3 13113.1 13153.4 13222.9 12813.6 12876.6 13054.2 13095.9 13225.6 7206.1 7256.5 7348.2 7348.8 7352.4 5360.2 5371.6 5482.9 5498.0 5583.8 11121.9 11642.2 11672.0 11704.8 11743.7 11823.0 11996.5 12024.6 12036.4 12060.1 7233.3 7439.4 7453.2 7455.7 7460.6 9138.1 9268.4 9435.3 9436.5 9439.9 8045.6 8085.6 8086.7 8151.1 8159.4 7764.5 7915.0 7944.5 8056.2 8166.6 7099.5 7233.3 7242.3 7256.8 7258.2 4853.7 4877.2 4946.1 5061.9 5152.1 5102.1 5201.4 5296.0 5316.6 5329.6 10:53:38 INFO - PID 12383 | 10:53:38 INFO - PID 12383 | [#4] prototype.html Cycles:180 Average:4677.67 Median:5293.52 stddev:1346.12 (25.4%) stddev-sans-first:1309.83 10:53:38 INFO - PID 12383 | Values: 334.4 359.6 377.8 382.8 386.9 5096.2 5200.9 5353.0 5359.5 5365.3 5189.1 5265.9 5269.5 5286.6 5300.5 4169.6 4175.9 4178.7 4179.6 4191.3 3960.6 4073.5 4177.9 4200.1 4200.6 4062.0 4158.9 4179.4 4180.0 4193.9 4170.7 4180.9 4182.8 4186.1 4201.7 3574.7 3591.7 3815.7 3822.1 3824.5 5143.0 5148.2 5156.2 5163.6 5191.9 4905.2 4908.0 4925.3 4929.8 4930.6 5463.4 5515.7 5588.5 5619.9 5624.4 4254.1 4260.2 4262.9 4272.1 4273.3 5872.9 5887.5 5889.5 5897.4 5898.7 4329.3 4352.5 4373.8 4378.4 4397.0 4182.7 4404.0 4414.2 4424.7 4436.8 4741.5 4762.3 4878.1 4878.5 4885.0 5571.2 5598.1 5599.4 5599.9 5605.6 1321.2 1370.6 1529.8 1550.1 1554.2 909.5 924.8 928.6 929.5 931.3 4827.6 4882.2 4890.5 4891.8 4914.5 5793.6 5798.9 5802.7 5822.0 5835.8 4739.9 4855.4 4858.6 4863.8 4870.7 3025.2 3043.7 3044.4 3046.2 3064.7 5326.2 5340.3 5351.3 5353.4 5375.5 5667.6 5925.0 5958.7 5974.4 5983.9 5423.5 5444.5 5446.2 5454.8 5470.9 5668.4 5846.1 5861.3 5861.5 5877.2 5753.5 5783.0 5789.5 5805.8 5806.1 5421.1 5450.8 5462.8 5466.8 5475.5 3800.7 3894.6 3920.4 3934.3 3938.2 5542.0 5629.2 5682.7 5825.8 5839.9 5590.6 5603.6 5605.1 5632.9 5640.8 5500.5 5567.4 5604.8 5623.9 5635.4 5501.4 5551.9 5555.2 5555.6 5562.9 5603.8 5607.0 5621.6 5625.3 5627.4 5390.3 5442.5 5505.7 5506.0 5508.7 10:53:38 INFO - PID 12383 | 10:53:38 INFO - PID 12383 | [#5] yui.html Cycles:180 Average:15016.36 Median:3580.46 stddev:17944.26 (501.2%) stddev-sans-first:17962.38 10:53:38 INFO - PID 12383 | Values: 697.5 706.8 711.3 727.8 739.2 13017.5 13900.8 13910.3 13911.3 13915.0 12967.9 14888.9 15086.8 15204.3 15235.8 872.2 887.4 891.2 891.3 891.8 905.7 908.0 908.3 908.5 908.6 954.9 959.6 959.8 960.2 960.4 884.6 904.1 916.7 952.2 952.6 671.6 671.8 671.8 672.2 673.9 13588.0 13763.6 13807.6 13825.5 13877.8 15457.5 15712.2 15986.7 16102.1 16103.7 11782.1 12030.6 12034.6 12045.3 12065.4 2723.6 2724.7 2732.6 2752.8 2753.8 68654.7 70426.0 71466.3 72235.6 72960.0 12293.0 12345.5 12461.6 12702.1 12727.0 22193.2 22484.1 22675.8 22703.1 22709.0 6244.3 6282.1 6293.5 6300.1 6307.6 2989.5 2994.7 3063.6 3067.4 3067.6 3519.2 3641.7 3645.7 3649.0 3655.2 711.8 714.2 719.7 720.8 723.3 555.7 557.0 558.8 560.7 563.0 8914.5 9035.9 9177.2 9194.7 9767.3 580.6 584.2 586.1 586.7 605.4 4421.0 4466.6 4472.8 4485.6 4494.7 62610.4 63760.4 63824.4 64624.4 64800.0 54555.0 55370.3 55408.7 55414.2 57540.4 36510.6 50902.7 53795.2 54084.7 54651.9 9195.9 10199.4 10311.6 10398.3 10640.5 26517.6 26586.9 26587.7 27453.9 27936.6 31500.7 31568.7 31587.7 31944.5 32631.8 12671.6 12756.7 12789.0 12876.9 12910.9 15206.3 15227.9 15234.2 15410.9 15483.5 13610.9 13733.2 13795.3 13931.9 14026.6 13642.9 13741.4 13749.7 13807.5 13852.2 13367.9 13380.5 13401.1 13420.0 13460.9 9638.2 9674.2 9772.9 9992.2 10094.2 10254.2 10319.5 10565.3 10634.1 10847.7 10:53:38 INFO - PID 12383 | -------- Summary: end -------- 10:53:38 INFO - PID 12383 | 10:53:39 INFO - TEST-INFO | 12383: exit 0 10:53:39 INFO - TEST-OK | dromaeo_css | took 1120448ms 10:53:39 INFO - TEST-START | kraken 10:53:39 INFO - operating with platform_type : linux_ 10:53:39 INFO - Initialising browser for kraken test... 10:53:39 INFO - TEST-INFO | started process 12707 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6xq9UY/profile http://localhost:50324/getInfo.html) 10:53:42 INFO - PID 12707 | __metrics Screen width/height:1600/1200 10:53:42 INFO - PID 12707 | colorDepth:24 10:53:42 INFO - PID 12707 | Browser inner width/height: 1024/695 10:53:42 INFO - PID 12707 | __metrics 10:53:43 INFO - PID 12707 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:53:43 INFO - PID 12707 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:53:44 INFO - TEST-INFO | 12707: exit 0 10:53:44 INFO - Browser initialized. 10:53:44 INFO - Running cycle 1/1 for kraken test... 10:53:44 INFO - TEST-INFO | started process 12807 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6xq9UY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:53:56 INFO - PID 12807 | RSS: Main: 149250048 10:53:56 INFO - PID 12807 | 10:53:59 INFO - PID 12807 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50324/tests/kraken/driver.html?testName=audio-beat-detection) 10:54:00 INFO - PID 12807 | RSS: Main: 222195712 10:54:00 INFO - PID 12807 | 10:54:02 INFO - PID 12807 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50324/tests/kraken/driver.html?testName=audio-dft) 10:54:03 INFO - PID 12807 | RSS: Main: 181960704 10:54:03 INFO - PID 12807 | 10:54:06 INFO - PID 12807 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50324/tests/kraken/driver.html?testName=audio-fft) 10:54:07 INFO - PID 12807 | RSS: Main: 263856128 10:54:07 INFO - PID 12807 | 10:54:09 INFO - PID 12807 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50324/tests/kraken/driver.html?testName=audio-oscillator) 10:54:09 INFO - PID 12807 | RSS: Main: 175595520 10:54:09 INFO - PID 12807 | 10:54:12 INFO - PID 12807 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50324/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:54:12 INFO - PID 12807 | RSS: Main: 177881088 10:54:12 INFO - PID 12807 | 10:54:15 INFO - PID 12807 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50324/tests/kraken/driver.html?testName=imaging-darkroom) 10:54:16 INFO - PID 12807 | RSS: Main: 238145536 10:54:16 INFO - PID 12807 | 10:54:20 INFO - PID 12807 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50324/tests/kraken/driver.html?testName=imaging-desaturate) 10:54:20 INFO - PID 12807 | RSS: Main: 237842432 10:54:20 INFO - PID 12807 | 10:54:23 INFO - PID 12807 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50324/tests/kraken/driver.html?testName=json-parse-financial) 10:54:24 INFO - PID 12807 | RSS: Main: 235331584 10:54:24 INFO - PID 12807 | 10:54:25 INFO - PID 12807 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50324/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:54:26 INFO - PID 12807 | RSS: Main: 200290304 10:54:26 INFO - PID 12807 | 10:54:28 INFO - PID 12807 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50324/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:54:28 INFO - PID 12807 | RSS: Main: 187617280 10:54:28 INFO - PID 12807 | 10:54:30 INFO - PID 12807 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50324/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:54:31 INFO - PID 12807 | RSS: Main: 215531520 10:54:31 INFO - PID 12807 | 10:54:34 INFO - PID 12807 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50324/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:54:34 INFO - PID 12807 | RSS: Main: 223866880 10:54:34 INFO - PID 12807 | 10:54:38 INFO - PID 12807 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50324/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:54:38 INFO - PID 12807 | RSS: Main: 219578368 10:54:38 INFO - PID 12807 | 10:54:40 INFO - PID 12807 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50324/tests/kraken/driver.html?testName=ai-astar) 10:54:40 INFO - PID 12807 | RSS: Main: 269275136 10:54:40 INFO - PID 12807 | 10:54:40 INFO - PID 12807 | __start_tp_report 10:54:40 INFO - PID 12807 | _x_x_mozilla_page_load 10:54:40 INFO - PID 12807 | _x_x_mozilla_page_load_details 10:54:40 INFO - PID 12807 | |i|pagename|runs| 10:54:40 INFO - PID 12807 | |0;ai-astar;108;111;111;112;112;111;110;111;113;111 10:54:40 INFO - PID 12807 | |1;audio-beat-detection;153;128;129;178;141;126;128;125;148;123 10:54:40 INFO - PID 12807 | |2;audio-dft;161;160;161;161;160;161;162;163;165;162 10:54:40 INFO - PID 12807 | |3;audio-fft;75;78;74;106;76;75;75;75;98;77 10:54:40 INFO - PID 12807 | |4;audio-oscillator;83;83;113;84;83;83;101;84;83;107 10:54:40 INFO - PID 12807 | |5;imaging-gaussian-blur;113;113;113;113;113;114;113;114;113;113 10:54:40 INFO - PID 12807 | |6;imaging-darkroom;149;149;148;149;149;149;150;150;148;149 10:54:40 INFO - PID 12807 | |7;imaging-desaturate;93;94;93;93;93;94;93;93;93;93 10:54:40 INFO - PID 12807 | |8;json-parse-financial;54;53;53;53;55;54;54;54;54;55 10:54:40 INFO - PID 12807 | |9;json-stringify-tinderbox;55;56;55;56;55;55;56;55;56;55 10:54:40 INFO - PID 12807 | |10;stanford-crypto-aes;81;81;79;81;80;82;81;80;81;81 10:54:40 INFO - PID 12807 | |11;stanford-crypto-ccm;132;130;132;131;137;128;133;131;185;130 10:54:40 INFO - PID 12807 | |12;stanford-crypto-pbkdf2;185;191;190;196;191;188;178;189;188;181 10:54:40 INFO - PID 12807 | |13;stanford-crypto-sha256-iterative;73;69;72;71;70;69;70;70;70;70 10:54:40 INFO - PID 12807 | __end_tp_report 10:54:40 INFO - PID 12807 | __start_cc_report 10:54:40 INFO - PID 12807 | _x_x_mozilla_cycle_collect,2011 10:54:40 INFO - PID 12807 | __end_cc_report 10:54:40 INFO - PID 12807 | __startTimestamp1494352480699__endTimestamp 10:54:40 INFO - PID 12807 | 10:54:40 INFO - PID 12807 | ------- Summary: start ------- 10:54:40 INFO - PID 12807 | Number of tests: 14 10:54:40 INFO - PID 12807 | 10:54:40 INFO - PID 12807 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:1.33 (1.2%) stddev-sans-first:0.87 10:54:40 INFO - PID 12807 | Values: 108.0 111.0 111.0 112.0 112.0 111.0 110.0 111.0 113.0 111.0 10:54:40 INFO - PID 12807 | 10:54:40 INFO - PID 12807 | [#1] audio-beat-detection Cycles:10 Average:137.90 Median:135.00 stddev:17.49 (13.0%) stddev-sans-first:17.68 10:54:40 INFO - PID 12807 | Values: 153.0 128.0 129.0 178.0 141.0 126.0 128.0 125.0 148.0 123.0 10:54:40 INFO - PID 12807 | 10:54:40 INFO - PID 12807 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.51 (0.9%) stddev-sans-first:1.58 10:54:40 INFO - PID 12807 | Values: 161.0 160.0 161.0 161.0 160.0 161.0 162.0 163.0 165.0 162.0 10:54:40 INFO - PID 12807 | 10:54:40 INFO - PID 12807 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.50 stddev:11.34 (15.0%) stddev-sans-first:11.82 10:54:40 INFO - PID 12807 | Values: 75.0 78.0 74.0 106.0 76.0 75.0 75.0 75.0 98.0 77.0 10:54:40 INFO - PID 12807 | 10:54:40 INFO - PID 12807 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:83.00 stddev:11.81 (14.2%) stddev-sans-first:12.21 10:54:40 INFO - PID 12807 | Values: 83.0 83.0 113.0 84.0 83.0 83.0 101.0 84.0 83.0 107.0 10:54:40 INFO - PID 12807 | 10:54:40 INFO - PID 12807 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:54:40 INFO - PID 12807 | Values: 113.0 113.0 113.0 113.0 113.0 114.0 113.0 114.0 113.0 113.0 10:54:40 INFO - PID 12807 | 10:54:40 INFO - PID 12807 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 10:54:40 INFO - PID 12807 | Values: 149.0 149.0 148.0 149.0 149.0 149.0 150.0 150.0 148.0 149.0 10:54:40 INFO - PID 12807 | 10:54:40 INFO - PID 12807 | [#7] imaging-desaturate Cycles:10 Average:93.20 Median:93.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 10:54:40 INFO - PID 12807 | Values: 93.0 94.0 93.0 93.0 93.0 94.0 93.0 93.0 93.0 93.0 10:54:40 INFO - PID 12807 | 10:54:40 INFO - PID 12807 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 10:54:40 INFO - PID 12807 | Values: 54.0 53.0 53.0 53.0 55.0 54.0 54.0 54.0 54.0 55.0 10:54:40 INFO - PID 12807 | 10:54:40 INFO - PID 12807 | [#9] json-stringify-tinderbox Cycles:10 Average:55.40 Median:55.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 10:54:40 INFO - PID 12807 | Values: 55.0 56.0 55.0 56.0 55.0 55.0 56.0 55.0 56.0 55.0 10:54:40 INFO - PID 12807 | 10:54:40 INFO - PID 12807 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:81.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 10:54:40 INFO - PID 12807 | Values: 81.0 81.0 79.0 81.0 80.0 82.0 81.0 80.0 81.0 81.0 10:54:40 INFO - PID 12807 | 10:54:40 INFO - PID 12807 | [#11] stanford-crypto-ccm Cycles:10 Average:136.90 Median:132.00 stddev:17.06 (12.9%) stddev-sans-first:18.01 10:54:40 INFO - PID 12807 | Values: 132.0 130.0 132.0 131.0 137.0 128.0 133.0 131.0 185.0 130.0 10:54:40 INFO - PID 12807 | 10:54:40 INFO - PID 12807 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.70 Median:189.50 stddev:5.21 (2.7%) stddev-sans-first:5.43 10:54:40 INFO - PID 12807 | Values: 185.0 191.0 190.0 196.0 191.0 188.0 178.0 189.0 188.0 181.0 10:54:40 INFO - PID 12807 | 10:54:40 INFO - PID 12807 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.00 stddev:1.26 (1.8%) stddev-sans-first:0.93 10:54:40 INFO - PID 12807 | Values: 73.0 69.0 72.0 71.0 70.0 69.0 70.0 70.0 70.0 70.0 10:54:40 INFO - PID 12807 | -------- Summary: end -------- 10:54:40 INFO - PID 12807 | 10:54:41 INFO - TEST-INFO | 12807: exit 0 10:54:41 INFO - TEST-OK | kraken | took 62773ms 10:54:41 INFO - SUITE-END | took 1183s 10:54:42 INFO - Completed test suite (00:19:43) 10:54:42 INFO - javascript benchmark 10:54:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6545.308442199274, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2676.1837639519945, 2683.2352779457833, 2721.9319517012086, 2729.413176167125, 2729.426820367722, 5127.435982041981, 5219.608529360295, 5268.394134674513, 5284.212206460365, 5309.283246761686, 5242.790288388469, 5251.317328747267, 5273.5781137509, 5318.2554442378005, 5335.039692855285, 4383.3424986252, 4575.130725162225, 4641.9535804641855, 4696.577308042276, 4748.5726284634375, 4672.15901137795, 4701.788419521113, 4715.12770137524, 4729.834455794048, 4769.689970151946, 4572.908541829145, 4629.097326021393, 4631.4673812511655, 4643.419572553431, 4686.015936653307, 4682.41469816273, 4684.601808846252, 4691.179043667345, 4714.528547145258, 4752.9762351188365, 4640.466346370177, 4666.2067448533835, 4678.625709943196, 4688.5077066907825, 4735.763211839394, 5128.205128205134, 5131.7690703918415, 5178.922316165261, 5190.11767999441, 5211.739413029333, 5590.440955904418, 5644.209810626516, 5700.7149642518125, 5705.885882282331, 5707.286589176353, 5709.571782116358, 5711.257536520226, 5730.140478928194, 5730.484256416942, 5736.913946290809, 5176.7411629418375, 5290.338707661504, 5305.283786688825, 5305.973470132702, 5354.116570765858, 5685.0619647758485, 5797.681127537941, 5798.072308430716, 5908.675022873697, 5910.438508341701, 5458.699771512525, 5500.257465242141, 5520.089185284463, 5522.834314970557, 5621.241132447068, 5725.59920805548, 5741.425857414225, 5742.856428589319, 5778.393268706809, 5781.046127389018, 5660.886782264414, 5663.377028526858, 5664.830055098354, 5666.46168613981, 5698.62958907678, 5643.80246691372, 5646.20953066571, 5648.548116150698, 5659.801906933238, 5666.320041594952, 4598.103369842848, 4612.677112602153, 4651.697639653412, 4657.650676199299, 4702.835400760957, 4025.8590949317218, 4035.1727895781296, 4040.7171497995446, 4063.79681015948, 4079.673626109904, 4788.970371370172, 4796.2805579163405, 4799.544043315949, 4801.9039619208115, 4843.660943733905, 5521.696306703089, 5612.775488980476, 5672.262605861211, 5682.943170568324, 5750.88498230033, 4838.467768545457, 4850.805967761321, 4852.1508735971765, 4852.854414367504, 4895.31465594817, 5119.098096924665, 5123.718195499283, 5129.179331306973, 5132.0, 5172.508611681884, 5179.507946745053, 5218.765155567932, 5270.920936185884, 5291.9206211906085, 5303.9204411934625, 5657.943420565742, 5671.262735844314, 5701.686407247641, 5711.200431939449, 5718.571107167062, 5242.16125419931, 5245.423003469692, 5246.842594722164, 5249.0, 5250.894982100413, 5422.620416570802, 5514.503694667499, 5529.944700552943, 5555.694436805853, 5618.101103823368, 5625.09998400254, 5654.0, 5664.122061080539, 5706.115552089433, 5715.142728590745, 5465.0, 5468.207109969112, 5468.699221542854, 5469.343678758574, 5473.151661492475, 5321.228421878884, 5396.83809485716, 5467.6719396836315, 5470.452954704498, 5528.530074943675, 5444.12893936984, 5446.482584154499, 5453.15476101205, 5491.066518691752, 5507.7246137693755, 5551.666899986014, 5556.361018482926, 5566.805161819317, 5568.331800184003, 5569.55443564522, 5279.287296215115, 5365.087935050972, 5381.596380271417, 5424.159255315432, 5463.535599474089], "value": 5127.374380384395, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.7284885377154, 635.098160611931, 655.2039272284173, 1023.442223987926, 1031.6028329093306, 24489.142879999203, 30264.243393915163, 31264.21839454015, 31355.529667054983, 31417.21456963577, 32971.34057318852, 33333.833330833375, 33367.332653346915, 33407.0, 33515.0, 4328.718633288826, 4486.259767138435, 6742.898856517144, 6943.861122777542, 6944.375006249436, 6026.909596356037, 6625.933740662604, 6632.403083722464, 6675.866482670343, 6676.132102826626, 6710.597364158141, 6711.362420570038, 6711.5301928865, 6716.6977486013, 6880.862382752367, 6619.437347825441, 6621.834454138637, 6636.900446493307, 6640.833979150511, 6673.265940746514, 6805.6597170141295, 6857.245702972669, 6869.0, 6870.45036397087, 6875.518713690044, 29822.254443638867, 29903.700962990526, 29961.45713043072, 29973.0, 30060.69939300601, 3054.618172728409, 3090.9690903090905, 3092.072378286505, 3092.1032900459063, 3092.149658843836, 23804.642930356058, 23877.0, 23918.0, 23920.0, 23986.0, 2856.757175640073, 2858.0, 2859.9714002859914, 2872.942541149186, 2872.9856350718323, 134432.0, 134584.32707836397, 134597.0, 134650.3267483666, 134746.326268369, 39578.80210598986, 39616.60383396129, 39677.20645587072, 39711.80144099261, 39736.40395394072, 41372.37941430881, 41395.0, 41447.792761036, 41461.170776584906, 41464.585354146075, 11584.47869845842, 11697.824532632018, 11699.415029248503, 11711.121665875093, 11711.355875426763, 8069.677212911418, 8208.220219079178, 9346.626134954526, 9361.812763744687, 9363.25093992479, 10969.561217551209, 11158.163137764537, 11177.385243811506, 11278.943605281922, 11298.20912536131, 4696.976515117402, 4749.64377671676, 4811.927821082687, 4818.180909245437, 4820.758962051954, 877.2455688108222, 895.5566994337714, 904.8054668246359, 927.3601215161517, 928.7492377058156, 19495.76989838807, 19587.706184407245, 20537.691934620994, 21044.89477552633, 21120.894395527925, 931.1479995803899, 974.4153507895348, 987.2990176974429, 994.6717583197527, 998.5356809083811, 10913.508892099875, 11049.613263535737, 11113.83329250062, 11140.944295278472, 11175.608853690082, 152984.0, 155654.0, 155775.0, 156023.21988389984, 156137.0, 37493.250134997696, 37641.435378469345, 37646.811765941, 37671.24657506835, 37700.245995079946, 1191.5253986932555, 1230.864604893461, 1232.0328542094412, 1232.0820988363726, 1233.0875152387348, 19022.7146592804, 19167.71248431247, 19177.61644767069, 19992.50018749543, 20338.288159914333, 28674.713252867205, 28676.283092922844, 28718.282042948256, 28759.424811503235, 28800.42399152047, 110323.44838275758, 110421.0, 110657.44671276915, 111118.0, 111492.0, 21960.23139190121, 22440.0, 27069.0, 27937.0, 28024.159275221777, 31154.0, 31886.52170217495, 32392.67607323991, 32925.83537082299, 33594.664053359156, 25019.374515636526, 25516.362090947874, 25892.22323330303, 26236.817114009944, 27293.044743433886, 25694.614580781676, 25730.485390291717, 26068.34829129287, 26583.544139262547, 27002.32494187661, 27809.304767380978, 27907.0, 29643.0, 31231.219219518785, 31304.373912522078, 26276.4744705101, 26609.467810644066, 27066.32334191661, 27090.593641095005, 27209.0, 20712.48218794482, 21921.232756853435, 22059.889700551394, 22074.22740204085, 22091.0], "value": 13587.005536443068, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.4684433658412, 415.36034506859437, 425.3449687481278, 430.9310510318349, 437.14319932931454, 16784.244708988095, 17175.742363864552, 17474.91262543687, 17490.912545437288, 17520.64958700825, 16362.590935226624, 16628.002319860785, 16752.497425077236, 16819.747703784422, 16999.0, 5306.044911915863, 5308.469153084699, 5472.288602481672, 5479.780808767665, 5486.259354987065, 5406.270153529283, 5492.642978206404, 5501.174823776426, 5502.119660854264, 5503.3395992480955, 5250.133727934905, 5343.7328133593355, 5456.727163641802, 5475.917861232065, 5480.232767412565, 5365.195220716884, 5412.323459567554, 5458.808941687062, 5460.672359658433, 5466.34403871534, 4807.375041244616, 4911.9754401227765, 4970.229614409736, 4977.502249774993, 4986.650934434591, 20102.195912163497, 20243.898780506002, 20365.49086272855, 20392.796072039237, 20535.8973205133, 1657.2790835986384, 1674.9413770517974, 1677.656080503494, 1677.7483377493475, 1679.8656107511492, 13859.0, 14331.498397556139, 14397.712045759132, 14513.129212247299, 14545.418183272763, 2007.9397618071482, 2045.1001559314002, 2100.096958307927, 2103.5582527669208, 2106.104905415192, 71683.64158179228, 72064.91902621517, 72172.0, 72588.0, 72970.27029729688, 10552.103071238877, 10743.462826858626, 10769.0, 10955.178361622751, 10982.176336774774, 15238.0, 15259.313330900137, 15266.618334541503, 15280.770788438182, 15291.311890964933, 7071.328223818729, 7193.0, 7265.09186351706, 7397.371223446067, 7455.030845990095, 6452.516061295421, 6566.212054553389, 6732.124823772878, 6740.764073257413, 6769.765977227503, 6621.503387245976, 6809.931900681029, 6813.931860681429, 6849.0, 6862.176538815374, 2054.907529161191, 2066.225165562914, 2070.171931227521, 2092.61286661968, 2101.53766171442, 858.793889466536, 859.4113032572708, 869.2654706772767, 892.2727976698969, 898.4160295807646, 16143.838561614233, 16361.0, 16395.918020409823, 16562.751558726628, 17119.828801712072, 875.3434923807145, 879.2921698033017, 893.1515060692368, 894.0612357025097, 907.8774365460711, 8747.387682862138, 8829.911700883038, 8994.28045756338, 10684.893151068545, 11445.370504622326, 315488.0, 323091.0, 323177.0, 323212.0, 324902.0, 71974.64012679903, 72447.0, 73299.63350183216, 73339.63330183421, 74646.0, 1081.929674571166, 1111.6553868300853, 1112.1769890281296, 1125.1617544928918, 1128.7798879218637, 16612.58468538296, 16622.916885415496, 17034.14829258557, 17344.0, 17387.0, 36617.45073823842, 37757.56060984754, 38501.6149838498, 38841.805790970866, 40128.79935600303, 45482.54517454783, 45514.31728524141, 45633.771831140635, 46049.0, 46639.53360466487, 7828.686852525835, 7943.642536086006, 7945.324647405036, 8011.759647210593, 8341.624626891926, 11812.0, 11954.282743035446, 12102.0, 12177.269363838199, 12482.251064936132, 9540.284478663989, 9625.71122866315, 10097.646582369582, 10188.490575471345, 10632.956608884635, 9546.904530954602, 9642.903570964201, 10101.49492525356, 10178.0, 10197.74505637365, 9959.502024898871, 10103.54534045955, 10186.898131018595, 10296.948515257676, 10718.678439646823, 7945.880811787712, 7980.441369104339, 8190.600900626174, 8202.58987050657, 8241.670333186605, 10377.221708371751, 10382.792344152924, 10514.684559463229, 10561.0, 10793.838092428778], "value": 8553.501460279238, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1078.320657985469, 1200.471792411339, 1273.8025606031063, 1280.3726174174653, 1286.665466978586, 8304.335653147742, 9849.162821160202, 10235.385876847386, 10236.641717539887, 10253.743656408593, 10012.199024078074, 10106.747331316721, 10120.240981926367, 10120.291579589431, 10128.848067278997, 1816.6094289727705, 2082.4273324835676, 2119.448943274752, 2119.682047692843, 2122.7877212278727, 1813.918373673188, 2197.165077270643, 2265.3996690876847, 2267.5124848157643, 2272.6931864198286, 2232.854864433815, 2261.7172853393326, 2263.5586060718165, 2267.7958983691547, 2270.421042634126, 2155.3210738617286, 2158.4927542027613, 2158.967615485769, 2163.9567208655894, 2165.1231251343233, 2143.3141394753684, 2163.7511686156136, 2222.533268013719, 2223.321886824518, 2224.7552769195377, 9830.803383932353, 9831.950840245825, 9919.156871665917, 9935.453550054744, 9944.453055081967, 5145.562627176694, 5332.520073193431, 5337.813176538842, 5338.866528336784, 5345.786168553253, 3199.1842080269384, 3401.5918089829133, 3404.642512536173, 3456.1186897341267, 3457.619661837196, 922.6171138977317, 943.6697155995415, 997.8952210017916, 1002.0580654185043, 1002.5037606384814, 14914.925425372912, 14933.328000240015, 14934.850651493454, 14953.0, 14964.176970266632, 5020.949790502122, 5104.591632669451, 5185.34753285053, 5205.2192171173865, 5308.177232528887, 12369.62891113268, 12404.503819847285, 12406.503739850305, 12408.317542535067, 12412.56556020535, 5541.113421852484, 5665.0, 5669.659820410789, 5674.205611214434, 5675.0068737971515, 4990.800367985313, 5097.8725531862, 5097.923531147036, 5105.387353517527, 5121.948780512147, 3728.8508459661853, 3791.677707394847, 3824.2542704172974, 3827.4641550182996, 3901.6098390160755, 1089.3082892363407, 1100.1583788401879, 1105.209775010855, 1105.7677887643524, 1134.2230572058002, 655.1057806094647, 674.8987651852261, 675.8006388115517, 691.3708525242106, 698.2563569798149, 4982.153033984159, 4997.175466048061, 5024.924825925768, 5196.740162991835, 5266.157414813688, 532.5526557691558, 799.9920000800034, 806.1253539909147, 809.7368355284556, 824.1881746479713, 3649.8357573908706, 3761.887143385703, 3762.887113386603, 3764.265968136187, 3895.3183192941688, 12472.812907806208, 12758.298293593942, 13113.147645403018, 13153.408096635674, 13222.933885330704, 12813.551525696555, 12876.613701588967, 13054.151480153949, 13095.934520327337, 13225.603231903058, 7206.135263768381, 7256.492045556866, 7348.191698913115, 7348.81627959316, 7352.411807055422, 5360.2227676987395, 5371.5971302153275, 5482.945170548243, 5497.972510137423, 5583.804566840141, 11121.944390277997, 11642.24325418845, 11672.0, 11704.824427633423, 11743.706407339885, 11822.995045421236, 11996.460159293027, 12024.579139730067, 12036.398180091135, 12060.095492837896, 7233.348998590152, 7439.40484761207, 7453.217412171643, 7455.664495097625, 7460.589667568336, 9138.13187747163, 9268.397554158959, 9435.339526233098, 9436.480993545421, 9439.905600944177, 8045.557494337868, 8085.555294458626, 8086.676532938616, 8151.103378628465, 8159.3880458967005, 7764.456488045783, 7915.0, 7944.523328600302, 8056.234657707509, 8166.550839703873, 7099.503034787722, 7233.348998590152, 7242.275772422716, 7256.818579535343, 7258.237885022208, 4853.708777473363, 4877.219644856806, 4946.134426475424, 5061.924071139009, 5152.145227718093, 5102.10713125209, 5201.375834899836, 5296.0, 5316.6012549058205, 5329.589062999761], "value": 4627.032923534693, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.44983002960146, 359.64035964035963, 377.7525720652972, 382.8124219132624, 386.8761996161226, 5096.159133742933, 5200.947990520093, 5352.973235133819, 5359.5444387227035, 5365.329333833266, 5189.143791274445, 5265.86835329117, 5269.525742683158, 5286.577073834093, 5300.469953004697, 4169.62473377396, 4175.895602609929, 4178.7283826551175, 4179.561146079664, 4191.2665283575325, 3960.584138665442, 4073.450084238634, 4177.895552611194, 4200.096979149483, 4200.600942910419, 4061.9593804062024, 4158.937615935748, 4179.373094035904, 4180.017695841475, 4193.916121677565, 4170.70805043647, 4180.853670121546, 4182.769947652878, 4186.120914607936, 4201.684873634459, 3574.6782789548806, 3591.712662986955, 3815.7328986970924, 3822.140018495844, 3824.5410550733814, 5143.04853602081, 5148.176291793295, 5156.226566015091, 5163.612729045337, 5191.922121168185, 4905.166121759309, 4908.0, 4925.285833554115, 4929.827456039057, 4930.580900623451, 5463.371712253102, 5515.7242137892945, 5588.497035266805, 5619.887602247933, 5624.409437009096, 4254.149170165979, 4260.21186080573, 4262.87211383659, 4272.060146767737, 4273.29490634045, 5872.941270587325, 5887.499562537189, 5889.499392551638, 5897.380775018604, 5898.705064746746, 4329.264025115738, 4352.455943007124, 4373.846915358011, 4378.365137055109, 4396.956030439655, 4182.749035057906, 4403.9779801100785, 4414.161309351213, 4424.6681498887065, 4436.800343984529, 4741.534402110952, 4762.285657151455, 4878.07316609843, 4878.463369029404, 4884.975575122102, 5571.192177134293, 5598.076317407582, 5599.412061733541, 5599.944000560024, 5605.5515558755205, 1321.187469706124, 1370.6025252676811, 1529.8393668664853, 1550.139672481761, 1554.1918202534619, 909.4997751236793, 924.7503174142944, 928.6471140966389, 929.4887811703536, 931.2782593490099, 4827.589654879304, 4882.170031094723, 4890.486498917634, 4891.779869905863, 4914.483979182206, 5793.565482588822, 5798.9130163047585, 5802.65184088956, 5821.970890145522, 5835.766569337264, 4739.881502962385, 4855.393075865517, 4858.562729354375, 4863.756812159449, 4870.683405578697, 3025.1529571719952, 3043.695630436983, 3044.4367791958557, 3046.207985923676, 3064.739497142768, 5326.174442961347, 5340.332458442695, 5351.25082488452, 5353.411124776271, 5375.543078838343, 5667.574931880125, 5924.970375148183, 5958.731857066442, 5974.402559744078, 5983.910241346383, 5423.48142520095, 5444.482774136451, 5446.2375267462585, 5454.809081682122, 5470.91793623096, 5668.404817494269, 5846.064629659234, 5861.32594751609, 5861.479563787442, 5877.177195192762, 5753.510951569164, 5782.959067367914, 5789.45000224978, 5805.82582522525, 5806.129080637938, 5421.05131601976, 5450.781968721207, 5462.8361149165585, 5466.781328746805, 5475.507204351468, 3800.714946379088, 3894.6300101490315, 3920.3727403615285, 3934.252492026506, 3938.2123575284486, 5542.0, 5629.240052593012, 5682.715864206856, 5825.79609713658, 5839.941600583939, 5590.580706446952, 5603.635763675348, 5605.103183490622, 5632.887342253214, 5640.830775076754, 5500.50495455395, 5567.4432556744005, 5604.8318550443555, 5623.8875222496135, 5635.351934527582, 5501.394846566955, 5551.944480555143, 5555.22226888244, 5555.555555555627, 5562.860928476821, 5603.7758489659955, 5607.0, 5621.634593751393, 5625.296837895263, 5627.380988091389, 5390.326209223847, 5442.455754424526, 5505.724713764376, 5505.9724701376235, 5508.724563771715], "value": 4257.2153761576965, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.5256825358754, 706.7738323736403, 711.2709472790389, 727.7671145233525, 739.1536690489392, 13017.544385946494, 13900.791488127687, 13910.304484775772, 13911.304434778245, 13915.025948183618, 12967.870321296808, 14888.851111488882, 15086.849131508681, 15204.315805788738, 15235.847641523582, 872.2498651159997, 887.414306557672, 891.189017993626, 891.2914233184633, 891.79488717595, 905.6603773584906, 907.9546022698871, 908.3232991421401, 908.5457271364318, 908.5684299957501, 954.9283803714715, 959.5681943125586, 959.788846453779, 960.1550635440802, 960.3853533738413, 884.5886662701843, 904.0597778310549, 916.6562539047857, 952.2334520710825, 952.6141912525438, 671.6171782084214, 671.8219671786932, 671.8454755406235, 672.2336536348566, 673.9090222819906, 13588.0, 13763.587092387244, 13807.585772426843, 13825.51610693631, 13877.791833122512, 15457.458988935447, 15712.21438928049, 15986.680266394724, 16102.114383708891, 16103.677926441405, 11782.116341274439, 12030.578929737418, 12034.63896083119, 12045.337506437143, 12065.396730163544, 2723.550614148663, 2724.741149590786, 2732.617433559303, 2752.779777617786, 2753.7796976241852, 68654.65672671655, 70426.0, 71466.285337147, 72235.63882180607, 72960.0, 12293.016558675285, 12345.506179752709, 12461.626151215478, 12702.11085224044, 12727.0, 22193.22323718662, 22484.100635974377, 22675.773242267365, 22703.091876325092, 22709.0, 6244.313125556185, 6282.120503129566, 6293.465055470337, 6300.086487459384, 6307.621542707452, 2989.491786396318, 2994.685558016377, 3063.6323641163203, 3067.4018566379787, 3067.601211842491, 3519.1729943463265, 3641.7450778445254, 3645.671889529955, 3648.9635103648625, 3655.1775850433974, 711.8291610013663, 714.17156098925, 719.6725489902082, 720.7909706185252, 723.2767232767233, 555.7026990560031, 556.9582281328917, 558.804418453538, 560.7476635514035, 562.971851407428, 8914.509701966324, 9035.864462033074, 9177.21993630549, 9194.678186263449, 9767.316287859781, 580.5935844908581, 584.243404790797, 586.1003359842621, 586.6978506069378, 605.4339192854695, 4420.955790442054, 4466.553344665507, 4472.843450479218, 4485.551444855553, 4494.662900282492, 62610.373896261364, 63760.36239637637, 63824.36175638277, 64624.35375646183, 64800.0, 54555.0, 55370.33888983337, 55408.72295638496, 55414.16878746822, 57540.424595754346, 36510.63489365125, 50902.745486273074, 53795.19307210317, 54084.72957635108, 54651.9011074171, 9195.862062069207, 10199.439030853078, 10311.587536498457, 10398.324108932895, 10640.52117654692, 26517.60223596686, 26586.867065664548, 26587.734122658527, 27453.862730686218, 27936.580951286152, 31500.68499315069, 31568.684313156573, 31587.684123158473, 31944.52083218707, 32631.836840815646, 12671.619851404472, 12756.74486510246, 12789.0, 12876.935615321863, 12910.935445322713, 15206.315715793036, 15227.923860380628, 15234.238288085773, 15410.92294538565, 15483.5354939352, 13610.863891361356, 13733.244671543162, 13795.310234488436, 13931.860681393056, 14026.579202623938, 13642.93178534101, 13741.381637826122, 13749.656258593615, 13807.51673691416, 13852.238126902714, 13367.866321336662, 13380.464781408635, 13401.128926619738, 13420.0, 13460.93269533646, 9638.243278789347, 9674.22606191489, 9772.9022709772, 9992.15066719337, 10094.24293178, 10254.179665626583, 10319.535620897228, 10565.260431769702, 10634.09610183112, 10847.728806779895], "value": 6698.225228255293, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1522.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 111.0, 112.0, 112.0, 111.0, 110.0, 111.0, 113.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 128.0, 129.0, 178.0, 141.0, 126.0, 128.0, 125.0, 148.0, 123.0], "value": 137.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 160.0, 161.0, 162.0, 163.0, 165.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 74.0, 106.0, 76.0, 75.0, 75.0, 75.0, 98.0, 77.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 113.0, 84.0, 83.0, 83.0, 101.0, 84.0, 83.0, 107.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0, 114.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 149.0, 149.0, 149.0, 150.0, 150.0, 148.0, 149.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 93.0, 93.0, 94.0, 93.0, 93.0, 93.0, 93.0], "value": 93.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 55.0, 54.0, 54.0, 54.0, 54.0, 55.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 56.0, 55.0, 55.0, 56.0, 55.0, 56.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 79.0, 81.0, 80.0, 82.0, 81.0, 80.0, 81.0, 81.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 130.0, 132.0, 131.0, 137.0, 128.0, 133.0, 131.0, 185.0, 130.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 191.0, 190.0, 196.0, 191.0, 188.0, 178.0, 189.0, 188.0, 181.0], "value": 187.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 69.0, 72.0, 71.0, 70.0, 69.0, 70.0, 70.0, 70.0, 70.0], "value": 70.4, "unit": "score"}]}]} 10:54:42 INFO - Return code: 0 10:54:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:54:42 INFO - # TBPL SUCCESS # 10:54:42 INFO - Running post-action listener: _resource_record_post_action 10:54:42 INFO - [mozharness: 2017-05-09 17:54:42.539632Z] Finished run-tests step (success) 10:54:42 INFO - Running post-run listener: _resource_record_post_run 10:54:42 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 359862272; Read time: 12; Write time: 239588 10:54:42 INFO - TinderboxPrint: CPU usage
12.9% 10:54:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:54:42 INFO - TinderboxPrint: I/O write bytes / time
359,862,272 / 239,588 10:54:42 INFO - TinderboxPrint: CPU idle
8,341.4 (87.1%) 10:54:42 INFO - TinderboxPrint: CPU user
1,195.5 (12.5%) 10:54:42 INFO - TinderboxPrint: Swap in / out
0 / 0 10:54:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106475520; Read time: 0; Write time: 97516 10:54:42 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 253386752; Read time: 0; Write time: 142072 10:54:43 INFO - Running post-run listener: _upload_blobber_files 10:54:43 INFO - Blob upload gear active. 10:54:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:54:43 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 10:54:43 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'] 10:54:43 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 10:54:43 INFO - (blobuploader) - INFO - Open directory for files ... 10:54:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:54:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:54:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:54:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:54:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:54:44 INFO - (blobuploader) - INFO - Done attempting. 10:54:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:54:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:54:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:54:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:54:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:54:45 INFO - (blobuploader) - INFO - Done attempting. 10:54:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:54:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:54:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:54:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:54:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:54:48 INFO - (blobuploader) - INFO - Done attempting. 10:54:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:54:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:54:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:54:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:54:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:54:50 INFO - (blobuploader) - INFO - Done attempting. 10:54:50 INFO - (blobuploader) - INFO - Iteration through files over. 10:54:50 INFO - Return code: 0 10:54:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:54:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:54:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ecb2e84a4dc79690b7892d37b98f6bd29f298ec548dc896669e2b50aef4347643d10e59af5029138cb75c7184a3229df8164d7044e03c7d267e3cb571c0fcf7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f32fe9782a530a6bf6b66f5561f4196e45a786c1c9f7aeb35ddb1f29fbe5a5f9aca07ad6e4f24fa13e839c0de0590214ddbd3824f934ac106bf187fc33ff1380", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c751ab26a1d1c71c04251db1e723cc237b2b6fef31996284a11a363dbeee15902c55f774887cbd3829896f28fc336c897beaf4ac8412f7e6ef0144643d0aadb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d9eee45d00d53f7186aa9058023ffd26aee2383da01bca490eadd0ab6b23344f187ab80a70691efb8d0af9421aaf08a5559b35ccc751ccb7676c104eec23195"} 10:54:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:54:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:54:50 INFO - Contents: 10:54:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ecb2e84a4dc79690b7892d37b98f6bd29f298ec548dc896669e2b50aef4347643d10e59af5029138cb75c7184a3229df8164d7044e03c7d267e3cb571c0fcf7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f32fe9782a530a6bf6b66f5561f4196e45a786c1c9f7aeb35ddb1f29fbe5a5f9aca07ad6e4f24fa13e839c0de0590214ddbd3824f934ac106bf187fc33ff1380", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c751ab26a1d1c71c04251db1e723cc237b2b6fef31996284a11a363dbeee15902c55f774887cbd3829896f28fc336c897beaf4ac8412f7e6ef0144643d0aadb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d9eee45d00d53f7186aa9058023ffd26aee2383da01bca490eadd0ab6b23344f187ab80a70691efb8d0af9421aaf08a5559b35ccc751ccb7676c104eec23195"} 10:54:50 INFO - Running post-run listener: copy_logs_to_upload_dir 10:54:50 INFO - Copying logs to upload dir... 10:54:50 INFO - mkdir: /builds/slave/test/build/upload/logs 10:54:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.318625 ========= master_lag: 0.23 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-05-09 10:54:50.502535) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-09 10:54:50.505801) ========= 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=62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ecb2e84a4dc79690b7892d37b98f6bd29f298ec548dc896669e2b50aef4347643d10e59af5029138cb75c7184a3229df8164d7044e03c7d267e3cb571c0fcf7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f32fe9782a530a6bf6b66f5561f4196e45a786c1c9f7aeb35ddb1f29fbe5a5f9aca07ad6e4f24fa13e839c0de0590214ddbd3824f934ac106bf187fc33ff1380", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c751ab26a1d1c71c04251db1e723cc237b2b6fef31996284a11a363dbeee15902c55f774887cbd3829896f28fc336c897beaf4ac8412f7e6ef0144643d0aadb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d9eee45d00d53f7186aa9058023ffd26aee2383da01bca490eadd0ab6b23344f187ab80a70691efb8d0af9421aaf08a5559b35ccc751ccb7676c104eec23195"} build_url:https://queue.taskcluster.net/v1/task/FRvYA01qRpywlEklhoWTpA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011199 build_url: 'https://queue.taskcluster.net/v1/task/FRvYA01qRpywlEklhoWTpA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ecb2e84a4dc79690b7892d37b98f6bd29f298ec548dc896669e2b50aef4347643d10e59af5029138cb75c7184a3229df8164d7044e03c7d267e3cb571c0fcf7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f32fe9782a530a6bf6b66f5561f4196e45a786c1c9f7aeb35ddb1f29fbe5a5f9aca07ad6e4f24fa13e839c0de0590214ddbd3824f934ac106bf187fc33ff1380", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c751ab26a1d1c71c04251db1e723cc237b2b6fef31996284a11a363dbeee15902c55f774887cbd3829896f28fc336c897beaf4ac8412f7e6ef0144643d0aadb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d9eee45d00d53f7186aa9058023ffd26aee2383da01bca490eadd0ab6b23344f187ab80a70691efb8d0af9421aaf08a5559b35ccc751ccb7676c104eec23195"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-09 10:54:50.530898) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 10:54:50.531230) ========= 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=62c568580acbfdaac3eec7be000001dc-1494350499.618174-1809224279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004422 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 10:54:50.580206) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-09 10:54:50.580525) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-09 10:54:50.580823) ========= ========= Total master_lag: 0.36 =========