builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1491216068.44 results: success (0) revision: aaa0cd3bd620daf6be29c72625f6e63fd0bc1d46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 03:41:08.436698) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 03:41:08.437255) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 03:41:08.437599) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 03:41:08.460349) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 03:41:08.460876) ========= 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=4300f881736b422476174874000001bc-1491215954.457309-663485225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-03 03:41:09-- 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% 28.5M=0s 2017-04-03 03:41:09 (28.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.079451 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 03:41:08.560365) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 03:41:08.561207) ========= 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=4300f881736b422476174874000001bc-1491215954.457309-663485225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018916 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 03:41:08.616806) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-03 03:41:08.617602) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev aaa0cd3bd620daf6be29c72625f6e63fd0bc1d46 --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 aaa0cd3bd620daf6be29c72625f6e63fd0bc1d46 --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=4300f881736b422476174874000001bc-1491215954.457309-663485225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-03 03:41:09,699 truncating revision to first 12 chars 2017-04-03 03:41:09,699 Setting DEBUG logging. 2017-04-03 03:41:09,699 attempt 1/10 2017-04-03 03:41:09,699 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/aaa0cd3bd620?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-03 03:41:10,874 unpacking tar archive at: mozilla-central-aaa0cd3bd620/testing/mozharness/ program finished with exit code 0 elapsedTime=1.487918 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-03 03:41:10.120513) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 03:41:10.120890) ========= script_repo_revision: aaa0cd3bd620daf6be29c72625f6e63fd0bc1d46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 03:41:10.121339) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 03:41:10.121656) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 03:41:10.132611) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-04-03 03:41:10.132990) ========= /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=4300f881736b422476174874000001bc-1491215954.457309-663485225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:41:11 INFO - MultiFileLogger online at 20170403 03:41:11 in /builds/slave/test 03:41:11 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 03:41:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:41:11 INFO - {'append_to_log': False, 03:41:11 INFO - 'base_work_dir': '/builds/slave/test', 03:41:11 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:41:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:41:11 INFO - 'branch': 'Firefox-Non-PGO', 03:41:11 INFO - 'buildbot_json_path': 'buildprops.json', 03:41:11 INFO - 'config_files': ('talos/linux_config.py',), 03:41:11 INFO - 'default_actions': ('clobber', 03:41:11 INFO - 'read-buildbot-config', 03:41:11 INFO - 'download-and-extract', 03:41:11 INFO - 'populate-webroot', 03:41:11 INFO - 'create-virtualenv', 03:41:11 INFO - 'install', 03:41:11 INFO - 'run-tests'), 03:41:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:41:11 INFO - 'download_minidump_stackwalk': True, 03:41:11 INFO - 'download_symbols': 'ondemand', 03:41:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:41:11 INFO - 'tooltool.py': '/tools/tooltool.py', 03:41:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:41:11 INFO - '/tools/misc-python/virtualenv.py')}, 03:41:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:41:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:41:11 INFO - 'gecko_profile': False, 03:41:11 INFO - 'gecko_profile_interval': 0, 03:41:11 INFO - 'installer_path': 'installer.exe', 03:41:11 INFO - 'log_level': 'info', 03:41:11 INFO - 'log_name': 'talos', 03:41:11 INFO - 'log_to_console': True, 03:41:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:41:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:41:11 INFO - 'opt_config_files': (), 03:41:11 INFO - 'pip_index': False, 03:41:11 INFO - 'suite': 'dromaeojs', 03:41:11 INFO - 'system_bits': '32', 03:41:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:41:11 INFO - 'title': 'talos-linux64-ix-045', 03:41:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:41:11 INFO - 'use_talos_json': True, 03:41:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:41:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:41:11 INFO - 'work_dir': 'build'} 03:41:11 INFO - [mozharness: 2017-04-03 10:41:11.313471Z] Running clobber step. 03:41:11 INFO - Running pre-action listener: _resource_record_pre_action 03:41:11 INFO - Running main action method: clobber 03:41:11 INFO - rmtree: /builds/slave/test/build 03:41:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:41:12 INFO - Running post-action listener: _resource_record_post_action 03:41:12 INFO - [mozharness: 2017-04-03 10:41:12.265640Z] Finished clobber step (success) 03:41:12 INFO - [mozharness: 2017-04-03 10:41:12.265740Z] Running read-buildbot-config step. 03:41:12 INFO - Running pre-action listener: _resource_record_pre_action 03:41:12 INFO - Running main action method: read_buildbot_config 03:41:12 INFO - Using buildbot properties: 03:41:12 INFO - { 03:41:12 INFO - "project": "", 03:41:12 INFO - "product": "firefox", 03:41:12 INFO - "who": "cbook@mozilla.com", 03:41:12 INFO - "installer_path": "public/build/target.tar.bz2", 03:41:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 03:41:12 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 03:41:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 03:41:12 INFO - "stage_platform": "linux64", 03:41:12 INFO - "basedir": "/builds/slave/test", 03:41:12 INFO - "buildnumber": 1049, 03:41:12 INFO - "platform": "ubuntu64_hw", 03:41:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:41:12 INFO - "slavebuilddir": "test", 03:41:12 INFO - "taskId": "DE6jWjBzRpinbzy63WaIvA", 03:41:12 INFO - "branch": "mozilla-central", 03:41:12 INFO - "script_repo_revision": "production", 03:41:12 INFO - "revision": "aaa0cd3bd620daf6be29c72625f6e63fd0bc1d46", 03:41:12 INFO - "slavename": "talos-linux64-ix-045", 03:41:12 INFO - "repo_path": "mozilla-central" 03:41:12 INFO - } 03:41:12 INFO - Finding installer, test and symbols from parent task. 03:41:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DE6jWjBzRpinbzy63WaIvA'}, attempt #1 03:41:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DE6jWjBzRpinbzy63WaIvA'}, attempt #1 03:41:13 INFO - Task dependencies: KJ-UiFRtRM6KsF05QxFqMA 03:41:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KJ-UiFRtRM6KsF05QxFqMA'}, attempt #1 03:41:13 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/KJ-UiFRtRM6KsF05QxFqMA/artifacts/public/build/target.tar.bz2 03:41:13 INFO - Set test_url: https://queue.taskcluster.net/v1/task/KJ-UiFRtRM6KsF05QxFqMA/artifacts/public/build/test_packages.json 03:41:13 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/KJ-UiFRtRM6KsF05QxFqMA/artifacts/public/build/target.crashreporter-symbols.zip 03:41:13 INFO - Running post-action listener: _resource_record_post_action 03:41:13 INFO - [mozharness: 2017-04-03 10:41:13.743357Z] Finished read-buildbot-config step (success) 03:41:13 INFO - [mozharness: 2017-04-03 10:41:13.743575Z] Running download-and-extract step. 03:41:13 INFO - Running pre-action listener: _resource_record_pre_action 03:41:13 INFO - Running main action method: download_and_extract 03:41:13 INFO - mkdir: /builds/slave/test/build/tests 03:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:13 INFO - trying https://queue.taskcluster.net/v1/task/KJ-UiFRtRM6KsF05QxFqMA/artifacts/public/build/target.test_packages.json 03:41:13 INFO - Downloading https://queue.taskcluster.net/v1/task/KJ-UiFRtRM6KsF05QxFqMA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:41:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KJ-UiFRtRM6KsF05QxFqMA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:41:14 INFO - Downloaded 986 bytes. 03:41:14 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:41:14 INFO - Using the following test package requirements: 03:41:14 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:41:14 INFO - u'common': [u'target.common.tests.zip'], 03:41:14 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:41:14 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:41:14 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:41:14 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:41:14 INFO - u'mozbase': [u'target.common.tests.zip'], 03:41:14 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:41:14 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:41:14 INFO - u'web-platform': [u'target.common.tests.zip', 03:41:14 INFO - u'target.web-platform.tests.zip'], 03:41:14 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:41:14 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:41:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KJ-UiFRtRM6KsF05QxFqMA/artifacts/public/build/target.common.tests.zip 03:41:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KJ-UiFRtRM6KsF05QxFqMA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:41:14 INFO - Fetch https://queue.taskcluster.net/v1/task/KJ-UiFRtRM6KsF05QxFqMA/artifacts/public/build/target.common.tests.zip into memory 03:41:15 INFO - Expected file size: 58235484 03:41:15 INFO - Obtained file size: 58235484 03:41:25 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:41:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KJ-UiFRtRM6KsF05QxFqMA/artifacts/public/build/target.common.tests.zip 03:41:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KJ-UiFRtRM6KsF05QxFqMA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:41:25 INFO - Fetch https://queue.taskcluster.net/v1/task/KJ-UiFRtRM6KsF05QxFqMA/artifacts/public/build/target.common.tests.zip into memory 03:41:26 INFO - Expected file size: 58235484 03:41:26 INFO - Obtained file size: 58235484 03:41:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KJ-UiFRtRM6KsF05QxFqMA/artifacts/public/build/target.talos.tests.zip 03:41:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KJ-UiFRtRM6KsF05QxFqMA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:41:37 INFO - Fetch https://queue.taskcluster.net/v1/task/KJ-UiFRtRM6KsF05QxFqMA/artifacts/public/build/target.talos.tests.zip into memory 03:41:38 INFO - Expected file size: 14404152 03:41:38 INFO - Obtained file size: 14404152 03:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:39 INFO - trying https://queue.taskcluster.net/v1/task/KJ-UiFRtRM6KsF05QxFqMA/artifacts/public/build/target.tar.bz2 03:41:39 INFO - Downloading https://queue.taskcluster.net/v1/task/KJ-UiFRtRM6KsF05QxFqMA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:41:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KJ-UiFRtRM6KsF05QxFqMA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:41:41 INFO - Downloaded 62526854 bytes. 03:41:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KJ-UiFRtRM6KsF05QxFqMA/artifacts/public/build/target.tar.bz2 03:41:41 INFO - mkdir: /builds/slave/test/properties 03:41:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:41:41 INFO - Writing to file /builds/slave/test/properties/build_url 03:41:41 INFO - Contents: 03:41:41 INFO - build_url:https://queue.taskcluster.net/v1/task/KJ-UiFRtRM6KsF05QxFqMA/artifacts/public/build/target.tar.bz2 03:41:41 INFO - Running post-action listener: _resource_record_post_action 03:41:41 INFO - Running post-action listener: set_extra_try_arguments 03:41:41 INFO - [mozharness: 2017-04-03 10:41:41.179051Z] Finished download-and-extract step (success) 03:41:41 INFO - [mozharness: 2017-04-03 10:41:41.179162Z] Running populate-webroot step. 03:41:41 INFO - Running pre-action listener: _resource_record_pre_action 03:41:41 INFO - Running main action method: populate_webroot 03:41:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:41:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:41:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:41:41 INFO - '--tppagecycles', 03:41:41 INFO - '7'], 03:41:41 INFO - 'tests': ['tsvgm']}}, 03:41:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:41:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:41:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:41:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:41:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:41:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:41:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:41:41 INFO - 'talos_options': ['--disable-e10s'], 03:41:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:41:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:41:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:41:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:41:41 INFO - 'talos_options': ['--disable-e10s'], 03:41:41 INFO - 'tests': ['damp', 'tps']}, 03:41:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:41:41 INFO - 'tests': ['damp', 'tps']}, 03:41:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:41:41 INFO - 'tests': ['dromaeo_dom']}, 03:41:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:41:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:41:41 INFO - 'tests': ['basic_compositor_video']}, 03:41:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:41:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:41:41 INFO - 'tests': ['a11yr', 03:41:41 INFO - 'ts_paint', 03:41:41 INFO - 'tpaint', 03:41:41 INFO - 'sessionrestore', 03:41:41 INFO - 'sessionrestore_no_auto_restore', 03:41:41 INFO - 'tabpaint']}, 03:41:41 INFO - 'other-e10s': {'tests': ['a11yr', 03:41:41 INFO - 'ts_paint', 03:41:41 INFO - 'tpaint', 03:41:41 INFO - 'sessionrestore', 03:41:41 INFO - 'sessionrestore_no_auto_restore', 03:41:41 INFO - 'tabpaint']}, 03:41:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:41:41 INFO - 'ts_paint', 03:41:41 INFO - 'tpaint', 03:41:41 INFO - 'sessionrestore', 03:41:41 INFO - 'sessionrestore_no_auto_restore', 03:41:41 INFO - 'tabpaint']}, 03:41:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:41:41 INFO - 'ts_paint', 03:41:41 INFO - 'tpaint', 03:41:41 INFO - 'sessionrestore', 03:41:41 INFO - 'sessionrestore_no_auto_restore', 03:41:41 INFO - 'tabpaint']}, 03:41:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:41:41 INFO - 'tests': ['a11yr', 03:41:41 INFO - 'ts_paint', 03:41:41 INFO - 'tpaint', 03:41:41 INFO - 'sessionrestore', 03:41:41 INFO - 'sessionrestore_no_auto_restore', 03:41:41 INFO - 'tabpaint']}, 03:41:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:41:41 INFO - 'tests': ['a11yr', 03:41:41 INFO - 'ts_paint', 03:41:41 INFO - 'tpaint', 03:41:41 INFO - 'sessionrestore', 03:41:41 INFO - 'sessionrestore_no_auto_restore', 03:41:41 INFO - 'tabpaint']}, 03:41:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:41:41 INFO - 'tests': ['tsvgx', 03:41:41 INFO - 'tsvgr_opacity', 03:41:41 INFO - 'tart', 03:41:41 INFO - 'tscrollx', 03:41:41 INFO - 'cart', 03:41:41 INFO - 'tsvg_static']}, 03:41:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:41:41 INFO - 'tsvgr_opacity', 03:41:41 INFO - 'tart', 03:41:41 INFO - 'tscrollx', 03:41:41 INFO - 'cart', 03:41:41 INFO - 'tsvg_static']}, 03:41:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:41:41 INFO - 'talos_options': ['--disable-e10s'], 03:41:41 INFO - 'tests': ['tp5o']}, 03:41:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:41:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:41:41 INFO - 'talos_options': ['--disable-e10s', 03:41:41 INFO - '--xperf_path', 03:41:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:41:41 INFO - 'tests': ['tp5n']}, 03:41:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:41:41 INFO - 'talos_options': ['--xperf_path', 03:41:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:41:41 INFO - 'tests': ['tp5n']}}, 03:41:41 INFO - 'talos.zip': {'path': '', 03:41:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:41:41 INFO - Running post-action listener: _resource_record_post_action 03:41:41 INFO - [mozharness: 2017-04-03 10:41:41.194073Z] Finished populate-webroot step (success) 03:41:41 INFO - [mozharness: 2017-04-03 10:41:41.194162Z] Running create-virtualenv step. 03:41:41 INFO - Running pre-action listener: _resource_record_pre_action 03:41:41 INFO - Running main action method: create_virtualenv 03:41:41 INFO - Creating virtualenv /builds/slave/test/build/venv 03:41:41 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 03:41:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:41:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:41:41 INFO - Using real prefix '/usr' 03:41:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:41:41 INFO - Installing distribute.............................................................................................................................................................................................done. 03:41:43 INFO - Installing pip.................done. 03:41:43 INFO - Return code: 0 03:41:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:41:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:41:43 INFO - Reading from file tmpfile_stdout 03:41:43 INFO - Output received: 03:41:43 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) 03:41:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:41:43 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')]} 03:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:43 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')]} 03:41:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:44 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 0x27c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a61290>, '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 0x2a61b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62040>, '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': '4300f881736b422476174874000001bc-1491215954.457309-663485225', '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 03:41:44 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 03:41:44 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 03:41:44 INFO - Using env: {'DISPLAY': ':0', 03:41:44 INFO - 'HOME': '/home/cltbld', 03:41:44 INFO - 'LANG': 'en_US.UTF-8', 03:41:44 INFO - 'LANGUAGE': 'en_US:en', 03:41:44 INFO - 'LOGNAME': 'cltbld', 03:41:44 INFO - 'MAIL': '/var/mail/cltbld', 03:41:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:44 INFO - 'MOZ_NO_REMOTE': '1', 03:41:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:44 INFO - 'NO_EM_RESTART': '1', 03:41:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:44 INFO - 'PWD': '/builds/slave/test', 03:41:44 INFO - 'SHELL': '/bin/bash', 03:41:44 INFO - 'SHLVL': '1', 03:41:44 INFO - 'TERM': 'linux', 03:41:44 INFO - 'TMOUT': '86400', 03:41:44 INFO - 'USER': 'cltbld', 03:41:44 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1491215954.457309-663485225', 03:41:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:44 INFO - '_': '/tools/buildbot/bin/python'} 03:41:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:44 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 03:41:44 INFO - Cleaning up... 03:41:44 INFO - Return code: 0 03:41:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:41:44 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')]} 03:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:44 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')]} 03:41:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:44 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 0x27c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a61290>, '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 0x2a61b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62040>, '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': '4300f881736b422476174874000001bc-1491215954.457309-663485225', '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 03:41:44 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 03:41:44 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 03:41:44 INFO - Using env: {'DISPLAY': ':0', 03:41:44 INFO - 'HOME': '/home/cltbld', 03:41:44 INFO - 'LANG': 'en_US.UTF-8', 03:41:44 INFO - 'LANGUAGE': 'en_US:en', 03:41:44 INFO - 'LOGNAME': 'cltbld', 03:41:44 INFO - 'MAIL': '/var/mail/cltbld', 03:41:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:44 INFO - 'MOZ_NO_REMOTE': '1', 03:41:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:44 INFO - 'NO_EM_RESTART': '1', 03:41:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:44 INFO - 'PWD': '/builds/slave/test', 03:41:44 INFO - 'SHELL': '/bin/bash', 03:41:44 INFO - 'SHLVL': '1', 03:41:44 INFO - 'TERM': 'linux', 03:41:44 INFO - 'TMOUT': '86400', 03:41:44 INFO - 'USER': 'cltbld', 03:41:44 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1491215954.457309-663485225', 03:41:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:44 INFO - '_': '/tools/buildbot/bin/python'} 03:41:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:44 INFO - Downloading/unpacking psutil>=3.1.1 03:41:44 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 03:41:44 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 03:41:44 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 03:41:44 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 03:41:44 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 03:41:44 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 03:41:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:41:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:41:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:41:46 INFO - Installing collected packages: psutil 03:41:46 INFO - Running setup.py install for psutil 03:41:46 INFO - building 'psutil._psutil_linux' extension 03:41:46 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 03:41:46 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 03:41:46 INFO - building 'psutil._psutil_posix' extension 03:41:46 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 03:41:46 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 03:41:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:41:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:41:47 INFO - Successfully installed psutil 03:41:47 INFO - Cleaning up... 03:41:47 INFO - Return code: 0 03:41:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:41:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:47 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 0x27c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a61290>, '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 0x2a61b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62040>, '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': '4300f881736b422476174874000001bc-1491215954.457309-663485225', '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 03:41:47 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 03:41:47 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 03:41:47 INFO - Using env: {'DISPLAY': ':0', 03:41:47 INFO - 'HOME': '/home/cltbld', 03:41:47 INFO - 'LANG': 'en_US.UTF-8', 03:41:47 INFO - 'LANGUAGE': 'en_US:en', 03:41:47 INFO - 'LOGNAME': 'cltbld', 03:41:47 INFO - 'MAIL': '/var/mail/cltbld', 03:41:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:47 INFO - 'MOZ_NO_REMOTE': '1', 03:41:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:47 INFO - 'NO_EM_RESTART': '1', 03:41:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:47 INFO - 'PWD': '/builds/slave/test', 03:41:47 INFO - 'SHELL': '/bin/bash', 03:41:47 INFO - 'SHLVL': '1', 03:41:47 INFO - 'TERM': 'linux', 03:41:47 INFO - 'TMOUT': '86400', 03:41:47 INFO - 'USER': 'cltbld', 03:41:47 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1491215954.457309-663485225', 03:41:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:47 INFO - '_': '/tools/buildbot/bin/python'} 03:41:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:41:47 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 03:41:47 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 03:41:47 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 03:41:47 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 03:41:47 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 03:41:47 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 03:41:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:41:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:41:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:41:49 INFO - Installing collected packages: mozsystemmonitor 03:41:49 INFO - Running setup.py install for mozsystemmonitor 03:41:49 INFO - Successfully installed mozsystemmonitor 03:41:49 INFO - Cleaning up... 03:41:49 INFO - Return code: 0 03:41:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:41:49 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')]} 03:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:49 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')]} 03:41:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:49 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 0x27c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a61290>, '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 0x2a61b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62040>, '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': '4300f881736b422476174874000001bc-1491215954.457309-663485225', '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 03:41:49 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 03:41:49 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 03:41:49 INFO - Using env: {'DISPLAY': ':0', 03:41:49 INFO - 'HOME': '/home/cltbld', 03:41:49 INFO - 'LANG': 'en_US.UTF-8', 03:41:49 INFO - 'LANGUAGE': 'en_US:en', 03:41:49 INFO - 'LOGNAME': 'cltbld', 03:41:49 INFO - 'MAIL': '/var/mail/cltbld', 03:41:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:49 INFO - 'MOZ_NO_REMOTE': '1', 03:41:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:49 INFO - 'NO_EM_RESTART': '1', 03:41:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:49 INFO - 'PWD': '/builds/slave/test', 03:41:49 INFO - 'SHELL': '/bin/bash', 03:41:49 INFO - 'SHLVL': '1', 03:41:49 INFO - 'TERM': 'linux', 03:41:49 INFO - 'TMOUT': '86400', 03:41:49 INFO - 'USER': 'cltbld', 03:41:49 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1491215954.457309-663485225', 03:41:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:49 INFO - '_': '/tools/buildbot/bin/python'} 03:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:49 INFO - Downloading/unpacking jsonschema==2.5.1 03:41:49 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 03:41:49 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 03:41:49 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 03:41:49 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 03:41:49 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 03:41:49 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 03:41:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:41:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:41:51 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 03:41:51 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 03:41:51 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 03:41:51 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 03:41:51 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 03:41:51 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 03:41:51 INFO - Downloading functools32-3.2.3-2.tar.gz 03:41:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:41:52 INFO - warning: no files found matching '*.txt' 03:41:52 INFO - no previously-included directories found matching 'build' 03:41:52 INFO - no previously-included directories found matching 'dist' 03:41:52 INFO - no previously-included directories found matching '.git*' 03:41:52 INFO - Installing collected packages: jsonschema, functools32 03:41:52 INFO - Running setup.py install for functools32 03:41:52 INFO - warning: no files found matching '*.txt' 03:41:52 INFO - no previously-included directories found matching 'build' 03:41:52 INFO - no previously-included directories found matching 'dist' 03:41:52 INFO - no previously-included directories found matching '.git*' 03:41:52 INFO - Successfully installed jsonschema functools32 03:41:52 INFO - Cleaning up... 03:41:52 INFO - Return code: 0 03:41:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:41:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:52 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 0x27c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a61290>, '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 0x2a61b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62040>, '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': '4300f881736b422476174874000001bc-1491215954.457309-663485225', '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 03:41:52 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 03:41:52 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 03:41:52 INFO - Using env: {'DISPLAY': ':0', 03:41:52 INFO - 'HOME': '/home/cltbld', 03:41:52 INFO - 'LANG': 'en_US.UTF-8', 03:41:52 INFO - 'LANGUAGE': 'en_US:en', 03:41:52 INFO - 'LOGNAME': 'cltbld', 03:41:52 INFO - 'MAIL': '/var/mail/cltbld', 03:41:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:52 INFO - 'MOZ_NO_REMOTE': '1', 03:41:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:52 INFO - 'NO_EM_RESTART': '1', 03:41:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:52 INFO - 'PWD': '/builds/slave/test', 03:41:52 INFO - 'SHELL': '/bin/bash', 03:41:52 INFO - 'SHLVL': '1', 03:41:52 INFO - 'TERM': 'linux', 03:41:52 INFO - 'TMOUT': '86400', 03:41:52 INFO - 'USER': 'cltbld', 03:41:52 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1491215954.457309-663485225', 03:41:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:52 INFO - '_': '/tools/buildbot/bin/python'} 03:41:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:41:52 INFO - Cleaning up... 03:41:52 INFO - Return code: 0 03:41:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:41:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:52 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 0x27c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a61290>, '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 0x2a61b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62040>, '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': '4300f881736b422476174874000001bc-1491215954.457309-663485225', '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 03:41:52 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 03:41:52 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 03:41:52 INFO - Using env: {'DISPLAY': ':0', 03:41:52 INFO - 'HOME': '/home/cltbld', 03:41:52 INFO - 'LANG': 'en_US.UTF-8', 03:41:52 INFO - 'LANGUAGE': 'en_US:en', 03:41:52 INFO - 'LOGNAME': 'cltbld', 03:41:52 INFO - 'MAIL': '/var/mail/cltbld', 03:41:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:52 INFO - 'MOZ_NO_REMOTE': '1', 03:41:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:52 INFO - 'NO_EM_RESTART': '1', 03:41:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:52 INFO - 'PWD': '/builds/slave/test', 03:41:52 INFO - 'SHELL': '/bin/bash', 03:41:52 INFO - 'SHLVL': '1', 03:41:52 INFO - 'TERM': 'linux', 03:41:52 INFO - 'TMOUT': '86400', 03:41:52 INFO - 'USER': 'cltbld', 03:41:52 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1491215954.457309-663485225', 03:41:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:52 INFO - '_': '/tools/buildbot/bin/python'} 03:41:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:52 INFO - Downloading/unpacking blobuploader==1.2.4 03:41:52 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 03:41:52 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 03:41:52 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 03:41:52 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 03:41:52 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 03:41:52 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 03:41:54 INFO - Downloading blobuploader-1.2.4.tar.gz 03:41:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:41:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:41:54 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 03:41:54 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 03:41:54 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 03:41:54 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 03:41:54 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 03:41:54 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 03:41:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:41:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:41:55 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 03:41:55 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 03:41:55 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 03:41:55 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 03:41:55 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 03:41:55 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 03:41:55 INFO - Downloading docopt-0.6.1.tar.gz 03:41:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:41:55 INFO - Installing collected packages: blobuploader, requests, docopt 03:41:55 INFO - Running setup.py install for blobuploader 03:41:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:41:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:41:55 INFO - Running setup.py install for requests 03:41:55 INFO - Running setup.py install for docopt 03:41:56 INFO - Successfully installed blobuploader requests docopt 03:41:56 INFO - Cleaning up... 03:41:56 INFO - Return code: 0 03:41:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:56 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 0x27c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a61290>, '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 0x2a61b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62040>, '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': '4300f881736b422476174874000001bc-1491215954.457309-663485225', '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 03:41:56 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 03:41:56 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 03:41:56 INFO - Using env: {'DISPLAY': ':0', 03:41:56 INFO - 'HOME': '/home/cltbld', 03:41:56 INFO - 'LANG': 'en_US.UTF-8', 03:41:56 INFO - 'LANGUAGE': 'en_US:en', 03:41:56 INFO - 'LOGNAME': 'cltbld', 03:41:56 INFO - 'MAIL': '/var/mail/cltbld', 03:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:56 INFO - 'MOZ_NO_REMOTE': '1', 03:41:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:56 INFO - 'NO_EM_RESTART': '1', 03:41:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:56 INFO - 'PWD': '/builds/slave/test', 03:41:56 INFO - 'SHELL': '/bin/bash', 03:41:56 INFO - 'SHLVL': '1', 03:41:56 INFO - 'TERM': 'linux', 03:41:56 INFO - 'TMOUT': '86400', 03:41:56 INFO - 'USER': 'cltbld', 03:41:56 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1491215954.457309-663485225', 03:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:56 INFO - '_': '/tools/buildbot/bin/python'} 03:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:41:56 INFO - Running setup.py (path:/tmp/pip-DgKgQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:41:56 INFO - Running setup.py (path:/tmp/pip-x_8qp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:41:56 INFO - Running setup.py (path:/tmp/pip-Dy98s0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:41:56 INFO - Running setup.py (path:/tmp/pip-aNKu9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:41:56 INFO - Running setup.py (path:/tmp/pip-KMlCsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:41:56 INFO - Running setup.py (path:/tmp/pip-G_Jj_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:41:56 INFO - Running setup.py (path:/tmp/pip-r4hkPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:41:56 INFO - Running setup.py (path:/tmp/pip-VGK06W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:41:56 INFO - Running setup.py (path:/tmp/pip-jnrUvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:41:57 INFO - Running setup.py (path:/tmp/pip-OggorT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:41:57 INFO - Running setup.py (path:/tmp/pip-722Sk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:41:57 INFO - Running setup.py (path:/tmp/pip-rJcAuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:41:57 INFO - Running setup.py (path:/tmp/pip-djfuZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:41:57 INFO - Running setup.py (path:/tmp/pip-1hkca0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:57 INFO - Running setup.py (path:/tmp/pip-m573_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:41:57 INFO - Running setup.py (path:/tmp/pip-t5OiQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:41:57 INFO - Running setup.py (path:/tmp/pip-4VR0WY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:41:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:41:57 INFO - Running setup.py install for manifestparser 03:41:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:41:57 INFO - Running setup.py install for mozcrash 03:41:57 INFO - Running setup.py install for mozdebug 03:41:57 INFO - Running setup.py install for mozdevice 03:41:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:41:57 INFO - Running setup.py install for mozfile 03:41:58 INFO - Running setup.py install for mozhttpd 03:41:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:41:58 INFO - Running setup.py install for mozinfo 03:41:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:41:58 INFO - Running setup.py install for mozInstall 03:41:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:41:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:41:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:41:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:41:58 INFO - Running setup.py install for mozleak 03:41:58 INFO - Running setup.py install for mozlog 03:41:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:41:58 INFO - Running setup.py install for moznetwork 03:41:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:41:58 INFO - Running setup.py install for mozprocess 03:41:58 INFO - Running setup.py install for mozprofile 03:41:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:41:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:41:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:41:58 INFO - Running setup.py install for mozrunner 03:41:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:41:59 INFO - Running setup.py install for mozscreenshot 03:41:59 INFO - Running setup.py install for moztest 03:41:59 INFO - Running setup.py install for mozversion 03:41:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:41:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:41:59 INFO - Cleaning up... 03:41:59 INFO - Return code: 0 03:41:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:59 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')]} 03:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:59 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')]} 03:41:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:59 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 0x27c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a61290>, '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 0x2a61b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62040>, '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': '4300f881736b422476174874000001bc-1491215954.457309-663485225', '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 03:41:59 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 03:41:59 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 03:41:59 INFO - Using env: {'DISPLAY': ':0', 03:41:59 INFO - 'HOME': '/home/cltbld', 03:41:59 INFO - 'LANG': 'en_US.UTF-8', 03:41:59 INFO - 'LANGUAGE': 'en_US:en', 03:41:59 INFO - 'LOGNAME': 'cltbld', 03:41:59 INFO - 'MAIL': '/var/mail/cltbld', 03:41:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:59 INFO - 'MOZ_NO_REMOTE': '1', 03:41:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:59 INFO - 'NO_EM_RESTART': '1', 03:41:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:59 INFO - 'PWD': '/builds/slave/test', 03:41:59 INFO - 'SHELL': '/bin/bash', 03:41:59 INFO - 'SHLVL': '1', 03:41:59 INFO - 'TERM': 'linux', 03:41:59 INFO - 'TMOUT': '86400', 03:41:59 INFO - 'USER': 'cltbld', 03:41:59 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1491215954.457309-663485225', 03:41:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:59 INFO - '_': '/tools/buildbot/bin/python'} 03:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:41:59 INFO - Running setup.py (path:/tmp/pip-pashUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:41:59 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)) 03:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:41:59 INFO - Running setup.py (path:/tmp/pip-0pNqJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:41:59 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)) 03:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:41:59 INFO - Running setup.py (path:/tmp/pip-SQWSN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:41:59 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)) 03:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:41:59 INFO - Running setup.py (path:/tmp/pip-8tl8QJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:41:59 INFO - Running setup.py (path:/tmp/pip-DqxcNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:41:59 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)) 03:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:41:59 INFO - Running setup.py (path:/tmp/pip-FoZIwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:42:00 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)) 03:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:42:00 INFO - Running setup.py (path:/tmp/pip-6_mrMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:42:00 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)) 03:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:42:00 INFO - Running setup.py (path:/tmp/pip-M0oEBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:42:00 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)) 03:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:42:00 INFO - Running setup.py (path:/tmp/pip-CEkAVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:42:00 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)) 03:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:42:00 INFO - Running setup.py (path:/tmp/pip-HsyWho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:42:00 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)) 03:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:42:00 INFO - Running setup.py (path:/tmp/pip-o73bIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:42:00 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)) 03:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:42:00 INFO - Running setup.py (path:/tmp/pip-eoCxKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:42:00 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)) 03:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:42:00 INFO - Running setup.py (path:/tmp/pip-vat2PU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:42:00 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)) 03:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:42:00 INFO - Running setup.py (path:/tmp/pip-PpvL_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:42:00 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)) 03:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:00 INFO - Running setup.py (path:/tmp/pip-VnrRV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:00 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)) 03:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:42:00 INFO - Running setup.py (path:/tmp/pip-eduN5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:42:00 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)) 03:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:42:00 INFO - Running setup.py (path:/tmp/pip-K6LaZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:42:00 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)) 03:42:00 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)) 03:42:00 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)) 03:42:00 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)) 03:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:42:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:42:00 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 03:42:00 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 03:42:00 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 03:42:00 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 03:42:00 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 03:42:00 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 03:42:02 INFO - Downloading blessings-1.6.tar.gz 03:42:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:42:02 INFO - Installing collected packages: blessings 03:42:02 INFO - Running setup.py install for blessings 03:42:03 INFO - Successfully installed blessings 03:42:03 INFO - Cleaning up... 03:42:03 INFO - Return code: 0 03:42:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:42:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:42:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:42:03 INFO - Reading from file tmpfile_stdout 03:42:03 INFO - Current package versions: 03:42:03 INFO - argparse == 1.2.1 03:42:03 INFO - blessings == 1.6 03:42:03 INFO - blobuploader == 1.2.4 03:42:03 INFO - docopt == 0.6.1 03:42:03 INFO - functools32 == 3.2.3-2 03:42:03 INFO - jsonschema == 2.5.1 03:42:03 INFO - manifestparser == 1.1 03:42:03 INFO - mozInstall == 1.12 03:42:03 INFO - mozcrash == 1.0 03:42:03 INFO - mozdebug == 0.1 03:42:03 INFO - mozdevice == 0.49 03:42:03 INFO - mozfile == 1.2 03:42:03 INFO - mozhttpd == 0.7 03:42:03 INFO - mozinfo == 0.9 03:42:03 INFO - mozleak == 0.1 03:42:03 INFO - mozlog == 3.4 03:42:03 INFO - moznetwork == 0.27 03:42:03 INFO - mozprocess == 0.25 03:42:03 INFO - mozprofile == 0.28 03:42:03 INFO - mozrunner == 6.13 03:42:03 INFO - mozscreenshot == 0.1 03:42:03 INFO - mozsystemmonitor == 0.3 03:42:03 INFO - moztest == 0.8 03:42:03 INFO - mozversion == 1.4 03:42:03 INFO - psutil == 3.1.1 03:42:03 INFO - requests == 1.2.3 03:42:03 INFO - wsgiref == 0.1.2 03:42:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:42:03 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')]} 03:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:03 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')]} 03:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:03 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 0x27c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a61290>, '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 0x2a61b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62040>, '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': '4300f881736b422476174874000001bc-1491215954.457309-663485225', '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 03:42:03 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 03:42:03 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 03:42:03 INFO - Using env: {'DISPLAY': ':0', 03:42:03 INFO - 'HOME': '/home/cltbld', 03:42:03 INFO - 'LANG': 'en_US.UTF-8', 03:42:03 INFO - 'LANGUAGE': 'en_US:en', 03:42:03 INFO - 'LOGNAME': 'cltbld', 03:42:03 INFO - 'MAIL': '/var/mail/cltbld', 03:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:03 INFO - 'MOZ_NO_REMOTE': '1', 03:42:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:03 INFO - 'NO_EM_RESTART': '1', 03:42:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:03 INFO - 'PWD': '/builds/slave/test', 03:42:03 INFO - 'SHELL': '/bin/bash', 03:42:03 INFO - 'SHLVL': '1', 03:42:03 INFO - 'TERM': 'linux', 03:42:03 INFO - 'TMOUT': '86400', 03:42:03 INFO - 'USER': 'cltbld', 03:42:03 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1491215954.457309-663485225', 03:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:03 INFO - '_': '/tools/buildbot/bin/python'} 03:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:03 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)) 03:42:03 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)) 03:42:03 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)) 03:42:03 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)) 03:42:03 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)) 03:42:03 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)) 03:42:03 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)) 03:42:03 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)) 03:42:03 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)) 03:42:03 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)) 03:42:03 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)) 03:42:03 INFO - Cleaning up... 03:42:03 INFO - Return code: 0 03:42:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:42:03 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')]} 03:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:03 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')]} 03:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:03 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 0x27c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a61290>, '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 0x2a61b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62040>, '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': '4300f881736b422476174874000001bc-1491215954.457309-663485225', '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 03:42:03 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 03:42:03 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 03:42:03 INFO - Using env: {'DISPLAY': ':0', 03:42:03 INFO - 'HOME': '/home/cltbld', 03:42:03 INFO - 'LANG': 'en_US.UTF-8', 03:42:03 INFO - 'LANGUAGE': 'en_US:en', 03:42:03 INFO - 'LOGNAME': 'cltbld', 03:42:03 INFO - 'MAIL': '/var/mail/cltbld', 03:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:03 INFO - 'MOZ_NO_REMOTE': '1', 03:42:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:03 INFO - 'NO_EM_RESTART': '1', 03:42:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:03 INFO - 'PWD': '/builds/slave/test', 03:42:03 INFO - 'SHELL': '/bin/bash', 03:42:03 INFO - 'SHLVL': '1', 03:42:03 INFO - 'TERM': 'linux', 03:42:03 INFO - 'TMOUT': '86400', 03:42:03 INFO - 'USER': 'cltbld', 03:42:03 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1491215954.457309-663485225', 03:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:03 INFO - '_': '/tools/buildbot/bin/python'} 03:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:42:03 INFO - Cleaning up... 03:42:03 INFO - Return code: 0 03:42:03 INFO - Running post-action listener: _resource_record_post_action 03:42:03 INFO - Running post-action listener: _start_resource_monitoring 03:42:03 INFO - Starting resource monitoring. 03:42:03 INFO - [mozharness: 2017-04-03 10:42:03.814944Z] Finished create-virtualenv step (success) 03:42:03 INFO - [mozharness: 2017-04-03 10:42:03.815457Z] Running install step. 03:42:03 INFO - Running pre-action listener: _resource_record_pre_action 03:42:03 INFO - Running main action method: install 03:42:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:42:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:42:04 INFO - Reading from file tmpfile_stdout 03:42:04 INFO - Detecting whether we're running mozinstall >=1.0... 03:42:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:42:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:42:04 INFO - Reading from file tmpfile_stdout 03:42:04 INFO - Output received: 03:42:04 INFO - Usage: mozinstall [options] installer 03:42:04 INFO - Options: 03:42:04 INFO - -h, --help show this help message and exit 03:42:04 INFO - -d DEST, --destination=DEST 03:42:04 INFO - Directory to install application into. [default: 03:42:04 INFO - "/builds/slave/test"] 03:42:04 INFO - --app=APP Application being installed. [default: firefox] 03:42:04 INFO - mkdir: /builds/slave/test/build/application 03:42:04 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'] 03:42:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:42:20 INFO - Reading from file tmpfile_stdout 03:42:20 INFO - Output received: 03:42:20 INFO - /builds/slave/test/build/application/firefox/firefox 03:42:20 INFO - Running post-action listener: _resource_record_post_action 03:42:20 INFO - [mozharness: 2017-04-03 10:42:20.473224Z] Finished install step (success) 03:42:20 INFO - [mozharness: 2017-04-03 10:42:20.473373Z] Running run-tests step. 03:42:20 INFO - Running pre-action listener: _resource_record_pre_action 03:42:20 INFO - Running main action method: run_tests 03:42:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:42:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:42:20 INFO - Python 2.7.3 03:42:20 INFO - Return code: 0 03:42:20 INFO - grabbing minidump binary from tooltool 03:42:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:20 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 0x2a61290>, '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 0x2a61b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:42:20 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 03:42:20 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 03:42:20 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 03:42:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:42:20 INFO - Return code: 0 03:42:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:42:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:42:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:42:20 INFO - ENV: RUST_BACKTRACE is now 1 03:42:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:42:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:42:20 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/KJ-UiFRtRM6KsF05QxFqMA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 03:42:20 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/KJ-UiFRtRM6KsF05QxFqMA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 03:42:20 INFO - Using env: {'DISPLAY': ':0', 03:42:20 INFO - 'HOME': '/home/cltbld', 03:42:20 INFO - 'LANG': 'en_US.UTF-8', 03:42:20 INFO - 'LANGUAGE': 'en_US:en', 03:42:20 INFO - 'LOGNAME': 'cltbld', 03:42:20 INFO - 'MAIL': '/var/mail/cltbld', 03:42:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:42:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:20 INFO - 'MOZ_NO_REMOTE': '1', 03:42:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:42:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:20 INFO - 'NO_EM_RESTART': '1', 03:42:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:20 INFO - 'PWD': '/builds/slave/test', 03:42:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:42:20 INFO - 'RUST_BACKTRACE': '1', 03:42:20 INFO - 'SHELL': '/bin/bash', 03:42:20 INFO - 'SHLVL': '1', 03:42:20 INFO - 'TERM': 'linux', 03:42:20 INFO - 'TMOUT': '86400', 03:42:20 INFO - 'USER': 'cltbld', 03:42:20 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1491215954.457309-663485225', 03:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:20 INFO - '_': '/tools/buildbot/bin/python'} 03:42:20 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/KJ-UiFRtRM6KsF05QxFqMA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 03:42:20 INFO - mozversion application_buildid: 20170403101416 03:42:20 INFO - mozversion application_changeset: aaa0cd3bd620daf6be29c72625f6e63fd0bc1d46 03:42:20 INFO - mozversion application_display_name: Nightly 03:42:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:42:20 INFO - mozversion application_name: Firefox 03:42:20 INFO - mozversion application_remotingname: firefox 03:42:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:42:20 INFO - mozversion application_vendor: Mozilla 03:42:20 INFO - mozversion application_version: 55.0a1 03:42:20 INFO - mozversion platform_buildid: 20170403101416 03:42:20 INFO - mozversion platform_changeset: aaa0cd3bd620daf6be29c72625f6e63fd0bc1d46 03:42:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:42:20 INFO - mozversion platform_version: 55.0a1 03:42:20 INFO - using testdate: 1491216140 03:42:20 INFO - actual date: 1491216140 03:42:20 INFO - starting webserver on 'localhost:43410' 03:42:20 INFO - SUITE-START | Running 2 tests 03:42:20 INFO - TEST-START | dromaeo_css 03:42:20 INFO - operating with platform_type : linux_ 03:42:20 INFO - Initialising browser for dromaeo_css test... 03:42:20 INFO - TEST-INFO | started process 17837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpelJfrv/profile http://localhost:43410/getInfo.html) 03:42:25 INFO - PID 17837 | __metrics Screen width/height:1600/1200 03:42:25 INFO - PID 17837 | colorDepth:24 03:42:25 INFO - PID 17837 | Browser inner width/height: 1024/697 03:42:25 INFO - PID 17837 | __metrics 03:42:26 INFO - PID 17837 | 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" 03:42:26 INFO - PID 17837 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:42:27 INFO - TEST-INFO | 17837: exit 0 03:42:27 INFO - Browser initialized. 03:42:27 INFO - Running cycle 1/1 for dromaeo_css test... 03:42:27 INFO - TEST-INFO | started process 17928 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpelJfrv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:42:39 INFO - PID 17928 | RSS: Main: 149741568 03:42:39 INFO - PID 17928 | 03:45:46 INFO - PID 17928 | Cycle 1(1): loaded http://localhost:43410/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43410/tests/dromaeo/cssquery-ext.html) 03:45:48 INFO - PID 17928 | RSS: Main: 262799360 03:45:48 INFO - PID 17928 | 03:47:28 INFO - PID 17928 | ************************* 03:47:28 INFO - PID 17928 | A coding exception was thrown and uncaught in a Task. 03:47:28 INFO - PID 17928 | 03:47:28 ERROR - PID 17928 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:47:28 INFO - PID 17928 | Full stack: 03:47:28 INFO - PID 17928 | ************************* 03:47:28 INFO - PID 17928 | ************************* 03:47:28 INFO - PID 17928 | A coding exception was thrown and uncaught in a Task. 03:47:28 INFO - PID 17928 | 03:47:28 ERROR - PID 17928 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:47:28 INFO - PID 17928 | Full stack: 03:47:28 INFO - PID 17928 | ************************* 03:47:28 INFO - PID 17928 | ************************* 03:47:28 INFO - PID 17928 | A coding exception was thrown and uncaught in a Task. 03:47:28 INFO - PID 17928 | 03:47:28 ERROR - PID 17928 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:47:28 INFO - PID 17928 | Full stack: 03:47:28 INFO - PID 17928 | ************************* 03:47:28 INFO - PID 17928 | ************************* 03:47:28 INFO - PID 17928 | A coding exception was thrown and uncaught in a Task. 03:47:28 INFO - PID 17928 | 03:47:28 ERROR - PID 17928 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:47:28 INFO - PID 17928 | Full stack: 03:47:28 INFO - PID 17928 | ************************* 03:48:50 INFO - PID 17928 | Cycle 1(1): loaded http://localhost:43410/tests/dromaeo/cssquery-ext.html (next: http://localhost:43410/tests/dromaeo/cssquery-jquery.html) 03:48:51 INFO - PID 17928 | RSS: Main: 228085760 03:48:51 INFO - PID 17928 | 03:51:53 INFO - PID 17928 | Cycle 1(1): loaded http://localhost:43410/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43410/tests/dromaeo/cssquery-mootools.html) 03:51:53 INFO - PID 17928 | RSS: Main: 183148544 03:51:53 INFO - PID 17928 | 03:54:55 INFO - PID 17928 | Cycle 1(1): loaded http://localhost:43410/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43410/tests/dromaeo/cssquery-prototype.html) 03:54:56 INFO - PID 17928 | RSS: Main: 243855360 03:54:56 INFO - PID 17928 | 03:57:59 INFO - PID 17928 | Cycle 1(1): loaded http://localhost:43410/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43410/tests/dromaeo/cssquery-yui.html) 03:58:00 INFO - PID 17928 | RSS: Main: 186499072 03:58:00 INFO - PID 17928 | 04:01:03 INFO - PID 17928 | Cycle 1(1): loaded http://localhost:43410/tests/dromaeo/cssquery-yui.html (next: http://localhost:43410/tests/dromaeo/cssquery-dojo.html) 04:01:03 INFO - PID 17928 | RSS: Main: 277700608 04:01:03 INFO - PID 17928 | 04:01:03 INFO - PID 17928 | __start_tp_report 04:01:03 INFO - PID 17928 | _x_x_mozilla_page_load 04:01:03 INFO - PID 17928 | _x_x_mozilla_page_load_details 04:01:03 INFO - PID 17928 | |i|pagename|runs| 04:01:03 INFO - PID 17928 | |0;dojo.html;2642.828216165949;2660.6807183138026;2668.533006723823;2691.596260560917;2694.8248363856337;5135.8202462913805;5205.791768329272;5223.294855194552;5233.450487698789;5245.711485868281;5172.224166375046;5211.687298762077;5218.47815218478;5267.1045922193225;5272.288241087452;4547.977260113695;4584.151931892602;4615.723056616597;4677.111348843709;4721.079389519045;4586.105709386671;4615.030843522864;4657.324687920266;4685.62514998801;4705.176594096037;4551.817927282905;4588.7476188809605;4611.26219804833;4614;4625.421822272216;4565.406497155382;4605.769711514445;4621.861344159681;4640.791164397577;4667.743274119922;4545.885026991178;4582.793774280132;4612.0545288215835;4620.029793743318;4654.930176047362;5062.67092638981;5147.150720131174;5148;5180.352455943007;5185.351831021122;5598.1322894951345;5623.775048998035;5670.773169073233;5674.290713660793;5677.829665110054;5657.20799088128;5657.23627310312;5668.489835914746;5685.289338832646;5685.800996965087;5156.871078223075;5243.449437809051;5258.842234732964;5261.894762104736;5307.787688492494;5734.541236701054;5737.913931291034;5808.680522571299;5814.04068328721;5814.302283725895;5481.260029895992;5505.724713764296;5520.06158952979;5524.254225679482;5527.336719593674;5567.081431563827;5616.494515493543;5627.465390787868;5639.774409023676;5641.210230567724;5443.401225865152;5519.862003449946;5527.44725527444;5542.0301447246575;5605.383407825136;5561.193626924073;5564.777408903679;5566.025945459528;5596.832095037155;5625.746841392147;4689.366935463737;4689.976550117228;4695.037517308943;4697.553732395417;4742.786574604151;3998;3998.820053097618;4006;4008.6993475489453;4070.592940705965;4694.131585656664;4704.9059018819435;4728.976355118202;4747.335373047776;4748.715077095385;5638.689872057076;5644.01229784786;5670.262865827499;5674.858128546819;5674.943250567524;4589.65577581676;4724.314974328703;4728.645351598575;4732.266498692708;4774.427068751703;4982.028504441599;4990.650654454226;5049.646524743306;5053.1157047516535;5060.721660308718;5060.569851562658;5169.741512924264;5187.92218116721;5190;5193.117170081171;5568.721563921868;5580.5535557156145;5586.944130558642;5613.522850557748;5662;5133.512316330092;5174.14626586624;5174.404943431403;5188.818391356435;5209.843704688714;5431.375391829832;5479.205515200353;5486;5492.697901615449;5541.3904470507405;5573.21974923503;5574.9442505574425;5583.804566840141;5618.550515958632;5628.352739434854;5413.648112872651;5419;5419.783208671609;5420.457954204706;5421.701806400528;5334.5198932094745;5414.307464201524;5415.891682166413;5417.566594672496;5464.23500709893;5333.679979201261;5348.839534813962;5364.9731751341;5396.946030539644;5410.1343784994215;5490.780368785364;5499.807506737245;5501.889962200814;5504.862378440571;5532.1425179097305;5289.761960711854;5336.359636843604;5353.75908084145;5354.196870469461;5355.464453554613 04:01:03 INFO - PID 17928 | |1;ext.html;699.2518005733867;738.8670039392908;759.7834617134116;966.6423423333364;982.9164521015713;25367.873160634193;33256.501152482735;34088.31823363534;34121.82939085301;34125.48811767819;36340.7280745174;36619;36800.26399472009;36808.81595592025;36859.815700921456;5374.462553744634;7220.422366210703;7410.962945185293;7411.110666719974;7414.962925185367;5445.047116754572;7068.505204635678;7313.451491138159;7319.524230925;7331.816704582401;7424.9628751856435;7472.4395670324675;7482.51363661363;7487.850242995137;7493.063367079115;7397.63011849408;7430.925690743077;7440;7464.4028477722195;7472;7218.6390680465765;7268.0914885639295;7273.927260727378;7294.635268236567;7295.270472952662;33671.326573468636;33830;33927.6607233927;33935.66064339374;33978.830105849556;2572.189760225523;2576.30439781258;2582.6384306197147;2583;2632.0524611140168;23152.884235578713;23161.189358372376;23260.41848953773;23273;23390.64914026291;2795.7623601993855;2808.578713193017;2815.2398852309966;2823.181277429543;2826;145887;145934;146341;147559;148729.2563537186;40240.59759402368;40414.39378409326;40436.191276174315;40468.797656011535;40487.797561012005;42843;42858.14283714308;42880.571194288284;42905.78547107307;42972.14055718868;12998.545050923172;13126.737465250833;13136.211827290394;13139.080264381402;13269.535566255328;8761.38670293086;8908;10686.145108391465;10686.198535109897;10686.358818470917;11632.360220187971;11704.70738231534;11729.706757331134;11862.525498979945;11961.129328960988;5108.259302401131;5143.742812859342;5159.432462429129;5204.8178313758835;5215.504527069922;860.9526476043877;896.7309807057987;900.3292547052357;912.7444315591645;931.1666058877403;19587.984463185014;19671.409857704293;20807.68788468174;20943.68584471234;21084.89457552733;986.40815510693;989.9802003960025;996.1383403356045;998.3959704378891;1012.9088382045651;10692.198085143646;10773.245872788986;11076.667699969013;11130.554777808797;11238.044766194802;219439;221263;221301;221712;221899;39540.406893896616;39616.405753913714;39707.2058558833;39748.60251397507;39757;1228.2323547782637;1253.943572539238;1256.1395444120624;1268.055298802398;1275.2157423184674;19289.90355048216;19822.108005139515;20156.697649535563;20217.89891050535;20497.38507844767;29301.120966371043;29327.70672293335;29347.55978660279;29408.26479338034;29416;214707;215966;216069;216127;216169;21045.89477052605;21154.78845211528;27451.862740686167;27960.580591291553;28176;31506.527402089447;32327;32432.35135297328;32512;32953;24828.50342993166;24874.875625621757;26368.472630547665;27489.587656184773;27585.310367240978;27055.86472067706;27140.864295679185;27352.452950941268;27918;28351.71648283491;29888.85055574708;30229.09312720622;30247;30350.089497315115;30502.389952201276;26620.46759064769;26752.19743407701;26871.865640672455;27182.592261116493;27742.44515109646;21230.46923826917;21872.562548749254;22150.33548993533;22203.555928881655;22270.554588908457 04:01:03 INFO - PID 17928 | |2;jquery.html;413.52238164919527;414.8154071438211;424.19614829897347;432.4119197890868;440.3856620015079;17892.31615257712;18080.819191808096;18648.533786655305;18768.249270029184;18866.90566547167;17740.645187096252;18048;19128.13923373448;19277.132529036193;19336.903315483403;5525.060739674245;5610.971945140279;5666.829995100154;5681.545476361881;5685.346185188694;5611.270534830466;5718.142278658193;5718.142278658213;5736.856578585548;5738.196652468658;5413.593980451482;5537.58468114891;5557.749901254453;5630.380658127603;5638.154276858463;5366.838994830161;5596.916046259309;5629.4652008059165;5633.042382794914;5634.6337488063145;4999.575036121934;5056.216286475602;5057.620678449094;5094.4141423736;5117.385913690344;21416.571668566696;22405.43986400337;22494.66258006131;22517.09931602734;22720.43198920024;1581.430684953416;1586.8968517046355;1590.1492701404693;1634.313588292908;1636.8035835699673;13748;13879.514217002457;13894.4442222312;14205.573832785032;14693.26533673312;1894.2896413844808;1924.1533725160884;1930.2279088364626;1951.8731282466736;1967.5572996075912;82008;83936;84639.6144154233;85701;86508.70236946514;10730.409827459565;11054.613088541862;11081.445927703744;11161;11206.831897521544;15347.697845323291;15441.768373474408;15462.458813941457;15464.458743943907;15464.690706185813;7463.365613922769;7713.4600577959;7729.613519324012;7841.607919604111;7884.881726774103;7109.786706398816;7117.75087871922;7306.305900939402;7313.049303590606;7337.669804858794;6622.536422450478;6760.850655388595;6821.795346139624;6833.760818371433;6841.486888483384;2075.865068770525;2086.155107181594;2086.4888102415007;2087.9269225577336;2093.445237012193;854.6538651846013;876.3077169036517;878.1438097854541;908.8318661047728;914.1270087066836;16405.507834764976;16848.915755421145;17051.91474042622;17223.31106755716;17772.111394430485;885.5041176940933;886.1271647427279;895.1719659315238;899.1098812175899;900.1223806788329;9151.575758175908;9467.810643787223;9493.19307858826;9544.284178686488;9576.850777906695;489979;493466;494647;500527;502824;89120.55439722759;90393;90544.54727726319;90819;91472;1057.7038429239826;1077.4828082520278;1080.3193987787643;1086.4459125845876;1094.43089593411;14618.780718289447;14936.178510182044;14942.925285373503;14943.925280373529;15133.394664213749;41667.7916610415;43440.69677909668;43687.344689830315;44033.339499908165;44130.33804492871;55215;56068.71965640146;56370.718146409;56630.15054774264;57844.421555783905;8142.615755321491;8374.204450577185;8622.870656940277;8877.689280875138;11692.240004399688;12816.359182041047;13251.46994120263;13278.402471888981;13291.933540332237;13677.452901883813;11733.589324373606;11908.464119114833;11921.34432606215;12201.511939522676;12214.38928053576;10737.516811743333;10927.07119894786;11044.968586466042;11087.94456027747;11374.488148033193;11675.766484670428;11766.647000589996;12035.338056406981;12169.513219471477;12372.319522426353;11862.406879656155;11923.165378423428;11984.940075299568;12140.453679584263;12429.627111186679;11311.434428278717;11465.484053217791;11566.537338506701;11614.025615645192;11786.646400607995 04:01:03 INFO - PID 17928 | |3;mootools.html;957.9760505987346;1225.4975460061373;1277.2400421749055;1289.1040726694946;1291.0059254374132;8467.618957146928;9669.613215471381;9960.402375857453;9986.850197247048;10000.399976001445;9694.709158725233;9780;9795.461249631267;9799.216062714984;9800.117989380955;2169.9692645993146;2216.1246307708448;2216.512367279196;2218.256883943881;2222.866628002325;1878.7181922711634;1948.6979518174705;2162.8053475187307;2242.6411774116145;2254.2448279826276;2218.6450167973126;2233.1848875160613;2233.7877901599322;2236.642137258039;2240.2383189715492;1851.3982955539504;2188.627933251343;2241.3276017194776;2243.798058174772;2244.1584405847807;1871.504051426373;2129.7018417421573;2180.269609680759;2191.704119943803;2195.6596727507263;9668.081532254424;9851.310408271424;9854.753631159207;9862.30963832532;9866.65466708669;5348.224507446398;5575.804846830341;5597.6641401516035;5601.943980560224;5607.102863541854;3115.875364985398;3192.1062102611304;3211.807291562514;3228.757843161749;3273.5253388258807;994.6419289055934;1084.4198353880715;1096.550414330129;1109.672646569264;1112.1603189591888;14562.344694488773;14601.415943362254;14672.853271467255;14679.926600366929;14679.926600367036;4773.997460533327;4956.753326571102;5020.949790502122;5055;5078;12046.216995895238;12054.457549410297;12063.095267854771;12069.57756478519;12076.154669173073;5565.610407271533;5612.887742245132;5636.85907852307;5665.858353541194;5677.602567820213;4883.560479556857;4916.754162291871;4957.603391728653;5016.772493111301;5114.3862736471865;4141.562904449493;4151.7924103794685;4196.643285320782;4235.618794308527;4262.360645903077;1288.606974872654;1299.6685845109437;1302.8176055352258;1336.398620620705;1343.3887581150552;592.3632095497358;605.6214865708932;617.4473845907887;629.6820105846609;630.334996578614;5087.97456012725;5765.88468230633;5850.034744267234;5988.730507127189;6178.320384757673;538.1013707109137;538.8561958538824;544.6759178288912;547.370523897521;561.9690916999523;3324.451465508164;3330.2506935939705;3330.3339332133187;3335.849886755102;3456.827158642058;12294.631161065183;13002.934985325013;13009.869901301056;13014.21914685122;13020.28388438645;12341;12851.807222891664;12858.549950751678;12870.356482176041;12876.742465150832;9128.90871091294;9228.123328283802;9310.767230819283;9363.578638961262;9374.90625093754;5503.422140675171;5546.112621980464;5553.694546799965;5588.385277619377;5717.771289148387;11128.666140015812;11181.664550063511;11239.100871930063;11364.715882102682;11390.829137563109;11291.435428228391;11758.118141139277;11888.04895608332;11942.223755455867;11944.820827687417;7994.320482759031;8079.111297757359;8086.9191308086165;8096.676132954852;8099.83800324002;8453.331604227604;8638.611262493328;8742.82514349722;8768.868466972874;8802.823943521222;7746.767596972099;7944.165862584346;7985.361171106181;8074.87887681697;8213.260806527442;7566.508176968699;7683.692652293846;7782.688692452239;7806.687732490864;7960;6526.379993900572;6692.163479565054;6695.0626912231355;6699.9665001674675;6702.162229721285;4210.7473551587;4710.646701497333;4838.806447742191;4899.721629442326;5231.8168864089575;5220.504052115043;5302.39022512416;5320.068987927175;5335.706536140394;5403.918941215807 04:01:03 INFO - PID 17928 | |4;prototype.html;366.4027634955023;384.40033547665627;392.4603669953814;393.2999261314859;395.1464835954337;5343.599230057746;5377.623566350357;5388.515033646971;5395.514403703666;5422;5310.522053015228;5319.590308568223;5322.414534401213;5322.760475778589;5331.173668081444;4076.1194624985055;4106.281400754856;4108.753474791522;4134.338505839067;4163.292240319145;4141.068259641586;4143.854965076223;4144.129732756125;4155.732501587015;4179.916401671965;4131.97132795525;4132.111596006858;4135.09028013838;4139.855105071323;4143.8964025899295;4043.1307268937026;4111.116110036357;4148.377743338493;4149.315362965107;4152.584741525853;3702.407614781622;3707.9814600926825;3709.1083547391027;3723.7579557328686;3731.067233191702;5196.558292545138;5225.921611175835;5239.1093514102695;5241.240020197089;5259.684418934838;4787.593054590364;4880.682755620874;4884.804607815719;4905.337779399771;4911.838790931978;5593.216949627055;5618.887622247573;5629.915551266734;5634.098544232944;5666.744996475169;4172.374143878443;4188.162367526507;4194.895127621803;4201.4538110045805;4210.51579068408;5643.589102724319;5754.367019627837;5842.211301474289;5920.378360272195;5933;4307.806148723315;4317.762523061199;4324.372965919924;4340.197063543254;4346.326319420495;4413.514513403523;4417.182821178092;4426.84506042287;4432.335149727567;4443.333499974965;4569.451665800058;4577.176108300538;4855.150348688965;4886.60907127429;4907.2393778964315;5589.301337332833;5594.85305512369;5599.188117722907;5610.943890561124;5613.522850557748;1518.7494063479623;1528.5414375687249;1541;1541.714782765192;1547.4893285216076;929.1266209762937;963.210167662524;969.5733877094056;1103.7626910214342;1109.6338208391212;4775.808967641325;4787.736674482867;4802.84731664405;4818.132736107535;4823.686460380064;5775.740091695884;5789.218455508452;5794.101914203306;5798.5071268941765;5810.7966221182905;4641.744704041243;4795.376601041912;4807.4471435784635;4825.396825396825;4827.2035114206465;3035.2563621912773;3052.404781067715;3063.754899608026;3069.1559821048945;3069.769767267464;5262;5273.683578985273;5295.735213239323;5298.675331167208;5335.839924802262;5769.913451298234;5914.2311499504785;5922.970385148046;5939.881202375928;5947.583669143205;5252.921206181911;5258.447862974333;5261.842144735588;5283.418823929364;5285.20721891727;5636.802711905064;5746.339170995389;5756.395578464201;5759.280089988752;5778.85552861165;5612.915806262828;5663.348714897839;5707.258056452634;5721.284839395075;5730.341010783646;5087.949120508748;5088.949110508847;5253.422123566481;5305.063651767;5309.973450132725;4037.454943582579;4039.7175595788285;4040.555538890661;4042.9393559096047;4046.4537287465814;5787.971060144672;5804.622699524517;5828.53371730269;5831.0378787499585;5835.94164058371;5417.945820541901;5559.8610034747835;5581.413951535031;5613.298337707786;5641.555898557911;5556.499915007668;5564.248826408545;5568.693721845176;5619.297587801525;5620.915686264628;5344.839654810362;5460.126379779216;5530.364008139116;5546.584006199632;5565.332160140647;5629.54963602919;5647.237622920853;5650.321961364498;5652.660840349592;5661.773529058792;5496.945030549803;5512.779488820403;5523.585731070106;5533.363663178625;5537.390887002346 04:01:03 INFO - PID 17928 | |5;yui.html;645.4287955159682;693.3551796828947;694.3854688600587;701.2461603775942;701.6071000239864;13300.800487992676;13603.115797473158;13810.102343347675;13960.301984900752;13976.440942362306;13597.796033059512;13814.792778108336;13817.93091034546;13840.723185536282;13841.515546955834;863.8574635185187;888.4003297773993;904.8190361927608;908.1055160666738;911.8632205169245;913.4656226107735;913.584319134792;913.7578541686458;915.1031988651126;917.7522069041355;967.5549247346229;968.6658102954469;968.7093871838421;968.941863488193;971.9368241064308;951.0394501553411;952.105021279998;952.9857052144223;955.350361754007;963.2438535749438;704.2957042957042;704.6793708862456;704.9577025378443;706.9575825450489;708.5217478202193;14038.882271737395;14117.364718587689;14147.929260353736;14293.57119286423;14492.42030318786;13537.323133843367;14164.92917535416;14241.359138838778;14253;14273.57179284623;9984.550695218733;10168.694939151837;10174.135198508062;10182.949085254526;10195.337303075275;2626.3565426470445;2644.444666620012;2666.4933662604044;2672.3853513691765;2681.892724291026;63055.6847215761;63391.049134263485;64413.355866441205;64513.35486645167;65048;9813.901860981441;9890.258230632731;9988.600455981825;10149.441780702133;10222.080012798884;18410.343069123843;18428.170732317078;18600.627987440446;19676.311329103413;20595.176192952415;6405.6797160141805;6616.172978377703;6694.230163531256;6811.444741706177;6819.863602727918;3127.9061628151194;3214.164317277478;3272.4273252180774;3317.336532693471;3434;3304.1574398528223;3368.915777105592;3374.79751214923;3777.508923839883;3928.1750832325533;669.7086767256259;671.8320419895026;677.3734295776387;691.6852831961445;693.2859155070286;452.67592292544174;469.8332092107321;477.3460359307771;480.9302651115569;487.8316980641673;8761.518116503526;8816.823663526822;9081.54592270384;9130.712943340524;9326.207272381787;483.7581209395302;491.70251997541686;508.91602885524213;509.8878246785701;515.2811827500616;3884.6115388461494;3939.6454319110844;4013.2776100301644;4059.594040595917;4096.959030409717;63450.682746585975;64456;66289.6685516579;67007.32992670011;67094;54597.45402546003;54868.17697734537;55038.17442738362;57835.710821445624;58026.41973580295;50435.94768627788;50614.74692626587;50935.7453212739;51564.48435515672;53415.7329213367;8141.267285944294;8275.131111233233;8328.375371847014;8472.703455379033;8573.785655358417;27747.16758497248;28117.57823632688;28426.43147137087;28627.28431789222;29465;32959.340813184084;33473.163170920925;33921.32157356889;34583.4812477808;35553.466697999036;10419.114375278186;12050.156489045683;12192.695182620506;12236.75526489483;12241.510339586317;13059.34703264814;13175.48233631425;13617.387217575431;13820.654483637989;13838.65403364924;12169.513219471122;12217.755644886875;12392.75214495687;12502.749945001231;12555.560555380518;11791.869464613257;12405.62783116508;12419.503219871103;12489.18820276679;12557;11402.885971140515;11467.770644587228;11926.761464770829;12079.214851034654;12144;9343.099084584925;9620;9787.119159275699;9901.801963960825;9906.207503399566;9043.457392556467;9532.428054316762;10364.689059328231;10778;11138 04:01:03 INFO - PID 17928 | __end_tp_report 04:01:03 INFO - PID 17928 | __start_cc_report 04:01:03 INFO - PID 17928 | _x_x_mozilla_cycle_collect,1326 04:01:03 INFO - PID 17928 | __end_cc_report 04:01:03 INFO - PID 17928 | __startTimestamp1491217263730__endTimestamp 04:01:03 INFO - PID 17928 | 04:01:03 INFO - PID 17928 | ------- Summary: start ------- 04:01:03 INFO - PID 17928 | Number of tests: 6 04:01:03 INFO - PID 17928 | 04:01:03 INFO - PID 17928 | [#0] dojo.html Cycles:165 Average:5116.60 Median:5267.10 stddev:609.17 (11.6%) stddev-sans-first:579.31 04:01:03 INFO - PID 17928 | Values: 2642.8 2660.7 2668.5 2691.6 2694.8 5135.8 5205.8 5223.3 5233.5 5245.7 5172.2 5211.7 5218.5 5267.1 5272.3 4548.0 4584.2 4615.7 4677.1 4721.1 4586.1 4615.0 4657.3 4685.6 4705.2 4551.8 4588.7 4611.3 4614.0 4625.4 4565.4 4605.8 4621.9 4640.8 4667.7 4545.9 4582.8 4612.1 4620.0 4654.9 5062.7 5147.2 5148.0 5180.4 5185.4 5598.1 5623.8 5670.8 5674.3 5677.8 5657.2 5657.2 5668.5 5685.3 5685.8 5156.9 5243.4 5258.8 5261.9 5307.8 5734.5 5737.9 5808.7 5814.0 5814.3 5481.3 5505.7 5520.1 5524.3 5527.3 5567.1 5616.5 5627.5 5639.8 5641.2 5443.4 5519.9 5527.4 5542.0 5605.4 5561.2 5564.8 5566.0 5596.8 5625.7 4689.4 4690.0 4695.0 4697.6 4742.8 3998.0 3998.8 4006.0 4008.7 4070.6 4694.1 4704.9 4729.0 4747.3 4748.7 5638.7 5644.0 5670.3 5674.9 5674.9 4589.7 4724.3 4728.6 4732.3 4774.4 4982.0 4990.7 5049.6 5053.1 5060.7 5060.6 5169.7 5187.9 5190.0 5193.1 5568.7 5580.6 5586.9 5613.5 5662.0 5133.5 5174.1 5174.4 5188.8 5209.8 5431.4 5479.2 5486.0 5492.7 5541.4 5573.2 5574.9 5583.8 5618.6 5628.4 5413.6 5419.0 5419.8 5420.5 5421.7 5334.5 5414.3 5415.9 5417.6 5464.2 5333.7 5348.8 5365.0 5396.9 5410.1 5490.8 5499.8 5501.9 5504.9 5532.1 5289.8 5336.4 5353.8 5354.2 5355.5 04:01:03 INFO - PID 17928 | 04:01:03 INFO - PID 17928 | [#1] ext.html Cycles:180 Average:33042.32 Median:29314.41 stddev:51420.03 (175.4%) stddev-sans-first:51506.93 04:01:03 INFO - PID 17928 | Values: 699.3 738.9 759.8 966.6 982.9 25367.9 33256.5 34088.3 34121.8 34125.5 36340.7 36619.0 36800.3 36808.8 36859.8 5374.5 7220.4 7411.0 7411.1 7415.0 5445.0 7068.5 7313.5 7319.5 7331.8 7425.0 7472.4 7482.5 7487.9 7493.1 7397.6 7430.9 7440.0 7464.4 7472.0 7218.6 7268.1 7273.9 7294.6 7295.3 33671.3 33830.0 33927.7 33935.7 33978.8 2572.2 2576.3 2582.6 2583.0 2632.1 23152.9 23161.2 23260.4 23273.0 23390.6 2795.8 2808.6 2815.2 2823.2 2826.0 145887.0 145934.0 146341.0 147559.0 148729.3 40240.6 40414.4 40436.2 40468.8 40487.8 42843.0 42858.1 42880.6 42905.8 42972.1 12998.5 13126.7 13136.2 13139.1 13269.5 8761.4 8908.0 10686.1 10686.2 10686.4 11632.4 11704.7 11729.7 11862.5 11961.1 5108.3 5143.7 5159.4 5204.8 5215.5 861.0 896.7 900.3 912.7 931.2 19588.0 19671.4 20807.7 20943.7 21084.9 986.4 990.0 996.1 998.4 1012.9 10692.2 10773.2 11076.7 11130.6 11238.0 219439.0 221263.0 221301.0 221712.0 221899.0 39540.4 39616.4 39707.2 39748.6 39757.0 1228.2 1253.9 1256.1 1268.1 1275.2 19289.9 19822.1 20156.7 20217.9 20497.4 29301.1 29327.7 29347.6 29408.3 29416.0 214707.0 215966.0 216069.0 216127.0 216169.0 21045.9 21154.8 27451.9 27960.6 28176.0 31506.5 32327.0 32432.4 32512.0 32953.0 24828.5 24874.9 26368.5 27489.6 27585.3 27055.9 27140.9 27352.5 27918.0 28351.7 29888.9 30229.1 30247.0 30350.1 30502.4 26620.5 26752.2 26871.9 27182.6 27742.4 21230.5 21872.6 22150.3 22203.6 22270.6 04:01:03 INFO - PID 17928 | 04:01:03 INFO - PID 17928 | [#2] jquery.html Cycles:180 Average:29217.47 Median:11566.98 stddev:81813.17 (707.3%) stddev-sans-first:82014.09 04:01:03 INFO - PID 17928 | Values: 413.5 414.8 424.2 432.4 440.4 17892.3 18080.8 18648.5 18768.2 18866.9 17740.6 18048.0 19128.1 19277.1 19336.9 5525.1 5611.0 5666.8 5681.5 5685.3 5611.3 5718.1 5718.1 5736.9 5738.2 5413.6 5537.6 5557.7 5630.4 5638.2 5366.8 5596.9 5629.5 5633.0 5634.6 4999.6 5056.2 5057.6 5094.4 5117.4 21416.6 22405.4 22494.7 22517.1 22720.4 1581.4 1586.9 1590.1 1634.3 1636.8 13748.0 13879.5 13894.4 14205.6 14693.3 1894.3 1924.2 1930.2 1951.9 1967.6 82008.0 83936.0 84639.6 85701.0 86508.7 10730.4 11054.6 11081.4 11161.0 11206.8 15347.7 15441.8 15462.5 15464.5 15464.7 7463.4 7713.5 7729.6 7841.6 7884.9 7109.8 7117.8 7306.3 7313.0 7337.7 6622.5 6760.9 6821.8 6833.8 6841.5 2075.9 2086.2 2086.5 2087.9 2093.4 854.7 876.3 878.1 908.8 914.1 16405.5 16848.9 17051.9 17223.3 17772.1 885.5 886.1 895.2 899.1 900.1 9151.6 9467.8 9493.2 9544.3 9576.9 489979.0 493466.0 494647.0 500527.0 502824.0 89120.6 90393.0 90544.5 90819.0 91472.0 1057.7 1077.5 1080.3 1086.4 1094.4 14618.8 14936.2 14942.9 14943.9 15133.4 41667.8 43440.7 43687.3 44033.3 44130.3 55215.0 56068.7 56370.7 56630.2 57844.4 8142.6 8374.2 8622.9 8877.7 11692.2 12816.4 13251.5 13278.4 13291.9 13677.5 11733.6 11908.5 11921.3 12201.5 12214.4 10737.5 10927.1 11045.0 11087.9 11374.5 11675.8 11766.6 12035.3 12169.5 12372.3 11862.4 11923.2 11984.9 12140.5 12429.6 11311.4 11465.5 11566.5 11614.0 11786.6 04:01:03 INFO - PID 17928 | 04:01:03 INFO - PID 17928 | [#3] mootools.html Cycles:180 Average:6164.64 Median:4936.75 stddev:3958.96 (80.2%) stddev-sans-first:3950.73 04:01:03 INFO - PID 17928 | Values: 958.0 1225.5 1277.2 1289.1 1291.0 8467.6 9669.6 9960.4 9986.9 10000.4 9694.7 9780.0 9795.5 9799.2 9800.1 2170.0 2216.1 2216.5 2218.3 2222.9 1878.7 1948.7 2162.8 2242.6 2254.2 2218.6 2233.2 2233.8 2236.6 2240.2 1851.4 2188.6 2241.3 2243.8 2244.2 1871.5 2129.7 2180.3 2191.7 2195.7 9668.1 9851.3 9854.8 9862.3 9866.7 5348.2 5575.8 5597.7 5601.9 5607.1 3115.9 3192.1 3211.8 3228.8 3273.5 994.6 1084.4 1096.6 1109.7 1112.2 14562.3 14601.4 14672.9 14679.9 14679.9 4774.0 4956.8 5020.9 5055.0 5078.0 12046.2 12054.5 12063.1 12069.6 12076.2 5565.6 5612.9 5636.9 5665.9 5677.6 4883.6 4916.8 4957.6 5016.8 5114.4 4141.6 4151.8 4196.6 4235.6 4262.4 1288.6 1299.7 1302.8 1336.4 1343.4 592.4 605.6 617.4 629.7 630.3 5088.0 5765.9 5850.0 5988.7 6178.3 538.1 538.9 544.7 547.4 562.0 3324.5 3330.3 3330.3 3335.8 3456.8 12294.6 13002.9 13009.9 13014.2 13020.3 12341.0 12851.8 12858.5 12870.4 12876.7 9128.9 9228.1 9310.8 9363.6 9374.9 5503.4 5546.1 5553.7 5588.4 5717.8 11128.7 11181.7 11239.1 11364.7 11390.8 11291.4 11758.1 11888.0 11942.2 11944.8 7994.3 8079.1 8086.9 8096.7 8099.8 8453.3 8638.6 8742.8 8768.9 8802.8 7746.8 7944.2 7985.4 8074.9 8213.3 7566.5 7683.7 7782.7 7806.7 7960.0 6526.4 6692.2 6695.1 6700.0 6702.2 4210.7 4710.6 4838.8 4899.7 5231.8 5220.5 5302.4 5320.1 5335.7 5403.9 04:01:03 INFO - PID 17928 | 04:01:03 INFO - PID 17928 | [#4] prototype.html Cycles:180 Average:4665.00 Median:5259.07 stddev:1324.57 (25.2%) stddev-sans-first:1288.39 04:01:03 INFO - PID 17928 | Values: 366.4 384.4 392.5 393.3 395.1 5343.6 5377.6 5388.5 5395.5 5422.0 5310.5 5319.6 5322.4 5322.8 5331.2 4076.1 4106.3 4108.8 4134.3 4163.3 4141.1 4143.9 4144.1 4155.7 4179.9 4132.0 4132.1 4135.1 4139.9 4143.9 4043.1 4111.1 4148.4 4149.3 4152.6 3702.4 3708.0 3709.1 3723.8 3731.1 5196.6 5225.9 5239.1 5241.2 5259.7 4787.6 4880.7 4884.8 4905.3 4911.8 5593.2 5618.9 5629.9 5634.1 5666.7 4172.4 4188.2 4194.9 4201.5 4210.5 5643.6 5754.4 5842.2 5920.4 5933.0 4307.8 4317.8 4324.4 4340.2 4346.3 4413.5 4417.2 4426.8 4432.3 4443.3 4569.5 4577.2 4855.2 4886.6 4907.2 5589.3 5594.9 5599.2 5610.9 5613.5 1518.7 1528.5 1541.0 1541.7 1547.5 929.1 963.2 969.6 1103.8 1109.6 4775.8 4787.7 4802.8 4818.1 4823.7 5775.7 5789.2 5794.1 5798.5 5810.8 4641.7 4795.4 4807.4 4825.4 4827.2 3035.3 3052.4 3063.8 3069.2 3069.8 5262.0 5273.7 5295.7 5298.7 5335.8 5769.9 5914.2 5923.0 5939.9 5947.6 5252.9 5258.4 5261.8 5283.4 5285.2 5636.8 5746.3 5756.4 5759.3 5778.9 5612.9 5663.3 5707.3 5721.3 5730.3 5087.9 5088.9 5253.4 5305.1 5310.0 4037.5 4039.7 4040.6 4042.9 4046.5 5788.0 5804.6 5828.5 5831.0 5835.9 5417.9 5559.9 5581.4 5613.3 5641.6 5556.5 5564.2 5568.7 5619.3 5620.9 5344.8 5460.1 5530.4 5546.6 5565.3 5629.5 5647.2 5650.3 5652.7 5661.8 5496.9 5512.8 5523.6 5533.4 5537.4 04:01:03 INFO - PID 17928 | 04:01:03 INFO - PID 17928 | [#5] yui.html Cycles:180 Average:14470.55 Median:473.59 stddev:17694.94 (3736.3%) stddev-sans-first:17714.13 04:01:03 INFO - PID 17928 | Values: 645.4 693.4 694.4 701.2 701.6 13300.8 13603.1 13810.1 13960.3 13976.4 13597.8 13814.8 13817.9 13840.7 13841.5 863.9 888.4 904.8 908.1 911.9 913.5 913.6 913.8 915.1 917.8 967.6 968.7 968.7 968.9 971.9 951.0 952.1 953.0 955.4 963.2 704.3 704.7 705.0 707.0 708.5 14038.9 14117.4 14147.9 14293.6 14492.4 13537.3 14164.9 14241.4 14253.0 14273.6 9984.6 10168.7 10174.1 10182.9 10195.3 2626.4 2644.4 2666.5 2672.4 2681.9 63055.7 63391.0 64413.4 64513.4 65048.0 9813.9 9890.3 9988.6 10149.4 10222.1 18410.3 18428.2 18600.6 19676.3 20595.2 6405.7 6616.2 6694.2 6811.4 6819.9 3127.9 3214.2 3272.4 3317.3 3434.0 3304.2 3368.9 3374.8 3777.5 3928.2 669.7 671.8 677.4 691.7 693.3 452.7 469.8 477.3 480.9 487.8 8761.5 8816.8 9081.5 9130.7 9326.2 483.8 491.7 508.9 509.9 515.3 3884.6 3939.6 4013.3 4059.6 4097.0 63450.7 64456.0 66289.7 67007.3 67094.0 54597.5 54868.2 55038.2 57835.7 58026.4 50435.9 50614.7 50935.7 51564.5 53415.7 8141.3 8275.1 8328.4 8472.7 8573.8 27747.2 28117.6 28426.4 28627.3 29465.0 32959.3 33473.2 33921.3 34583.5 35553.5 10419.1 12050.2 12192.7 12236.8 12241.5 13059.3 13175.5 13617.4 13820.7 13838.7 12169.5 12217.8 12392.8 12502.7 12555.6 11791.9 12405.6 12419.5 12489.2 12557.0 11402.9 11467.8 11926.8 12079.2 12144.0 9343.1 9620.0 9787.1 9901.8 9906.2 9043.5 9532.4 10364.7 10778.0 11138.0 04:01:03 INFO - PID 17928 | -------- Summary: end -------- 04:01:03 INFO - PID 17928 | 04:01:04 INFO - TEST-INFO | 17928: exit 0 04:01:04 INFO - TEST-OK | dromaeo_css | took 1123935ms 04:01:04 INFO - TEST-START | kraken 04:01:04 INFO - operating with platform_type : linux_ 04:01:04 INFO - Initialising browser for kraken test... 04:01:04 INFO - TEST-INFO | started process 18246 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpemTJfn/profile http://localhost:43410/getInfo.html) 04:01:08 INFO - PID 18246 | __metrics Screen width/height:1600/1200 04:01:08 INFO - PID 18246 | colorDepth:24 04:01:08 INFO - PID 18246 | Browser inner width/height: 1024/697 04:01:08 INFO - PID 18246 | __metrics 04:01:09 INFO - PID 18246 | 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" 04:01:09 INFO - PID 18246 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:01:10 INFO - TEST-INFO | 18246: exit 0 04:01:10 INFO - Browser initialized. 04:01:10 INFO - Running cycle 1/1 for kraken test... 04:01:10 INFO - TEST-INFO | started process 18338 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpemTJfn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:01:22 INFO - PID 18338 | RSS: Main: 149577728 04:01:22 INFO - PID 18338 | 04:01:25 INFO - PID 18338 | Cycle 1(1): loaded http://localhost:43410/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43410/tests/kraken/driver.html?testName=audio-beat-detection) 04:01:26 INFO - PID 18338 | RSS: Main: 203350016 04:01:26 INFO - PID 18338 | 04:01:29 INFO - PID 18338 | Cycle 1(1): loaded http://localhost:43410/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43410/tests/kraken/driver.html?testName=audio-dft) 04:01:29 INFO - PID 18338 | RSS: Main: 184537088 04:01:29 INFO - PID 18338 | 04:01:33 INFO - PID 18338 | Cycle 1(1): loaded http://localhost:43410/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43410/tests/kraken/driver.html?testName=audio-fft) 04:01:33 INFO - PID 18338 | RSS: Main: 267001856 04:01:33 INFO - PID 18338 | 04:01:35 INFO - PID 18338 | Cycle 1(1): loaded http://localhost:43410/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43410/tests/kraken/driver.html?testName=audio-oscillator) 04:01:36 INFO - PID 18338 | RSS: Main: 178184192 04:01:36 INFO - PID 18338 | 04:01:38 INFO - PID 18338 | Cycle 1(1): loaded http://localhost:43410/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43410/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:01:39 INFO - PID 18338 | RSS: Main: 181190656 04:01:39 INFO - PID 18338 | 04:01:42 INFO - PID 18338 | Cycle 1(1): loaded http://localhost:43410/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43410/tests/kraken/driver.html?testName=imaging-darkroom) 04:01:43 INFO - PID 18338 | RSS: Main: 220225536 04:01:43 INFO - PID 18338 | 04:01:46 INFO - PID 18338 | Cycle 1(1): loaded http://localhost:43410/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43410/tests/kraken/driver.html?testName=imaging-desaturate) 04:01:47 INFO - PID 18338 | RSS: Main: 215076864 04:01:47 INFO - PID 18338 | 04:01:50 INFO - PID 18338 | Cycle 1(1): loaded http://localhost:43410/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43410/tests/kraken/driver.html?testName=json-parse-financial) 04:01:50 INFO - PID 18338 | RSS: Main: 216600576 04:01:50 INFO - PID 18338 | 04:01:52 INFO - PID 18338 | Cycle 1(1): loaded http://localhost:43410/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43410/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:01:53 INFO - PID 18338 | RSS: Main: 180432896 04:01:53 INFO - PID 18338 | 04:01:54 INFO - PID 18338 | Cycle 1(1): loaded http://localhost:43410/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43410/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:01:55 INFO - PID 18338 | RSS: Main: 186683392 04:01:55 INFO - PID 18338 | 04:01:57 INFO - PID 18338 | Cycle 1(1): loaded http://localhost:43410/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43410/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:01:58 INFO - PID 18338 | RSS: Main: 196612096 04:01:58 INFO - PID 18338 | 04:02:01 INFO - PID 18338 | Cycle 1(1): loaded http://localhost:43410/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43410/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:02:02 INFO - PID 18338 | RSS: Main: 205643776 04:02:02 INFO - PID 18338 | 04:02:05 INFO - PID 18338 | Cycle 1(1): loaded http://localhost:43410/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43410/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:02:05 INFO - PID 18338 | RSS: Main: 202125312 04:02:05 INFO - PID 18338 | 04:02:07 INFO - PID 18338 | Cycle 1(1): loaded http://localhost:43410/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43410/tests/kraken/driver.html?testName=ai-astar) 04:02:07 INFO - PID 18338 | RSS: Main: 270073856 04:02:07 INFO - PID 18338 | 04:02:07 INFO - PID 18338 | __start_tp_report 04:02:07 INFO - PID 18338 | _x_x_mozilla_page_load 04:02:07 INFO - PID 18338 | _x_x_mozilla_page_load_details 04:02:07 INFO - PID 18338 | |i|pagename|runs| 04:02:07 INFO - PID 18338 | |0;ai-astar;109;112;110;111;113;111;111;111;111;111 04:02:07 INFO - PID 18338 | |1;audio-beat-detection;151;125;126;164;125;126;127;124;157;126 04:02:07 INFO - PID 18338 | |2;audio-dft;167;166;166;167;166;168;166;171;166;166 04:02:07 INFO - PID 18338 | |3;audio-fft;76;79;76;116;76;76;75;82;95;78 04:02:07 INFO - PID 18338 | |4;audio-oscillator;83;84;106;85;85;84;111;84;85;110 04:02:07 INFO - PID 18338 | |5;imaging-gaussian-blur;114;114;114;114;114;114;114;113;113;114 04:02:07 INFO - PID 18338 | |6;imaging-darkroom;150;150;150;150;150;149;151;149;150;150 04:02:07 INFO - PID 18338 | |7;imaging-desaturate;94;95;95;96;94;96;94;95;95;95 04:02:07 INFO - PID 18338 | |8;json-parse-financial;52;52;54;53;53;54;54;54;53;54 04:02:07 INFO - PID 18338 | |9;json-stringify-tinderbox;58;57;57;56;58;57;58;57;56;57 04:02:07 INFO - PID 18338 | |10;stanford-crypto-aes;84;84;82;84;93;91;93;83;83;82 04:02:07 INFO - PID 18338 | |11;stanford-crypto-ccm;135;142;142;150;135;136;143;140;185;138 04:02:07 INFO - PID 18338 | |12;stanford-crypto-pbkdf2;184;193;197;193;201;193;194;195;190;191 04:02:07 INFO - PID 18338 | |13;stanford-crypto-sha256-iterative;73;72;73;78;75;75;73;73;72;70 04:02:07 INFO - PID 18338 | __end_tp_report 04:02:07 INFO - PID 18338 | __start_cc_report 04:02:07 INFO - PID 18338 | _x_x_mozilla_cycle_collect,2039 04:02:07 INFO - PID 18338 | __end_cc_report 04:02:07 INFO - PID 18338 | __startTimestamp1491217327909__endTimestamp 04:02:07 INFO - PID 18338 | 04:02:07 INFO - PID 18338 | ------- Summary: start ------- 04:02:07 INFO - PID 18338 | Number of tests: 14 04:02:07 INFO - PID 18338 | 04:02:07 INFO - PID 18338 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:1.05 (0.9%) stddev-sans-first:0.83 04:02:07 INFO - PID 18338 | Values: 109.0 112.0 110.0 111.0 113.0 111.0 111.0 111.0 111.0 111.0 04:02:07 INFO - PID 18338 | 04:02:07 INFO - PID 18338 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:126.50 stddev:15.67 (12.4%) stddev-sans-first:15.52 04:02:07 INFO - PID 18338 | Values: 151.0 125.0 126.0 164.0 125.0 126.0 127.0 124.0 157.0 126.0 04:02:07 INFO - PID 18338 | 04:02:07 INFO - PID 18338 | [#2] audio-dft Cycles:10 Average:166.90 Median:166.50 stddev:1.60 (1.0%) stddev-sans-first:1.69 04:02:07 INFO - PID 18338 | Values: 167.0 166.0 166.0 167.0 166.0 168.0 166.0 171.0 166.0 166.0 04:02:07 INFO - PID 18338 | 04:02:07 INFO - PID 18338 | [#3] audio-fft Cycles:10 Average:82.90 Median:77.00 stddev:13.06 (17.0%) stddev-sans-first:13.61 04:02:07 INFO - PID 18338 | Values: 76.0 79.0 76.0 116.0 76.0 76.0 75.0 82.0 95.0 78.0 04:02:07 INFO - PID 18338 | 04:02:07 INFO - PID 18338 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:84.00 stddev:12.02 (14.3%) stddev-sans-first:12.33 04:02:07 INFO - PID 18338 | Values: 83.0 84.0 106.0 85.0 85.0 84.0 111.0 84.0 85.0 110.0 04:02:07 INFO - PID 18338 | 04:02:07 INFO - PID 18338 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:02:07 INFO - PID 18338 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 114.0 113.0 113.0 114.0 04:02:07 INFO - PID 18338 | 04:02:07 INFO - PID 18338 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:150.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 04:02:07 INFO - PID 18338 | Values: 150.0 150.0 150.0 150.0 150.0 149.0 151.0 149.0 150.0 150.0 04:02:07 INFO - PID 18338 | 04:02:07 INFO - PID 18338 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 04:02:07 INFO - PID 18338 | Values: 94.0 95.0 95.0 96.0 94.0 96.0 94.0 95.0 95.0 95.0 04:02:07 INFO - PID 18338 | 04:02:07 INFO - PID 18338 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.73 04:02:07 INFO - PID 18338 | Values: 52.0 52.0 54.0 53.0 53.0 54.0 54.0 54.0 53.0 54.0 04:02:07 INFO - PID 18338 | 04:02:07 INFO - PID 18338 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:57.00 stddev:0.74 (1.3%) stddev-sans-first:0.71 04:02:07 INFO - PID 18338 | Values: 58.0 57.0 57.0 56.0 58.0 57.0 58.0 57.0 56.0 57.0 04:02:07 INFO - PID 18338 | 04:02:07 INFO - PID 18338 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:84.00 stddev:4.53 (5.4%) stddev-sans-first:4.76 04:02:07 INFO - PID 18338 | Values: 84.0 84.0 82.0 84.0 93.0 91.0 93.0 83.0 83.0 82.0 04:02:07 INFO - PID 18338 | 04:02:07 INFO - PID 18338 | [#11] stanford-crypto-ccm Cycles:10 Average:144.60 Median:142.00 stddev:14.91 (10.5%) stddev-sans-first:15.40 04:02:07 INFO - PID 18338 | Values: 135.0 142.0 142.0 150.0 135.0 136.0 143.0 140.0 185.0 138.0 04:02:07 INFO - PID 18338 | 04:02:07 INFO - PID 18338 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.10 Median:193.50 stddev:4.46 (2.3%) stddev-sans-first:3.30 04:02:07 INFO - PID 18338 | Values: 184.0 193.0 197.0 193.0 201.0 193.0 194.0 195.0 190.0 191.0 04:02:07 INFO - PID 18338 | 04:02:07 INFO - PID 18338 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:73.00 stddev:2.17 (3.0%) stddev-sans-first:2.30 04:02:07 INFO - PID 18338 | Values: 73.0 72.0 73.0 78.0 75.0 75.0 73.0 73.0 72.0 70.0 04:02:07 INFO - PID 18338 | -------- Summary: end -------- 04:02:07 INFO - PID 18338 | 04:02:09 INFO - TEST-INFO | 18338: exit 0 04:02:09 INFO - TEST-OK | kraken | took 64439ms 04:02:09 INFO - SUITE-END | took 1188s 04:02:09 INFO - Completed test suite (00:19:48) 04:02:09 INFO - javascript benchmark 04:02:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6627.8937566537425, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2642.828216165949, 2660.6807183138026, 2668.533006723823, 2691.596260560917, 2694.8248363856337, 5135.8202462913805, 5205.791768329272, 5223.294855194552, 5233.450487698789, 5245.711485868281, 5172.224166375046, 5211.687298762077, 5218.47815218478, 5267.1045922193225, 5272.288241087452, 4547.977260113695, 4584.151931892602, 4615.723056616597, 4677.111348843709, 4721.079389519045, 4586.105709386671, 4615.030843522864, 4657.324687920266, 4685.62514998801, 4705.176594096037, 4551.817927282905, 4588.7476188809605, 4611.26219804833, 4614.0, 4625.421822272216, 4565.406497155382, 4605.769711514445, 4621.861344159681, 4640.791164397577, 4667.743274119922, 4545.885026991178, 4582.793774280132, 4612.0545288215835, 4620.029793743318, 4654.930176047362, 5062.67092638981, 5147.150720131174, 5148.0, 5180.352455943007, 5185.351831021122, 5598.1322894951345, 5623.775048998035, 5670.773169073233, 5674.290713660793, 5677.829665110054, 5657.20799088128, 5657.23627310312, 5668.489835914746, 5685.289338832646, 5685.800996965087, 5156.871078223075, 5243.449437809051, 5258.842234732964, 5261.894762104736, 5307.787688492494, 5734.541236701054, 5737.913931291034, 5808.680522571299, 5814.04068328721, 5814.302283725895, 5481.260029895992, 5505.724713764296, 5520.06158952979, 5524.254225679482, 5527.336719593674, 5567.081431563827, 5616.494515493543, 5627.465390787868, 5639.774409023676, 5641.210230567724, 5443.401225865152, 5519.862003449946, 5527.44725527444, 5542.0301447246575, 5605.383407825136, 5561.193626924073, 5564.777408903679, 5566.025945459528, 5596.832095037155, 5625.746841392147, 4689.366935463737, 4689.976550117228, 4695.037517308943, 4697.553732395417, 4742.786574604151, 3998.0, 3998.820053097618, 4006.0, 4008.6993475489453, 4070.592940705965, 4694.131585656664, 4704.9059018819435, 4728.976355118202, 4747.335373047776, 4748.715077095385, 5638.689872057076, 5644.01229784786, 5670.262865827499, 5674.858128546819, 5674.943250567524, 4589.65577581676, 4724.314974328703, 4728.645351598575, 4732.266498692708, 4774.427068751703, 4982.028504441599, 4990.650654454226, 5049.646524743306, 5053.1157047516535, 5060.721660308718, 5060.569851562658, 5169.741512924264, 5187.92218116721, 5190.0, 5193.117170081171, 5568.721563921868, 5580.5535557156145, 5586.944130558642, 5613.522850557748, 5662.0, 5133.512316330092, 5174.14626586624, 5174.404943431403, 5188.818391356435, 5209.843704688714, 5431.375391829832, 5479.205515200353, 5486.0, 5492.697901615449, 5541.3904470507405, 5573.21974923503, 5574.9442505574425, 5583.804566840141, 5618.550515958632, 5628.352739434854, 5413.648112872651, 5419.0, 5419.783208671609, 5420.457954204706, 5421.701806400528, 5334.5198932094745, 5414.307464201524, 5415.891682166413, 5417.566594672496, 5464.23500709893, 5333.679979201261, 5348.839534813962, 5364.9731751341, 5396.946030539644, 5410.1343784994215, 5490.780368785364, 5499.807506737245, 5501.889962200814, 5504.862378440571, 5532.1425179097305, 5289.761960711854, 5336.359636843604, 5353.75908084145, 5354.196870469461, 5355.464453554613], "value": 5071.537408392271, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.2518005733867, 738.8670039392908, 759.7834617134116, 966.6423423333364, 982.9164521015713, 25367.873160634193, 33256.501152482735, 34088.31823363534, 34121.82939085301, 34125.48811767819, 36340.7280745174, 36619.0, 36800.26399472009, 36808.81595592025, 36859.815700921456, 5374.462553744634, 7220.422366210703, 7410.962945185293, 7411.110666719974, 7414.962925185367, 5445.047116754572, 7068.505204635678, 7313.451491138159, 7319.524230925, 7331.816704582401, 7424.9628751856435, 7472.4395670324675, 7482.51363661363, 7487.850242995137, 7493.063367079115, 7397.63011849408, 7430.925690743077, 7440.0, 7464.4028477722195, 7472.0, 7218.6390680465765, 7268.0914885639295, 7273.927260727378, 7294.635268236567, 7295.270472952662, 33671.326573468636, 33830.0, 33927.6607233927, 33935.66064339374, 33978.830105849556, 2572.189760225523, 2576.30439781258, 2582.6384306197147, 2583.0, 2632.0524611140168, 23152.884235578713, 23161.189358372376, 23260.41848953773, 23273.0, 23390.64914026291, 2795.7623601993855, 2808.578713193017, 2815.2398852309966, 2823.181277429543, 2826.0, 145887.0, 145934.0, 146341.0, 147559.0, 148729.2563537186, 40240.59759402368, 40414.39378409326, 40436.191276174315, 40468.797656011535, 40487.797561012005, 42843.0, 42858.14283714308, 42880.571194288284, 42905.78547107307, 42972.14055718868, 12998.545050923172, 13126.737465250833, 13136.211827290394, 13139.080264381402, 13269.535566255328, 8761.38670293086, 8908.0, 10686.145108391465, 10686.198535109897, 10686.358818470917, 11632.360220187971, 11704.70738231534, 11729.706757331134, 11862.525498979945, 11961.129328960988, 5108.259302401131, 5143.742812859342, 5159.432462429129, 5204.8178313758835, 5215.504527069922, 860.9526476043877, 896.7309807057987, 900.3292547052357, 912.7444315591645, 931.1666058877403, 19587.984463185014, 19671.409857704293, 20807.68788468174, 20943.68584471234, 21084.89457552733, 986.40815510693, 989.9802003960025, 996.1383403356045, 998.3959704378891, 1012.9088382045651, 10692.198085143646, 10773.245872788986, 11076.667699969013, 11130.554777808797, 11238.044766194802, 219439.0, 221263.0, 221301.0, 221712.0, 221899.0, 39540.406893896616, 39616.405753913714, 39707.2058558833, 39748.60251397507, 39757.0, 1228.2323547782637, 1253.943572539238, 1256.1395444120624, 1268.055298802398, 1275.2157423184674, 19289.90355048216, 19822.108005139515, 20156.697649535563, 20217.89891050535, 20497.38507844767, 29301.120966371043, 29327.70672293335, 29347.55978660279, 29408.26479338034, 29416.0, 214707.0, 215966.0, 216069.0, 216127.0, 216169.0, 21045.89477052605, 21154.78845211528, 27451.862740686167, 27960.580591291553, 28176.0, 31506.527402089447, 32327.0, 32432.35135297328, 32512.0, 32953.0, 24828.50342993166, 24874.875625621757, 26368.472630547665, 27489.587656184773, 27585.310367240978, 27055.86472067706, 27140.864295679185, 27352.452950941268, 27918.0, 28351.71648283491, 29888.85055574708, 30229.09312720622, 30247.0, 30350.089497315115, 30502.389952201276, 26620.46759064769, 26752.19743407701, 26871.865640672455, 27182.592261116493, 27742.44515109646, 21230.46923826917, 21872.562548749254, 22150.33548993533, 22203.555928881655, 22270.554588908457], "value": 14508.256714703484, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.52238164919527, 414.8154071438211, 424.19614829897347, 432.4119197890868, 440.3856620015079, 17892.31615257712, 18080.819191808096, 18648.533786655305, 18768.249270029184, 18866.90566547167, 17740.645187096252, 18048.0, 19128.13923373448, 19277.132529036193, 19336.903315483403, 5525.060739674245, 5610.971945140279, 5666.829995100154, 5681.545476361881, 5685.346185188694, 5611.270534830466, 5718.142278658193, 5718.142278658213, 5736.856578585548, 5738.196652468658, 5413.593980451482, 5537.58468114891, 5557.749901254453, 5630.380658127603, 5638.154276858463, 5366.838994830161, 5596.916046259309, 5629.4652008059165, 5633.042382794914, 5634.6337488063145, 4999.575036121934, 5056.216286475602, 5057.620678449094, 5094.4141423736, 5117.385913690344, 21416.571668566696, 22405.43986400337, 22494.66258006131, 22517.09931602734, 22720.43198920024, 1581.430684953416, 1586.8968517046355, 1590.1492701404693, 1634.313588292908, 1636.8035835699673, 13748.0, 13879.514217002457, 13894.4442222312, 14205.573832785032, 14693.26533673312, 1894.2896413844808, 1924.1533725160884, 1930.2279088364626, 1951.8731282466736, 1967.5572996075912, 82008.0, 83936.0, 84639.6144154233, 85701.0, 86508.70236946514, 10730.409827459565, 11054.613088541862, 11081.445927703744, 11161.0, 11206.831897521544, 15347.697845323291, 15441.768373474408, 15462.458813941457, 15464.458743943907, 15464.690706185813, 7463.365613922769, 7713.4600577959, 7729.613519324012, 7841.607919604111, 7884.881726774103, 7109.786706398816, 7117.75087871922, 7306.305900939402, 7313.049303590606, 7337.669804858794, 6622.536422450478, 6760.850655388595, 6821.795346139624, 6833.760818371433, 6841.486888483384, 2075.865068770525, 2086.155107181594, 2086.4888102415007, 2087.9269225577336, 2093.445237012193, 854.6538651846013, 876.3077169036517, 878.1438097854541, 908.8318661047728, 914.1270087066836, 16405.507834764976, 16848.915755421145, 17051.91474042622, 17223.31106755716, 17772.111394430485, 885.5041176940933, 886.1271647427279, 895.1719659315238, 899.1098812175899, 900.1223806788329, 9151.575758175908, 9467.810643787223, 9493.19307858826, 9544.284178686488, 9576.850777906695, 489979.0, 493466.0, 494647.0, 500527.0, 502824.0, 89120.55439722759, 90393.0, 90544.54727726319, 90819.0, 91472.0, 1057.7038429239826, 1077.4828082520278, 1080.3193987787643, 1086.4459125845876, 1094.43089593411, 14618.780718289447, 14936.178510182044, 14942.925285373503, 14943.925280373529, 15133.394664213749, 41667.7916610415, 43440.69677909668, 43687.344689830315, 44033.339499908165, 44130.33804492871, 55215.0, 56068.71965640146, 56370.718146409, 56630.15054774264, 57844.421555783905, 8142.615755321491, 8374.204450577185, 8622.870656940277, 8877.689280875138, 11692.240004399688, 12816.359182041047, 13251.46994120263, 13278.402471888981, 13291.933540332237, 13677.452901883813, 11733.589324373606, 11908.464119114833, 11921.34432606215, 12201.511939522676, 12214.38928053576, 10737.516811743333, 10927.07119894786, 11044.968586466042, 11087.94456027747, 11374.488148033193, 11675.766484670428, 11766.647000589996, 12035.338056406981, 12169.513219471477, 12372.319522426353, 11862.406879656155, 11923.165378423428, 11984.940075299568, 12140.453679584263, 12429.627111186679, 11311.434428278717, 11465.484053217791, 11566.537338506701, 11614.025615645192, 11786.646400607995], "value": 9202.2484162049, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [957.9760505987346, 1225.4975460061373, 1277.2400421749055, 1289.1040726694946, 1291.0059254374132, 8467.618957146928, 9669.613215471381, 9960.402375857453, 9986.850197247048, 10000.399976001445, 9694.709158725233, 9780.0, 9795.461249631267, 9799.216062714984, 9800.117989380955, 2169.9692645993146, 2216.1246307708448, 2216.512367279196, 2218.256883943881, 2222.866628002325, 1878.7181922711634, 1948.6979518174705, 2162.8053475187307, 2242.6411774116145, 2254.2448279826276, 2218.6450167973126, 2233.1848875160613, 2233.7877901599322, 2236.642137258039, 2240.2383189715492, 1851.3982955539504, 2188.627933251343, 2241.3276017194776, 2243.798058174772, 2244.1584405847807, 1871.504051426373, 2129.7018417421573, 2180.269609680759, 2191.704119943803, 2195.6596727507263, 9668.081532254424, 9851.310408271424, 9854.753631159207, 9862.30963832532, 9866.65466708669, 5348.224507446398, 5575.804846830341, 5597.6641401516035, 5601.943980560224, 5607.102863541854, 3115.875364985398, 3192.1062102611304, 3211.807291562514, 3228.757843161749, 3273.5253388258807, 994.6419289055934, 1084.4198353880715, 1096.550414330129, 1109.672646569264, 1112.1603189591888, 14562.344694488773, 14601.415943362254, 14672.853271467255, 14679.926600366929, 14679.926600367036, 4773.997460533327, 4956.753326571102, 5020.949790502122, 5055.0, 5078.0, 12046.216995895238, 12054.457549410297, 12063.095267854771, 12069.57756478519, 12076.154669173073, 5565.610407271533, 5612.887742245132, 5636.85907852307, 5665.858353541194, 5677.602567820213, 4883.560479556857, 4916.754162291871, 4957.603391728653, 5016.772493111301, 5114.3862736471865, 4141.562904449493, 4151.7924103794685, 4196.643285320782, 4235.618794308527, 4262.360645903077, 1288.606974872654, 1299.6685845109437, 1302.8176055352258, 1336.398620620705, 1343.3887581150552, 592.3632095497358, 605.6214865708932, 617.4473845907887, 629.6820105846609, 630.334996578614, 5087.97456012725, 5765.88468230633, 5850.034744267234, 5988.730507127189, 6178.320384757673, 538.1013707109137, 538.8561958538824, 544.6759178288912, 547.370523897521, 561.9690916999523, 3324.451465508164, 3330.2506935939705, 3330.3339332133187, 3335.849886755102, 3456.827158642058, 12294.631161065183, 13002.934985325013, 13009.869901301056, 13014.21914685122, 13020.28388438645, 12341.0, 12851.807222891664, 12858.549950751678, 12870.356482176041, 12876.742465150832, 9128.90871091294, 9228.123328283802, 9310.767230819283, 9363.578638961262, 9374.90625093754, 5503.422140675171, 5546.112621980464, 5553.694546799965, 5588.385277619377, 5717.771289148387, 11128.666140015812, 11181.664550063511, 11239.100871930063, 11364.715882102682, 11390.829137563109, 11291.435428228391, 11758.118141139277, 11888.04895608332, 11942.223755455867, 11944.820827687417, 7994.320482759031, 8079.111297757359, 8086.9191308086165, 8096.676132954852, 8099.83800324002, 8453.331604227604, 8638.611262493328, 8742.82514349722, 8768.868466972874, 8802.823943521222, 7746.767596972099, 7944.165862584346, 7985.361171106181, 8074.87887681697, 8213.260806527442, 7566.508176968699, 7683.692652293846, 7782.688692452239, 7806.687732490864, 7960.0, 6526.379993900572, 6692.163479565054, 6695.0626912231355, 6699.9665001674675, 6702.162229721285, 4210.7473551587, 4710.646701497333, 4838.806447742191, 4899.721629442326, 5231.8168864089575, 5220.504052115043, 5302.39022512416, 5320.068987927175, 5335.706536140394, 5403.918941215807], "value": 4603.299147523718, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.4027634955023, 384.40033547665627, 392.4603669953814, 393.2999261314859, 395.1464835954337, 5343.599230057746, 5377.623566350357, 5388.515033646971, 5395.514403703666, 5422.0, 5310.522053015228, 5319.590308568223, 5322.414534401213, 5322.760475778589, 5331.173668081444, 4076.1194624985055, 4106.281400754856, 4108.753474791522, 4134.338505839067, 4163.292240319145, 4141.068259641586, 4143.854965076223, 4144.129732756125, 4155.732501587015, 4179.916401671965, 4131.97132795525, 4132.111596006858, 4135.09028013838, 4139.855105071323, 4143.8964025899295, 4043.1307268937026, 4111.116110036357, 4148.377743338493, 4149.315362965107, 4152.584741525853, 3702.407614781622, 3707.9814600926825, 3709.1083547391027, 3723.7579557328686, 3731.067233191702, 5196.558292545138, 5225.921611175835, 5239.1093514102695, 5241.240020197089, 5259.684418934838, 4787.593054590364, 4880.682755620874, 4884.804607815719, 4905.337779399771, 4911.838790931978, 5593.216949627055, 5618.887622247573, 5629.915551266734, 5634.098544232944, 5666.744996475169, 4172.374143878443, 4188.162367526507, 4194.895127621803, 4201.4538110045805, 4210.51579068408, 5643.589102724319, 5754.367019627837, 5842.211301474289, 5920.378360272195, 5933.0, 4307.806148723315, 4317.762523061199, 4324.372965919924, 4340.197063543254, 4346.326319420495, 4413.514513403523, 4417.182821178092, 4426.84506042287, 4432.335149727567, 4443.333499974965, 4569.451665800058, 4577.176108300538, 4855.150348688965, 4886.60907127429, 4907.2393778964315, 5589.301337332833, 5594.85305512369, 5599.188117722907, 5610.943890561124, 5613.522850557748, 1518.7494063479623, 1528.5414375687249, 1541.0, 1541.714782765192, 1547.4893285216076, 929.1266209762937, 963.210167662524, 969.5733877094056, 1103.7626910214342, 1109.6338208391212, 4775.808967641325, 4787.736674482867, 4802.84731664405, 4818.132736107535, 4823.686460380064, 5775.740091695884, 5789.218455508452, 5794.101914203306, 5798.5071268941765, 5810.7966221182905, 4641.744704041243, 4795.376601041912, 4807.4471435784635, 4825.396825396825, 4827.2035114206465, 3035.2563621912773, 3052.404781067715, 3063.754899608026, 3069.1559821048945, 3069.769767267464, 5262.0, 5273.683578985273, 5295.735213239323, 5298.675331167208, 5335.839924802262, 5769.913451298234, 5914.2311499504785, 5922.970385148046, 5939.881202375928, 5947.583669143205, 5252.921206181911, 5258.447862974333, 5261.842144735588, 5283.418823929364, 5285.20721891727, 5636.802711905064, 5746.339170995389, 5756.395578464201, 5759.280089988752, 5778.85552861165, 5612.915806262828, 5663.348714897839, 5707.258056452634, 5721.284839395075, 5730.341010783646, 5087.949120508748, 5088.949110508847, 5253.422123566481, 5305.063651767, 5309.973450132725, 4037.454943582579, 4039.7175595788285, 4040.555538890661, 4042.9393559096047, 4046.4537287465814, 5787.971060144672, 5804.622699524517, 5828.53371730269, 5831.0378787499585, 5835.94164058371, 5417.945820541901, 5559.8610034747835, 5581.413951535031, 5613.298337707786, 5641.555898557911, 5556.499915007668, 5564.248826408545, 5568.693721845176, 5619.297587801525, 5620.915686264628, 5344.839654810362, 5460.126379779216, 5530.364008139116, 5546.584006199632, 5565.332160140647, 5629.54963602919, 5647.237622920853, 5650.321961364498, 5652.660840349592, 5661.773529058792, 5496.945030549803, 5512.779488820403, 5523.585731070106, 5533.363663178625, 5537.390887002346], "value": 4265.209206124242, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.4287955159682, 693.3551796828947, 694.3854688600587, 701.2461603775942, 701.6071000239864, 13300.800487992676, 13603.115797473158, 13810.102343347675, 13960.301984900752, 13976.440942362306, 13597.796033059512, 13814.792778108336, 13817.93091034546, 13840.723185536282, 13841.515546955834, 863.8574635185187, 888.4003297773993, 904.8190361927608, 908.1055160666738, 911.8632205169245, 913.4656226107735, 913.584319134792, 913.7578541686458, 915.1031988651126, 917.7522069041355, 967.5549247346229, 968.6658102954469, 968.7093871838421, 968.941863488193, 971.9368241064308, 951.0394501553411, 952.105021279998, 952.9857052144223, 955.350361754007, 963.2438535749438, 704.2957042957042, 704.6793708862456, 704.9577025378443, 706.9575825450489, 708.5217478202193, 14038.882271737395, 14117.364718587689, 14147.929260353736, 14293.57119286423, 14492.42030318786, 13537.323133843367, 14164.92917535416, 14241.359138838778, 14253.0, 14273.57179284623, 9984.550695218733, 10168.694939151837, 10174.135198508062, 10182.949085254526, 10195.337303075275, 2626.3565426470445, 2644.444666620012, 2666.4933662604044, 2672.3853513691765, 2681.892724291026, 63055.6847215761, 63391.049134263485, 64413.355866441205, 64513.35486645167, 65048.0, 9813.901860981441, 9890.258230632731, 9988.600455981825, 10149.441780702133, 10222.080012798884, 18410.343069123843, 18428.170732317078, 18600.627987440446, 19676.311329103413, 20595.176192952415, 6405.6797160141805, 6616.172978377703, 6694.230163531256, 6811.444741706177, 6819.863602727918, 3127.9061628151194, 3214.164317277478, 3272.4273252180774, 3317.336532693471, 3434.0, 3304.1574398528223, 3368.915777105592, 3374.79751214923, 3777.508923839883, 3928.1750832325533, 669.7086767256259, 671.8320419895026, 677.3734295776387, 691.6852831961445, 693.2859155070286, 452.67592292544174, 469.8332092107321, 477.3460359307771, 480.9302651115569, 487.8316980641673, 8761.518116503526, 8816.823663526822, 9081.54592270384, 9130.712943340524, 9326.207272381787, 483.7581209395302, 491.70251997541686, 508.91602885524213, 509.8878246785701, 515.2811827500616, 3884.6115388461494, 3939.6454319110844, 4013.2776100301644, 4059.594040595917, 4096.959030409717, 63450.682746585975, 64456.0, 66289.6685516579, 67007.32992670011, 67094.0, 54597.45402546003, 54868.17697734537, 55038.17442738362, 57835.710821445624, 58026.41973580295, 50435.94768627788, 50614.74692626587, 50935.7453212739, 51564.48435515672, 53415.7329213367, 8141.267285944294, 8275.131111233233, 8328.375371847014, 8472.703455379033, 8573.785655358417, 27747.16758497248, 28117.57823632688, 28426.43147137087, 28627.28431789222, 29465.0, 32959.340813184084, 33473.163170920925, 33921.32157356889, 34583.4812477808, 35553.466697999036, 10419.114375278186, 12050.156489045683, 12192.695182620506, 12236.75526489483, 12241.510339586317, 13059.34703264814, 13175.48233631425, 13617.387217575431, 13820.654483637989, 13838.65403364924, 12169.513219471122, 12217.755644886875, 12392.75214495687, 12502.749945001231, 12555.560555380518, 11791.869464613257, 12405.62783116508, 12419.503219871103, 12489.18820276679, 12557.0, 11402.885971140515, 11467.770644587228, 11926.761464770829, 12079.214851034654, 12144.0, 9343.099084584925, 9620.0, 9787.119159275699, 9901.801963960825, 9906.207503399566, 9043.457392556467, 9532.428054316762, 10364.689059328231, 10778.0, 11138.0], "value": 6376.186261277932, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 110.0, 111.0, 113.0, 111.0, 111.0, 111.0, 111.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 126.0, 164.0, 125.0, 126.0, 127.0, 124.0, 157.0, 126.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 166.0, 167.0, 166.0, 168.0, 166.0, 171.0, 166.0, 166.0], "value": 166.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 76.0, 116.0, 76.0, 76.0, 75.0, 82.0, 95.0, 78.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 106.0, 85.0, 85.0, 84.0, 111.0, 84.0, 85.0, 110.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 150.0, 150.0, 149.0, 151.0, 149.0, 150.0, 150.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 96.0, 94.0, 96.0, 94.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 54.0, 53.0, 53.0, 54.0, 54.0, 54.0, 53.0, 54.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 56.0, 58.0, 57.0, 58.0, 57.0, 56.0, 57.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 82.0, 84.0, 93.0, 91.0, 93.0, 83.0, 83.0, 82.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 142.0, 142.0, 150.0, 135.0, 136.0, 143.0, 140.0, 185.0, 138.0], "value": 144.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 193.0, 197.0, 193.0, 201.0, 193.0, 194.0, 195.0, 190.0, 191.0], "value": 193.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 73.0, 78.0, 75.0, 75.0, 73.0, 73.0, 72.0, 70.0], "value": 73.4, "unit": "score"}]}]} 04:02:09 INFO - Return code: 0 04:02:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:02:09 ERROR - # TBPL SUCCESS # 04:02:09 INFO - Running post-action listener: _resource_record_post_action 04:02:09 INFO - [mozharness: 2017-04-03 11:02:09.720546Z] Finished run-tests step (success) 04:02:09 INFO - Running post-run listener: _resource_record_post_run 04:02:09 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 0; Write bytes: 365486080; Read time: 0; Write time: 234488 04:02:09 INFO - TinderboxPrint: CPU usage
13.0% 04:02:09 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:02:09 INFO - TinderboxPrint: I/O write bytes / time
365,486,080 / 234,488 04:02:09 INFO - TinderboxPrint: CPU idle
8,364.4 (87.0%) 04:02:09 INFO - TinderboxPrint: CPU user
1,204.8 (12.5%) 04:02:09 INFO - TinderboxPrint: Swap in / out
0 / 0 04:02:09 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106876928; Read time: 0; Write time: 82300 04:02:09 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 258609152; Read time: 0; Write time: 152188 04:02:10 INFO - Running post-run listener: _upload_blobber_files 04:02:10 INFO - Blob upload gear active. 04:02:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:02:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:02:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:02:10 INFO - (blobuploader) - INFO - Open directory for files ... 04:02:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:02:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:02:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:12 INFO - (blobuploader) - INFO - Done attempting. 04:02:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:02:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:02:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:16 INFO - (blobuploader) - INFO - Done attempting. 04:02:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:02:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:02:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:17 INFO - (blobuploader) - INFO - Done attempting. 04:02:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:02:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:02:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:18 INFO - (blobuploader) - INFO - Done attempting. 04:02:18 INFO - (blobuploader) - INFO - Iteration through files over. 04:02:18 INFO - Return code: 0 04:02:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:02:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:02:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ccf2f6bd676e2b8fbdde4b81c28e575396f5e7f63857d091e8c405ee2c4a976b25c06c160bf4adfbf17d1bca10d9f8c7f150650c13e68f96ea0e2dada6b4f9c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee58a01c7dba981695011a325d8b7c3a6e13e8d069219fe9fcf89b41d571da1ff9fee9213b094d30dbd6ec27db610fdade4bda9d10545a8794d75b0e7842d840", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ef88eacfad5a06cdbf43fd2edc77fccddb5d802d7a913a5fc93402a8d3abd61dd879f63292411aca0f72c5605a334715b7fa384fd8dbc008a220a1b2b2f6548", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/96ee7996f3babb8c322be0b1a8e482532d3a839dd7d94230f8af276059721c4195b8f3e76f52ffd114f95ec8944ea03089b827d2c9f6eb928c533a138502c6d3"} 04:02:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:02:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:02:18 INFO - Contents: 04:02:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ccf2f6bd676e2b8fbdde4b81c28e575396f5e7f63857d091e8c405ee2c4a976b25c06c160bf4adfbf17d1bca10d9f8c7f150650c13e68f96ea0e2dada6b4f9c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee58a01c7dba981695011a325d8b7c3a6e13e8d069219fe9fcf89b41d571da1ff9fee9213b094d30dbd6ec27db610fdade4bda9d10545a8794d75b0e7842d840", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ef88eacfad5a06cdbf43fd2edc77fccddb5d802d7a913a5fc93402a8d3abd61dd879f63292411aca0f72c5605a334715b7fa384fd8dbc008a220a1b2b2f6548", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/96ee7996f3babb8c322be0b1a8e482532d3a839dd7d94230f8af276059721c4195b8f3e76f52ffd114f95ec8944ea03089b827d2c9f6eb928c533a138502c6d3"} 04:02:18 INFO - Running post-run listener: copy_logs_to_upload_dir 04:02:18 INFO - Copying logs to upload dir... 04:02:18 INFO - mkdir: /builds/slave/test/build/upload/logs 04:02:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.596583 ========= master_lag: 0.30 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-04-03 04:02:18.027870) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 04:02:18.031174) ========= 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=4300f881736b422476174874000001bc-1491215954.457309-663485225 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/ccf2f6bd676e2b8fbdde4b81c28e575396f5e7f63857d091e8c405ee2c4a976b25c06c160bf4adfbf17d1bca10d9f8c7f150650c13e68f96ea0e2dada6b4f9c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee58a01c7dba981695011a325d8b7c3a6e13e8d069219fe9fcf89b41d571da1ff9fee9213b094d30dbd6ec27db610fdade4bda9d10545a8794d75b0e7842d840", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ef88eacfad5a06cdbf43fd2edc77fccddb5d802d7a913a5fc93402a8d3abd61dd879f63292411aca0f72c5605a334715b7fa384fd8dbc008a220a1b2b2f6548", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/96ee7996f3babb8c322be0b1a8e482532d3a839dd7d94230f8af276059721c4195b8f3e76f52ffd114f95ec8944ea03089b827d2c9f6eb928c533a138502c6d3"} build_url:https://queue.taskcluster.net/v1/task/KJ-UiFRtRM6KsF05QxFqMA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011320 build_url: 'https://queue.taskcluster.net/v1/task/KJ-UiFRtRM6KsF05QxFqMA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ccf2f6bd676e2b8fbdde4b81c28e575396f5e7f63857d091e8c405ee2c4a976b25c06c160bf4adfbf17d1bca10d9f8c7f150650c13e68f96ea0e2dada6b4f9c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee58a01c7dba981695011a325d8b7c3a6e13e8d069219fe9fcf89b41d571da1ff9fee9213b094d30dbd6ec27db610fdade4bda9d10545a8794d75b0e7842d840", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ef88eacfad5a06cdbf43fd2edc77fccddb5d802d7a913a5fc93402a8d3abd61dd879f63292411aca0f72c5605a334715b7fa384fd8dbc008a220a1b2b2f6548", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/96ee7996f3babb8c322be0b1a8e482532d3a839dd7d94230f8af276059721c4195b8f3e76f52ffd114f95ec8944ea03089b827d2c9f6eb928c533a138502c6d3"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 04:02:18.085367) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 04:02:18.086033) ========= 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=4300f881736b422476174874000001bc-1491215954.457309-663485225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004660 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 04:02:18.138816) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 04:02:18.139140) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 04:02:18.140373) ========= ========= Total master_lag: 0.46 =========