builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1491257955.53 results: success (0) revision: 2a593ea93f6637df49eedc998b1f5ae4781a0f56 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 15:19:15.531599) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 15:19:15.532054) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 15:19:15.532329) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 15:19:15.547289) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 15:19:15.547605) ========= 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=0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-03 15:19:15-- 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% 40.9M=0s 2017-04-03 15:19:15 (40.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122018 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 15:19:15.685510) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 15:19:15.686251) ========= 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=0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018028 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 15:19:15.736556) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-03 15:19:15.736963) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2a593ea93f6637df49eedc998b1f5ae4781a0f56 --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 2a593ea93f6637df49eedc998b1f5ae4781a0f56 --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=0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-03 15:19:16,087 truncating revision to first 12 chars 2017-04-03 15:19:16,087 Setting DEBUG logging. 2017-04-03 15:19:16,087 attempt 1/10 2017-04-03 15:19:16,087 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2a593ea93f66?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-03 15:19:17,314 unpacking tar archive at: mozilla-central-2a593ea93f66/testing/mozharness/ program finished with exit code 0 elapsedTime=1.540341 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-03 15:19:17.290698) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 15:19:17.291030) ========= script_repo_revision: 2a593ea93f6637df49eedc998b1f5ae4781a0f56 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 15:19:17.291407) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 15:19:17.291666) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 15:19:17.301161) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-04-03 15:19:17.301564) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:19:17 INFO - MultiFileLogger online at 20170403 15:19:17 in /builds/slave/test 15:19:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:19:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:19:17 INFO - {'append_to_log': False, 15:19:17 INFO - 'base_work_dir': '/builds/slave/test', 15:19:17 INFO - 'blob_upload_branch': 'Firefox', 15:19:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:19:17 INFO - 'branch': 'Firefox', 15:19:17 INFO - 'buildbot_json_path': 'buildprops.json', 15:19:17 INFO - 'config_files': ('talos/linux_config.py',), 15:19:17 INFO - 'default_actions': ('clobber', 15:19:17 INFO - 'read-buildbot-config', 15:19:17 INFO - 'download-and-extract', 15:19:17 INFO - 'populate-webroot', 15:19:17 INFO - 'create-virtualenv', 15:19:17 INFO - 'install', 15:19:17 INFO - 'run-tests'), 15:19:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:19:17 INFO - 'download_minidump_stackwalk': True, 15:19:17 INFO - 'download_symbols': 'ondemand', 15:19:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:19:17 INFO - 'tooltool.py': '/tools/tooltool.py', 15:19:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:19:17 INFO - '/tools/misc-python/virtualenv.py')}, 15:19:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:19:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:19:17 INFO - 'gecko_profile': False, 15:19:17 INFO - 'gecko_profile_interval': 0, 15:19:17 INFO - 'installer_path': 'installer.exe', 15:19:17 INFO - 'log_level': 'info', 15:19:17 INFO - 'log_name': 'talos', 15:19:17 INFO - 'log_to_console': True, 15:19:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:19:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:19:17 INFO - 'opt_config_files': (), 15:19:17 INFO - 'pip_index': False, 15:19:17 INFO - 'suite': 'dromaeojs', 15:19:17 INFO - 'system_bits': '32', 15:19:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:19:17 INFO - 'title': 'talos-linux64-ix-017', 15:19:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:19:17 INFO - 'use_talos_json': True, 15:19:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:19:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:19:17 INFO - 'work_dir': 'build'} 15:19:17 INFO - [mozharness: 2017-04-03 22:19:17.754292Z] Running clobber step. 15:19:17 INFO - Running pre-action listener: _resource_record_pre_action 15:19:17 INFO - Running main action method: clobber 15:19:17 INFO - rmtree: /builds/slave/test/build 15:19:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:19:18 INFO - Running post-action listener: _resource_record_post_action 15:19:18 INFO - [mozharness: 2017-04-03 22:19:18.696588Z] Finished clobber step (success) 15:19:18 INFO - [mozharness: 2017-04-03 22:19:18.696687Z] Running read-buildbot-config step. 15:19:18 INFO - Running pre-action listener: _resource_record_pre_action 15:19:18 INFO - Running main action method: read_buildbot_config 15:19:18 INFO - Using buildbot properties: 15:19:18 INFO - { 15:19:18 INFO - "project": "", 15:19:18 INFO - "product": "firefox", 15:19:18 INFO - "who": "kwierso@gmail.com", 15:19:18 INFO - "installer_path": "public/build/target.tar.bz2", 15:19:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs", 15:19:18 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 15:19:18 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs", 15:19:18 INFO - "stage_platform": "linux64-stylo", 15:19:18 INFO - "basedir": "/builds/slave/test", 15:19:18 INFO - "buildnumber": 15, 15:19:18 INFO - "platform": "ubuntu64_hw_stylo", 15:19:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:19:18 INFO - "slavebuilddir": "test", 15:19:18 INFO - "taskId": "PMVVzNBpRFOpR5caMhjfEQ", 15:19:18 INFO - "branch": "mozilla-central", 15:19:18 INFO - "script_repo_revision": "production", 15:19:18 INFO - "revision": "2a593ea93f6637df49eedc998b1f5ae4781a0f56", 15:19:18 INFO - "slavename": "talos-linux64-ix-017", 15:19:18 INFO - "repo_path": "mozilla-central" 15:19:18 INFO - } 15:19:18 INFO - Finding installer, test and symbols from parent task. 15:19:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PMVVzNBpRFOpR5caMhjfEQ'}, attempt #1 15:19:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PMVVzNBpRFOpR5caMhjfEQ'}, attempt #1 15:19:19 INFO - Task dependencies: HUZCYkopRRifab-IdBq9ew 15:19:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HUZCYkopRRifab-IdBq9ew'}, attempt #1 15:19:20 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HUZCYkopRRifab-IdBq9ew/artifacts/public/build/target.tar.bz2 15:19:20 INFO - Set test_url: https://queue.taskcluster.net/v1/task/HUZCYkopRRifab-IdBq9ew/artifacts/public/build/test_packages.json 15:19:20 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HUZCYkopRRifab-IdBq9ew/artifacts/public/build/target.crashreporter-symbols.zip 15:19:20 INFO - Running post-action listener: _resource_record_post_action 15:19:20 INFO - [mozharness: 2017-04-03 22:19:20.075390Z] Finished read-buildbot-config step (success) 15:19:20 INFO - [mozharness: 2017-04-03 22:19:20.075606Z] Running download-and-extract step. 15:19:20 INFO - Running pre-action listener: _resource_record_pre_action 15:19:20 INFO - Running main action method: download_and_extract 15:19:20 INFO - mkdir: /builds/slave/test/build/tests 15:19: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')]} 15:19:20 INFO - trying https://queue.taskcluster.net/v1/task/HUZCYkopRRifab-IdBq9ew/artifacts/public/build/target.test_packages.json 15:19:20 INFO - Downloading https://queue.taskcluster.net/v1/task/HUZCYkopRRifab-IdBq9ew/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:19:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HUZCYkopRRifab-IdBq9ew/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:19:20 INFO - Downloaded 986 bytes. 15:19:20 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:19:20 INFO - Using the following test package requirements: 15:19:20 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:19:20 INFO - u'common': [u'target.common.tests.zip'], 15:19:20 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:19:20 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:19:20 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:19:20 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:19:20 INFO - u'mozbase': [u'target.common.tests.zip'], 15:19:20 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:19:20 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:19:20 INFO - u'web-platform': [u'target.common.tests.zip', 15:19:20 INFO - u'target.web-platform.tests.zip'], 15:19:20 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:19:20 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:19:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HUZCYkopRRifab-IdBq9ew/artifacts/public/build/target.common.tests.zip 15:19:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HUZCYkopRRifab-IdBq9ew/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:19:20 INFO - Fetch https://queue.taskcluster.net/v1/task/HUZCYkopRRifab-IdBq9ew/artifacts/public/build/target.common.tests.zip into memory 15:19:21 INFO - Expected file size: 58241632 15:19:21 INFO - Obtained file size: 58241632 15:19:31 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:19:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HUZCYkopRRifab-IdBq9ew/artifacts/public/build/target.common.tests.zip 15:19:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HUZCYkopRRifab-IdBq9ew/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:19:31 INFO - Fetch https://queue.taskcluster.net/v1/task/HUZCYkopRRifab-IdBq9ew/artifacts/public/build/target.common.tests.zip into memory 15:19:32 INFO - Expected file size: 58241632 15:19:32 INFO - Obtained file size: 58241632 15:19:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HUZCYkopRRifab-IdBq9ew/artifacts/public/build/target.talos.tests.zip 15:19:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HUZCYkopRRifab-IdBq9ew/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:19:43 INFO - Fetch https://queue.taskcluster.net/v1/task/HUZCYkopRRifab-IdBq9ew/artifacts/public/build/target.talos.tests.zip into memory 15:19:44 INFO - Expected file size: 14404152 15:19:44 INFO - Obtained file size: 14404152 15:19: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')]} 15:19:44 INFO - trying https://queue.taskcluster.net/v1/task/HUZCYkopRRifab-IdBq9ew/artifacts/public/build/target.tar.bz2 15:19:44 INFO - Downloading https://queue.taskcluster.net/v1/task/HUZCYkopRRifab-IdBq9ew/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:19:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HUZCYkopRRifab-IdBq9ew/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:19:45 INFO - Downloaded 63962444 bytes. 15:19:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HUZCYkopRRifab-IdBq9ew/artifacts/public/build/target.tar.bz2 15:19:45 INFO - mkdir: /builds/slave/test/properties 15:19:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:19:45 INFO - Writing to file /builds/slave/test/properties/build_url 15:19:45 INFO - Contents: 15:19:45 INFO - build_url:https://queue.taskcluster.net/v1/task/HUZCYkopRRifab-IdBq9ew/artifacts/public/build/target.tar.bz2 15:19:45 INFO - Running post-action listener: _resource_record_post_action 15:19:45 INFO - Running post-action listener: set_extra_try_arguments 15:19:45 INFO - [mozharness: 2017-04-03 22:19:45.646980Z] Finished download-and-extract step (success) 15:19:45 INFO - [mozharness: 2017-04-03 22:19:45.647077Z] Running populate-webroot step. 15:19:45 INFO - Running pre-action listener: _resource_record_pre_action 15:19:45 INFO - Running main action method: populate_webroot 15:19:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:19:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:19:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:19:45 INFO - '--tppagecycles', 15:19:45 INFO - '7'], 15:19:45 INFO - 'tests': ['tsvgm']}}, 15:19:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:19:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:19:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:19:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:19:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:19:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:19:45 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:19:45 INFO - 'talos_options': ['--disable-e10s'], 15:19:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:19:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:19:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:19:45 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:19:45 INFO - 'talos_options': ['--disable-e10s'], 15:19:45 INFO - 'tests': ['damp', 'tps']}, 15:19:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:19:45 INFO - 'tests': ['damp', 'tps']}, 15:19:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:19:45 INFO - 'tests': ['dromaeo_dom']}, 15:19:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:19:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:19:45 INFO - 'tests': ['basic_compositor_video']}, 15:19:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:19:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:19:45 INFO - 'tests': ['a11yr', 15:19:45 INFO - 'ts_paint', 15:19:45 INFO - 'tpaint', 15:19:45 INFO - 'sessionrestore', 15:19:45 INFO - 'sessionrestore_no_auto_restore', 15:19:45 INFO - 'tabpaint']}, 15:19:45 INFO - 'other-e10s': {'tests': ['a11yr', 15:19:45 INFO - 'ts_paint', 15:19:45 INFO - 'tpaint', 15:19:45 INFO - 'sessionrestore', 15:19:45 INFO - 'sessionrestore_no_auto_restore', 15:19:45 INFO - 'tabpaint']}, 15:19:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:19:45 INFO - 'ts_paint', 15:19:45 INFO - 'tpaint', 15:19:45 INFO - 'sessionrestore', 15:19:45 INFO - 'sessionrestore_no_auto_restore', 15:19:45 INFO - 'tabpaint']}, 15:19:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:19:45 INFO - 'ts_paint', 15:19:45 INFO - 'tpaint', 15:19:45 INFO - 'sessionrestore', 15:19:45 INFO - 'sessionrestore_no_auto_restore', 15:19:45 INFO - 'tabpaint']}, 15:19:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:19:45 INFO - 'tests': ['a11yr', 15:19:45 INFO - 'ts_paint', 15:19:45 INFO - 'tpaint', 15:19:45 INFO - 'sessionrestore', 15:19:45 INFO - 'sessionrestore_no_auto_restore', 15:19:45 INFO - 'tabpaint']}, 15:19:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:19:45 INFO - 'tests': ['a11yr', 15:19:45 INFO - 'ts_paint', 15:19:45 INFO - 'tpaint', 15:19:45 INFO - 'sessionrestore', 15:19:45 INFO - 'sessionrestore_no_auto_restore', 15:19:45 INFO - 'tabpaint']}, 15:19:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:19:45 INFO - 'tests': ['tsvgx', 15:19:45 INFO - 'tsvgr_opacity', 15:19:45 INFO - 'tart', 15:19:45 INFO - 'tscrollx', 15:19:45 INFO - 'cart', 15:19:45 INFO - 'tsvg_static']}, 15:19:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:19:45 INFO - 'tsvgr_opacity', 15:19:45 INFO - 'tart', 15:19:45 INFO - 'tscrollx', 15:19:45 INFO - 'cart', 15:19:45 INFO - 'tsvg_static']}, 15:19:45 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:19:45 INFO - 'talos_options': ['--disable-e10s'], 15:19:45 INFO - 'tests': ['tp5o']}, 15:19:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:19:45 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:19:45 INFO - 'talos_options': ['--disable-e10s', 15:19:45 INFO - '--xperf_path', 15:19:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:19:45 INFO - 'tests': ['tp5n']}, 15:19:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:19:45 INFO - 'talos_options': ['--xperf_path', 15:19:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:19:45 INFO - 'tests': ['tp5n']}}, 15:19:45 INFO - 'talos.zip': {'path': '', 15:19:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:19:45 INFO - Running post-action listener: _resource_record_post_action 15:19:45 INFO - [mozharness: 2017-04-03 22:19:45.660143Z] Finished populate-webroot step (success) 15:19:45 INFO - [mozharness: 2017-04-03 22:19:45.660232Z] Running create-virtualenv step. 15:19:45 INFO - Running pre-action listener: _resource_record_pre_action 15:19:45 INFO - Running main action method: create_virtualenv 15:19:45 INFO - Creating virtualenv /builds/slave/test/build/venv 15:19:45 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 15:19:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:19:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:19:45 INFO - Using real prefix '/usr' 15:19:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:19:46 INFO - Installing distribute.............................................................................................................................................................................................done. 15:19:48 INFO - Installing pip.................done. 15:19:48 INFO - Return code: 0 15:19:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:19:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:19:48 INFO - Reading from file tmpfile_stdout 15:19:48 INFO - Output received: 15:19:48 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) 15:19:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:19:48 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')]} 15:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:48 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')]} 15:19:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:48 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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2709a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296a310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967400>, '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 0x29683b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2968840>, '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': '0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677', '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 15:19:48 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 15:19:48 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 15:19:48 INFO - Using env: {'DISPLAY': ':0', 15:19:48 INFO - 'HOME': '/home/cltbld', 15:19:48 INFO - 'LANG': 'en_US.UTF-8', 15:19:48 INFO - 'LANGUAGE': 'en_US:en', 15:19:48 INFO - 'LOGNAME': 'cltbld', 15:19:48 INFO - 'MAIL': '/var/mail/cltbld', 15:19:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:48 INFO - 'MOZ_NO_REMOTE': '1', 15:19:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:48 INFO - 'NO_EM_RESTART': '1', 15:19:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:48 INFO - 'PWD': '/builds/slave/test', 15:19:48 INFO - 'SHELL': '/bin/bash', 15:19:48 INFO - 'SHLVL': '1', 15:19:48 INFO - 'TERM': 'linux', 15:19:48 INFO - 'TMOUT': '86400', 15:19:48 INFO - 'USER': 'cltbld', 15:19:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677', 15:19:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:48 INFO - '_': '/tools/buildbot/bin/python'} 15:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:48 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 15:19:48 INFO - Cleaning up... 15:19:48 INFO - Return code: 0 15:19:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:19:48 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')]} 15:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:48 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')]} 15:19:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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', '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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2709a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296a310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967400>, '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 0x29683b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2968840>, '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': '0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677', '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 15:19: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', 'psutil>=3.1.1'] in /builds/slave/test/build 15:19: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 psutil>=3.1.1 15:19:49 INFO - Using env: {'DISPLAY': ':0', 15:19:49 INFO - 'HOME': '/home/cltbld', 15:19:49 INFO - 'LANG': 'en_US.UTF-8', 15:19:49 INFO - 'LANGUAGE': 'en_US:en', 15:19:49 INFO - 'LOGNAME': 'cltbld', 15:19:49 INFO - 'MAIL': '/var/mail/cltbld', 15:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:49 INFO - 'MOZ_NO_REMOTE': '1', 15:19:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:49 INFO - 'NO_EM_RESTART': '1', 15:19:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:49 INFO - 'PWD': '/builds/slave/test', 15:19:49 INFO - 'SHELL': '/bin/bash', 15:19:49 INFO - 'SHLVL': '1', 15:19:49 INFO - 'TERM': 'linux', 15:19:49 INFO - 'TMOUT': '86400', 15:19:49 INFO - 'USER': 'cltbld', 15:19:49 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677', 15:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:49 INFO - '_': '/tools/buildbot/bin/python'} 15:19:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:49 INFO - Downloading/unpacking psutil>=3.1.1 15:19: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 15:19: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 15:19: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 15:19: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 15:19: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 15:19: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 15:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:19:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:19:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:19:51 INFO - Installing collected packages: psutil 15:19:51 INFO - Running setup.py install for psutil 15:19:51 INFO - building 'psutil._psutil_linux' extension 15:19:51 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 15:19:51 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 15:19:51 INFO - building 'psutil._psutil_posix' extension 15:19:51 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 15:19:51 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 15:19:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:19:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:19:51 INFO - Successfully installed psutil 15:19:51 INFO - Cleaning up... 15:19:52 INFO - Return code: 0 15:19:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:19: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')]} 15:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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')]} 15:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2709a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296a310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967400>, '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 0x29683b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2968840>, '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': '0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677', '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 15:19: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:19: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 mozsystemmonitor==0.3 15:19:52 INFO - Using env: {'DISPLAY': ':0', 15:19:52 INFO - 'HOME': '/home/cltbld', 15:19:52 INFO - 'LANG': 'en_US.UTF-8', 15:19:52 INFO - 'LANGUAGE': 'en_US:en', 15:19:52 INFO - 'LOGNAME': 'cltbld', 15:19:52 INFO - 'MAIL': '/var/mail/cltbld', 15:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:52 INFO - 'MOZ_NO_REMOTE': '1', 15:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:52 INFO - 'NO_EM_RESTART': '1', 15:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:52 INFO - 'PWD': '/builds/slave/test', 15:19:52 INFO - 'SHELL': '/bin/bash', 15:19:52 INFO - 'SHLVL': '1', 15:19:52 INFO - 'TERM': 'linux', 15:19:52 INFO - 'TMOUT': '86400', 15:19:52 INFO - 'USER': 'cltbld', 15:19:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677', 15:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:52 INFO - '_': '/tools/buildbot/bin/python'} 15:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:19: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 15:19: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 15:19: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 15:19: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 15:19: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 15:19: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 15:19:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:19:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:19:54 INFO - Installing collected packages: mozsystemmonitor 15:19:54 INFO - Running setup.py install for mozsystemmonitor 15:19:54 INFO - Successfully installed mozsystemmonitor 15:19:54 INFO - Cleaning up... 15:19:54 INFO - Return code: 0 15:19:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:19:54 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')]} 15:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:54 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')]} 15:19:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:54 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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2709a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296a310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967400>, '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 0x29683b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2968840>, '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': '0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677', '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 15:19:54 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 15:19:54 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 15:19:54 INFO - Using env: {'DISPLAY': ':0', 15:19:54 INFO - 'HOME': '/home/cltbld', 15:19:54 INFO - 'LANG': 'en_US.UTF-8', 15:19:54 INFO - 'LANGUAGE': 'en_US:en', 15:19:54 INFO - 'LOGNAME': 'cltbld', 15:19:54 INFO - 'MAIL': '/var/mail/cltbld', 15:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:54 INFO - 'MOZ_NO_REMOTE': '1', 15:19:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:54 INFO - 'NO_EM_RESTART': '1', 15:19:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:54 INFO - 'PWD': '/builds/slave/test', 15:19:54 INFO - 'SHELL': '/bin/bash', 15:19:54 INFO - 'SHLVL': '1', 15:19:54 INFO - 'TERM': 'linux', 15:19:54 INFO - 'TMOUT': '86400', 15:19:54 INFO - 'USER': 'cltbld', 15:19:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677', 15:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:54 INFO - '_': '/tools/buildbot/bin/python'} 15:19:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:54 INFO - Downloading/unpacking jsonschema==2.5.1 15:19: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 15:19: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 15:19: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 15:19: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 15:19: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 15:19: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 15:19:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:19:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:19:56 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 15:19:56 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 15:19:56 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 15:19:56 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 15:19:56 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 15:19:56 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 15:19:56 INFO - Downloading functools32-3.2.3-2.tar.gz 15:19:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:19:57 INFO - warning: no files found matching '*.txt' 15:19:57 INFO - no previously-included directories found matching 'build' 15:19:57 INFO - no previously-included directories found matching 'dist' 15:19:57 INFO - no previously-included directories found matching '.git*' 15:19:57 INFO - Installing collected packages: jsonschema, functools32 15:19:57 INFO - Running setup.py install for functools32 15:19:57 INFO - warning: no files found matching '*.txt' 15:19:57 INFO - no previously-included directories found matching 'build' 15:19:57 INFO - no previously-included directories found matching 'dist' 15:19:57 INFO - no previously-included directories found matching '.git*' 15:19:57 INFO - Successfully installed jsonschema functools32 15:19:57 INFO - Cleaning up... 15:19:57 INFO - Return code: 0 15:19:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:57 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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2709a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296a310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967400>, '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 0x29683b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2968840>, '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': '0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677', '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 15:19:57 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 15:19:57 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 15:19:57 INFO - Using env: {'DISPLAY': ':0', 15:19:57 INFO - 'HOME': '/home/cltbld', 15:19:57 INFO - 'LANG': 'en_US.UTF-8', 15:19:57 INFO - 'LANGUAGE': 'en_US:en', 15:19:57 INFO - 'LOGNAME': 'cltbld', 15:19:57 INFO - 'MAIL': '/var/mail/cltbld', 15:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:57 INFO - 'MOZ_NO_REMOTE': '1', 15:19:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:57 INFO - 'NO_EM_RESTART': '1', 15:19:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:57 INFO - 'PWD': '/builds/slave/test', 15:19:57 INFO - 'SHELL': '/bin/bash', 15:19:57 INFO - 'SHLVL': '1', 15:19:57 INFO - 'TERM': 'linux', 15:19:57 INFO - 'TMOUT': '86400', 15:19:57 INFO - 'USER': 'cltbld', 15:19:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677', 15:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:57 INFO - '_': '/tools/buildbot/bin/python'} 15:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:19:57 INFO - Cleaning up... 15:19:57 INFO - Return code: 0 15:19:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:57 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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2709a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296a310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967400>, '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 0x29683b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2968840>, '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': '0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677', '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 15:19:57 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 15:19:57 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 15:19:57 INFO - Using env: {'DISPLAY': ':0', 15:19:57 INFO - 'HOME': '/home/cltbld', 15:19:57 INFO - 'LANG': 'en_US.UTF-8', 15:19:57 INFO - 'LANGUAGE': 'en_US:en', 15:19:57 INFO - 'LOGNAME': 'cltbld', 15:19:57 INFO - 'MAIL': '/var/mail/cltbld', 15:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:57 INFO - 'MOZ_NO_REMOTE': '1', 15:19:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:57 INFO - 'NO_EM_RESTART': '1', 15:19:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:57 INFO - 'PWD': '/builds/slave/test', 15:19:57 INFO - 'SHELL': '/bin/bash', 15:19:57 INFO - 'SHLVL': '1', 15:19:57 INFO - 'TERM': 'linux', 15:19:57 INFO - 'TMOUT': '86400', 15:19:57 INFO - 'USER': 'cltbld', 15:19:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677', 15:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:57 INFO - '_': '/tools/buildbot/bin/python'} 15:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:57 INFO - Downloading/unpacking blobuploader==1.2.4 15:19:57 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 15:19:57 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 15:19:57 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 15:19:57 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 15:19:57 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 15:19:57 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 15:19:59 INFO - Downloading blobuploader-1.2.4.tar.gz 15:19:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:19:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:19:59 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 15:19:59 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 15:19:59 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 15:19:59 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 15:19:59 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 15:19:59 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 15:20:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:20:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:20: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 15:20: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 15:20: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 15:20: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 15:20: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 15:20: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 15:20:00 INFO - Downloading docopt-0.6.1.tar.gz 15:20:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:20:00 INFO - Installing collected packages: blobuploader, requests, docopt 15:20:00 INFO - Running setup.py install for blobuploader 15:20:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:20:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:20:00 INFO - Running setup.py install for requests 15:20:00 INFO - Running setup.py install for docopt 15:20:01 INFO - Successfully installed blobuploader requests docopt 15:20:01 INFO - Cleaning up... 15:20:01 INFO - Return code: 0 15:20:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:01 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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2709a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296a310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967400>, '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 0x29683b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2968840>, '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': '0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677', '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 15:20:01 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 15:20:01 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 15:20:01 INFO - Using env: {'DISPLAY': ':0', 15:20:01 INFO - 'HOME': '/home/cltbld', 15:20:01 INFO - 'LANG': 'en_US.UTF-8', 15:20:01 INFO - 'LANGUAGE': 'en_US:en', 15:20:01 INFO - 'LOGNAME': 'cltbld', 15:20:01 INFO - 'MAIL': '/var/mail/cltbld', 15:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:01 INFO - 'MOZ_NO_REMOTE': '1', 15:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:01 INFO - 'NO_EM_RESTART': '1', 15:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:01 INFO - 'PWD': '/builds/slave/test', 15:20:01 INFO - 'SHELL': '/bin/bash', 15:20:01 INFO - 'SHLVL': '1', 15:20:01 INFO - 'TERM': 'linux', 15:20:01 INFO - 'TMOUT': '86400', 15:20:01 INFO - 'USER': 'cltbld', 15:20:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677', 15:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:01 INFO - '_': '/tools/buildbot/bin/python'} 15:20:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:20:01 INFO - Running setup.py (path:/tmp/pip-JF9aZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:20:01 INFO - Running setup.py (path:/tmp/pip-W7ohNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:20:01 INFO - Running setup.py (path:/tmp/pip-c1N3af-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:20:01 INFO - Running setup.py (path:/tmp/pip-VyhwgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:20:01 INFO - Running setup.py (path:/tmp/pip-toPOnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:20:01 INFO - Running setup.py (path:/tmp/pip-98EvMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:20:01 INFO - Running setup.py (path:/tmp/pip-IEthMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:20:02 INFO - Running setup.py (path:/tmp/pip-wOj_H2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:20:02 INFO - Running setup.py (path:/tmp/pip-fWzmyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:20:02 INFO - Running setup.py (path:/tmp/pip-9XLwLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:20:02 INFO - Running setup.py (path:/tmp/pip-60Lym2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:20:02 INFO - Running setup.py (path:/tmp/pip-30XFiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:20:02 INFO - Running setup.py (path:/tmp/pip-gRS5aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:20:02 INFO - Running setup.py (path:/tmp/pip-Eu7_FN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:20:02 INFO - Running setup.py (path:/tmp/pip-LbkK4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:20:02 INFO - Running setup.py (path:/tmp/pip-lvk5Y8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:20:02 INFO - Running setup.py (path:/tmp/pip-Iu3dah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:20:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:20:02 INFO - Running setup.py install for manifestparser 15:20:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:20:02 INFO - Running setup.py install for mozcrash 15:20:02 INFO - Running setup.py install for mozdebug 15:20:03 INFO - Running setup.py install for mozdevice 15:20:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:20:03 INFO - Running setup.py install for mozfile 15:20:03 INFO - Running setup.py install for mozhttpd 15:20:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:20:03 INFO - Running setup.py install for mozinfo 15:20:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:20:03 INFO - Running setup.py install for mozInstall 15:20:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:20:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:20:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:20:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:20:03 INFO - Running setup.py install for mozleak 15:20:03 INFO - Running setup.py install for mozlog 15:20:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:20:03 INFO - Running setup.py install for moznetwork 15:20:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:20:03 INFO - Running setup.py install for mozprocess 15:20:03 INFO - Running setup.py install for mozprofile 15:20:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:20:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:20:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:20:04 INFO - Running setup.py install for mozrunner 15:20:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:20:04 INFO - Running setup.py install for mozscreenshot 15:20:04 INFO - Running setup.py install for moztest 15:20:04 INFO - Running setup.py install for mozversion 15:20:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:20:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:20:04 INFO - Cleaning up... 15:20:04 INFO - Return code: 0 15:20:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:20:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:04 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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2709a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296a310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967400>, '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 0x29683b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2968840>, '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': '0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677', '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 15:20:04 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 15:20:04 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 15:20:04 INFO - Using env: {'DISPLAY': ':0', 15:20:04 INFO - 'HOME': '/home/cltbld', 15:20:04 INFO - 'LANG': 'en_US.UTF-8', 15:20:04 INFO - 'LANGUAGE': 'en_US:en', 15:20:04 INFO - 'LOGNAME': 'cltbld', 15:20:04 INFO - 'MAIL': '/var/mail/cltbld', 15:20:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:04 INFO - 'MOZ_NO_REMOTE': '1', 15:20:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:04 INFO - 'NO_EM_RESTART': '1', 15:20:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:04 INFO - 'PWD': '/builds/slave/test', 15:20:04 INFO - 'SHELL': '/bin/bash', 15:20:04 INFO - 'SHLVL': '1', 15:20:04 INFO - 'TERM': 'linux', 15:20:04 INFO - 'TMOUT': '86400', 15:20:04 INFO - 'USER': 'cltbld', 15:20:04 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677', 15:20:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:04 INFO - '_': '/tools/buildbot/bin/python'} 15:20:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:20:04 INFO - Running setup.py (path:/tmp/pip-DFb1lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:20:04 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)) 15:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:20:04 INFO - Running setup.py (path:/tmp/pip-CNuJku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:20:04 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)) 15:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:20:04 INFO - Running setup.py (path:/tmp/pip-gmFxZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:20:05 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)) 15:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:20:05 INFO - Running setup.py (path:/tmp/pip-AZhKyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:20:05 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)) 15:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:20:05 INFO - Running setup.py (path:/tmp/pip-bnjfuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:20:05 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)) 15:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:20:05 INFO - Running setup.py (path:/tmp/pip-bdBegS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:20:05 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)) 15:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:20:05 INFO - Running setup.py (path:/tmp/pip-csctRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:20:05 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)) 15:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:20:05 INFO - Running setup.py (path:/tmp/pip-GR8LAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:20:05 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)) 15:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:20:05 INFO - Running setup.py (path:/tmp/pip-o052ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:20:05 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)) 15:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:20:05 INFO - Running setup.py (path:/tmp/pip-yW8Xss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:20:05 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)) 15:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:20:05 INFO - Running setup.py (path:/tmp/pip-DUCk4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:20:05 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)) 15:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:20:05 INFO - Running setup.py (path:/tmp/pip-6BAxzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:20:05 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)) 15:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:20:05 INFO - Running setup.py (path:/tmp/pip-G7JCV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:20:05 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)) 15:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:20:05 INFO - Running setup.py (path:/tmp/pip-kwYehD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:20:05 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)) 15:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:20:05 INFO - Running setup.py (path:/tmp/pip-8rkGh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:20:05 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)) 15:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:20:05 INFO - Running setup.py (path:/tmp/pip-Kt5ATQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:20:05 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)) 15:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:20:05 INFO - Running setup.py (path:/tmp/pip-L5CnTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:20:06 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)) 15:20:06 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)) 15:20:06 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)) 15:20:06 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)) 15:20:06 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)) 15:20:06 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)) 15:20:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:20:06 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 15:20:06 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 15:20:06 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 15:20:06 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 15:20:06 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 15:20:06 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 15:20:08 INFO - Downloading blessings-1.6.tar.gz 15:20:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:20:08 INFO - Installing collected packages: blessings 15:20:08 INFO - Running setup.py install for blessings 15:20:08 INFO - Successfully installed blessings 15:20:08 INFO - Cleaning up... 15:20:08 INFO - Return code: 0 15:20:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:20:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:20:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:20:08 INFO - Reading from file tmpfile_stdout 15:20:08 INFO - Current package versions: 15:20:08 INFO - argparse == 1.2.1 15:20:08 INFO - blessings == 1.6 15:20:08 INFO - blobuploader == 1.2.4 15:20:08 INFO - docopt == 0.6.1 15:20:08 INFO - functools32 == 3.2.3-2 15:20:08 INFO - jsonschema == 2.5.1 15:20:08 INFO - manifestparser == 1.1 15:20:08 INFO - mozInstall == 1.12 15:20:08 INFO - mozcrash == 1.0 15:20:08 INFO - mozdebug == 0.1 15:20:08 INFO - mozdevice == 0.49 15:20:08 INFO - mozfile == 1.2 15:20:08 INFO - mozhttpd == 0.7 15:20:08 INFO - mozinfo == 0.9 15:20:08 INFO - mozleak == 0.1 15:20:08 INFO - mozlog == 3.4 15:20:08 INFO - moznetwork == 0.27 15:20:08 INFO - mozprocess == 0.25 15:20:08 INFO - mozprofile == 0.28 15:20:08 INFO - mozrunner == 6.13 15:20:08 INFO - mozscreenshot == 0.1 15:20:08 INFO - mozsystemmonitor == 0.3 15:20:08 INFO - moztest == 0.8 15:20:08 INFO - mozversion == 1.4 15:20:08 INFO - psutil == 3.1.1 15:20:08 INFO - requests == 1.2.3 15:20:08 INFO - wsgiref == 0.1.2 15:20:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:20:08 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')]} 15:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:08 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')]} 15:20:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:08 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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2709a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296a310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967400>, '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 0x29683b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2968840>, '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': '0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677', '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 15:20:08 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 15:20:08 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 15:20:08 INFO - Using env: {'DISPLAY': ':0', 15:20:08 INFO - 'HOME': '/home/cltbld', 15:20:08 INFO - 'LANG': 'en_US.UTF-8', 15:20:08 INFO - 'LANGUAGE': 'en_US:en', 15:20:08 INFO - 'LOGNAME': 'cltbld', 15:20:08 INFO - 'MAIL': '/var/mail/cltbld', 15:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:08 INFO - 'MOZ_NO_REMOTE': '1', 15:20:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:08 INFO - 'NO_EM_RESTART': '1', 15:20:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:08 INFO - 'PWD': '/builds/slave/test', 15:20:08 INFO - 'SHELL': '/bin/bash', 15:20:08 INFO - 'SHLVL': '1', 15:20:08 INFO - 'TERM': 'linux', 15:20:08 INFO - 'TMOUT': '86400', 15:20:08 INFO - 'USER': 'cltbld', 15:20:08 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677', 15:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:08 INFO - '_': '/tools/buildbot/bin/python'} 15:20:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:08 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)) 15:20:08 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)) 15:20:08 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)) 15:20:08 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)) 15:20:08 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)) 15:20:08 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)) 15:20:08 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)) 15:20:08 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)) 15:20:08 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)) 15:20:08 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)) 15:20:08 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)) 15:20:08 INFO - Cleaning up... 15:20:08 INFO - Return code: 0 15:20:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:20:08 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')]} 15:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:08 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')]} 15:20:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:08 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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2709a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296a310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967400>, '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 0x29683b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2968840>, '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': '0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677', '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 15:20:08 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 15:20:08 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 15:20:08 INFO - Using env: {'DISPLAY': ':0', 15:20:08 INFO - 'HOME': '/home/cltbld', 15:20:08 INFO - 'LANG': 'en_US.UTF-8', 15:20:08 INFO - 'LANGUAGE': 'en_US:en', 15:20:08 INFO - 'LOGNAME': 'cltbld', 15:20:08 INFO - 'MAIL': '/var/mail/cltbld', 15:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:08 INFO - 'MOZ_NO_REMOTE': '1', 15:20:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:08 INFO - 'NO_EM_RESTART': '1', 15:20:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:08 INFO - 'PWD': '/builds/slave/test', 15:20:08 INFO - 'SHELL': '/bin/bash', 15:20:08 INFO - 'SHLVL': '1', 15:20:08 INFO - 'TERM': 'linux', 15:20:08 INFO - 'TMOUT': '86400', 15:20:08 INFO - 'USER': 'cltbld', 15:20:08 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677', 15:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:08 INFO - '_': '/tools/buildbot/bin/python'} 15:20:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:20:09 INFO - Cleaning up... 15:20:09 INFO - Return code: 0 15:20:09 INFO - Running post-action listener: _resource_record_post_action 15:20:09 INFO - Running post-action listener: _start_resource_monitoring 15:20:09 INFO - Starting resource monitoring. 15:20:09 INFO - [mozharness: 2017-04-03 22:20:09.106499Z] Finished create-virtualenv step (success) 15:20:09 INFO - [mozharness: 2017-04-03 22:20:09.106960Z] Running install step. 15:20:09 INFO - Running pre-action listener: _resource_record_pre_action 15:20:09 INFO - Running main action method: install 15:20:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:20:09 INFO - Reading from file tmpfile_stdout 15:20:09 INFO - Detecting whether we're running mozinstall >=1.0... 15:20:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:20:09 INFO - Reading from file tmpfile_stdout 15:20:09 INFO - Output received: 15:20:09 INFO - Usage: mozinstall [options] installer 15:20:09 INFO - Options: 15:20:09 INFO - -h, --help show this help message and exit 15:20:09 INFO - -d DEST, --destination=DEST 15:20:09 INFO - Directory to install application into. [default: 15:20:09 INFO - "/builds/slave/test"] 15:20:09 INFO - --app=APP Application being installed. [default: firefox] 15:20:09 INFO - mkdir: /builds/slave/test/build/application 15:20:09 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'] 15:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:20:25 INFO - Reading from file tmpfile_stdout 15:20:25 INFO - Output received: 15:20:25 INFO - /builds/slave/test/build/application/firefox/firefox 15:20:25 INFO - Running post-action listener: _resource_record_post_action 15:20:25 INFO - [mozharness: 2017-04-03 22:20:25.432200Z] Finished install step (success) 15:20:25 INFO - [mozharness: 2017-04-03 22:20:25.432472Z] Running run-tests step. 15:20:25 INFO - Running pre-action listener: _resource_record_pre_action 15:20:25 INFO - Running main action method: run_tests 15:20:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:20:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:20:25 INFO - Python 2.7.3 15:20:25 INFO - Return code: 0 15:20:25 INFO - grabbing minidump binary from tooltool 15:20:25 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')]} 15:20:25 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 0x2967400>, '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 0x29683b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2968840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:20:25 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 15:20:25 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 15:20:25 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 15:20:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:20:25 INFO - Return code: 0 15:20:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:20:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:20:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:20:25 INFO - ENV: RUST_BACKTRACE is now 1 15:20:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:20:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:20:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HUZCYkopRRifab-IdBq9ew/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 15:20:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HUZCYkopRRifab-IdBq9ew/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 15:20:25 INFO - Using env: {'DISPLAY': ':0', 15:20:25 INFO - 'HOME': '/home/cltbld', 15:20:25 INFO - 'LANG': 'en_US.UTF-8', 15:20:25 INFO - 'LANGUAGE': 'en_US:en', 15:20:25 INFO - 'LOGNAME': 'cltbld', 15:20:25 INFO - 'MAIL': '/var/mail/cltbld', 15:20:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:20:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:25 INFO - 'MOZ_NO_REMOTE': '1', 15:20:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:20:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:25 INFO - 'NO_EM_RESTART': '1', 15:20:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:25 INFO - 'PWD': '/builds/slave/test', 15:20:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:20:25 INFO - 'RUST_BACKTRACE': '1', 15:20:25 INFO - 'SHELL': '/bin/bash', 15:20:25 INFO - 'SHLVL': '1', 15:20:25 INFO - 'TERM': 'linux', 15:20:25 INFO - 'TMOUT': '86400', 15:20:25 INFO - 'USER': 'cltbld', 15:20:25 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677', 15:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:25 INFO - '_': '/tools/buildbot/bin/python'} 15:20:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HUZCYkopRRifab-IdBq9ew/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 15:20:25 INFO - mozversion application_buildid: 20170403214313 15:20:25 INFO - mozversion application_changeset: 2a593ea93f6637df49eedc998b1f5ae4781a0f56 15:20:25 INFO - mozversion application_display_name: Nightly 15:20:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:20:25 INFO - mozversion application_name: Firefox 15:20:25 INFO - mozversion application_remotingname: firefox 15:20:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:20:25 INFO - mozversion application_vendor: Mozilla 15:20:25 INFO - mozversion application_version: 55.0a1 15:20:25 INFO - mozversion platform_buildid: 20170403214313 15:20:25 INFO - mozversion platform_changeset: 2a593ea93f6637df49eedc998b1f5ae4781a0f56 15:20:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:20:25 INFO - mozversion platform_version: 55.0a1 15:20:25 INFO - using testdate: 1491258025 15:20:25 INFO - actual date: 1491258025 15:20:25 INFO - starting webserver on 'localhost:51325' 15:20:25 INFO - SUITE-START | Running 2 tests 15:20:25 INFO - TEST-START | dromaeo_css 15:20:25 INFO - operating with platform_type : linux_ 15:20:25 INFO - Initialising browser for dromaeo_css test... 15:20:25 INFO - TEST-INFO | started process 9996 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1e1LUK/profile http://localhost:51325/getInfo.html) 15:20:29 INFO - PID 9996 | __metrics Screen width/height:1600/1200 15:20:29 INFO - PID 9996 | colorDepth:24 15:20:29 INFO - PID 9996 | Browser inner width/height: 1024/697 15:20:29 INFO - PID 9996 | __metrics 15:20:30 INFO - PID 9996 | 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" 15:20:30 INFO - PID 9996 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:20:31 INFO - TEST-INFO | 9996: exit 0 15:20:31 INFO - Browser initialized. 15:20:31 INFO - Running cycle 1/1 for dromaeo_css test... 15:20:31 INFO - TEST-INFO | started process 10095 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1e1LUK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:20:43 INFO - PID 10095 | RSS: Main: 166477824 15:20:43 INFO - PID 10095 | 15:23:51 INFO - PID 10095 | Cycle 1(1): loaded http://localhost:51325/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51325/tests/dromaeo/cssquery-ext.html) 15:23:52 INFO - PID 10095 | RSS: Main: 308465664 15:23:52 INFO - PID 10095 | 15:25:33 INFO - PID 10095 | ************************* 15:25:33 INFO - PID 10095 | A coding exception was thrown and uncaught in a Task. 15:25:33 INFO - PID 10095 | 15:25:33 ERROR - PID 10095 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:25:33 INFO - PID 10095 | Full stack: 15:25:33 INFO - PID 10095 | ************************* 15:25:33 INFO - PID 10095 | ************************* 15:25:33 INFO - PID 10095 | A coding exception was thrown and uncaught in a Task. 15:25:33 INFO - PID 10095 | 15:25:33 ERROR - PID 10095 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:25:33 INFO - PID 10095 | Full stack: 15:25:33 INFO - PID 10095 | ************************* 15:25:33 INFO - PID 10095 | ************************* 15:25:33 INFO - PID 10095 | A coding exception was thrown and uncaught in a Task. 15:25:33 INFO - PID 10095 | 15:25:33 ERROR - PID 10095 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:25:33 INFO - PID 10095 | Full stack: 15:25:33 INFO - PID 10095 | ************************* 15:25:33 INFO - PID 10095 | ************************* 15:25:33 INFO - PID 10095 | A coding exception was thrown and uncaught in a Task. 15:25:33 INFO - PID 10095 | 15:25:33 ERROR - PID 10095 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:25:33 INFO - PID 10095 | Full stack: 15:25:33 INFO - PID 10095 | ************************* 15:26:55 INFO - PID 10095 | Cycle 1(1): loaded http://localhost:51325/tests/dromaeo/cssquery-ext.html (next: http://localhost:51325/tests/dromaeo/cssquery-jquery.html) 15:26:56 INFO - PID 10095 | RSS: Main: 268636160 15:26:56 INFO - PID 10095 | 15:29:58 INFO - PID 10095 | Cycle 1(1): loaded http://localhost:51325/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51325/tests/dromaeo/cssquery-mootools.html) 15:29:59 INFO - PID 10095 | RSS: Main: 249393152 15:29:59 INFO - PID 10095 | 15:33:01 INFO - PID 10095 | Cycle 1(1): loaded http://localhost:51325/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51325/tests/dromaeo/cssquery-prototype.html) 15:33:02 INFO - PID 10095 | RSS: Main: 245686272 15:33:02 INFO - PID 10095 | 15:36:05 INFO - PID 10095 | Cycle 1(1): loaded http://localhost:51325/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51325/tests/dromaeo/cssquery-yui.html) 15:36:06 INFO - PID 10095 | RSS: Main: 215789568 15:36:06 INFO - PID 10095 | 15:39:09 INFO - PID 10095 | Cycle 1(1): loaded http://localhost:51325/tests/dromaeo/cssquery-yui.html (next: http://localhost:51325/tests/dromaeo/cssquery-dojo.html) 15:39:09 INFO - PID 10095 | RSS: Main: 303689728 15:39:09 INFO - PID 10095 | 15:39:09 INFO - PID 10095 | __start_tp_report 15:39:09 INFO - PID 10095 | _x_x_mozilla_page_load 15:39:09 INFO - PID 10095 | _x_x_mozilla_page_load_details 15:39:09 INFO - PID 10095 | |i|pagename|runs| 15:39:09 INFO - PID 10095 | |0;dojo.html;2744.2178978990987;2766.0871912268954;2779.3607470281822;2797.523732559126;2818.210900947734;5154.536091751751;5260.053190425722;5280.102382594959;5281.419043905167;5329.92005119923;5275.551578115865;5286.471352864712;5287.735613219343;5288.127458969275;5302.257683924244;4612.1928662484015;4683.859484215479;4714.669973101884;4718.952810471903;4768.499307572707;4726.66913316068;4743.739094349809;4763.880902977436;4773.546513081252;4774.140654682155;4741.8103275868925;4744.572988431058;4752.548507891762;4764;4785.545373189559;4698.835540756074;4728.267118596623;4730.858074257743;4735.881602959919;4755.286706993944;4726.196546587088;4751.738654374008;4767.856964291077;4790.712557246541;4812.350332705075;4763.873489560812;4955.801767929314;5144.151215049513;5176.145935920568;5183.818566350197;5566.471185237396;5632.042552765999;5633.63381380209;5638.436156384329;5639.605227634067;5664.603477756558;5781.739821708034;5783.277090363705;5786.855328616776;5789.88420231593;5300.522952934254;5300.602454815904;5303.04545181871;5303.098473259555;5303.708296043677;5853.560982926298;5864.44287792659;5867.295924489089;5868.794592189253;5869.8239052828485;5492.258545096441;5554.1391084381985;5555;5558.194061861008;5559.861003474945;5678.063119585222;5684.09054551278;5698.458646428583;5703.201551782754;5758.0787074068785;5681.176229446707;5714.857128571736;5729.9713501432225;5731.398203188605;5738.483536481736;5515.889682206333;5584.078627026495;5587.3015873015875;5589.692566908859;5658.236138121383;4677.836275730333;4688.085823264499;4692.296155576691;4697;4699.412573428322;4025.959740402617;4026.617471340218;4027.476428064333;4062.51249850014;4074.3888416737727;4820.542048505386;4829.396325459317;4834.709917404896;4852.733099679552;4878.048780487842;5626.549876009909;5695.003374409462;5702.6863522506665;5757.165211044375;5764.423557644286;4777.976110119427;4780.54584814449;4782.378290822171;4785.162596545661;4791.688540244873;4947;5025.924611130836;5042;5078.035173317058;5080.314157588752;5279.841604751864;5326;5327.147656374961;5328.813491527778;5358.732063396893;5752.30972283312;5753.9136912945505;5755.71221438918;5758.366579676316;5764.7405866736935;5148.073346797462;5216.191490319006;5217.06092903281;5236.842894713165;5373.489518495737;5627.8593035174445;5649.378568357395;5684.204211410323;5698.886022279448;5699.772009119754;5707.571932105026;5742.339630942495;5759.1649210865025;5763.567732420169;5769.94230057694;5423.891522169455;5485.985092757693;5551.666899986014;5553.4724201200825;5554.08357620988;5484.095124304445;5510.504054635102;5529.889402212014;5534.667919924817;5541.168824676331;5479.671219726829;5480.123180291134;5481.616286859881;5483.341998960151;5513.338399392099;5551.472610102034;5570.136628822539;5573.058391791762;5575.275214222125;5584.804531841366;5270.947290527046;5373.435789242073;5393.083175860034;5395.082835917982;5466.863328416822 15:39:09 INFO - PID 10095 | |1;ext.html;569.3907518954718;629.4020680353665;640.388429050257;1079.1636481726662;1091.5360971587074;27740.861295693518;34210;34816.82591587039;34870;34893.82553087231;36844.44733329002;37227.441588376125;37305.440418393744;37365.25269494609;37370.8131459343;5136.563392111675;7208;7373.373263272601;7374.926250737478;7375.299346562068;5511.641743286674;7022.297770222988;7219.0976127984;7231.3130252625915;7233.168185658637;7315.707371705125;7367.226441223675;7367.263273672644;7373.926260737378;7375.151857536398;7294.234105418935;7315.30504602062;7346.742863999788;7360.2271761465345;7362.558246505227;7071.328223818729;7142.964285178593;7144.106986626672;7146.106736657918;7147.857042859166;33848.49227261593;34064;34150.48774268388;34153.487697684555;34177.487337689956;2556.821022528424;2587.107447930461;2587.275562842407;2591.403977085262;2648.351153967271;23619.29142125739;23741.7625823743;23742.881285593634;23955.40111497209;24128.155514556907;2889.927751806201;2964.392299578581;2966.821990680566;2967.139529536432;2969.9554506682416;154696;154975.22512387478;155059.99999999886;155524;155577;43938.56061439409;43963.56036439659;44290.77854610706;44421.77789111034;44431;46558.53441465542;46650.533494665295;46652.76673616678;46778.53221467742;46823;12276.938615306866;12650.114491985472;12651.367431628381;12672.239665620093;12683;8440.451370660887;8854.38019338653;10151.137153342048;10162.4918754062;10176.185905127571;10990.560377584967;11127.499262533205;11131.053860421793;12221.877781222252;12351.752964940652;5034.194528875362;5217.895642087213;5236.6334356595435;5269.762860671279;5292.206169074592;873.6592728835759;900.4237288135598;912.4662072687552;922.4327038871046;940.1632547033146;20261.898690506452;21124.577508450053;21173.364799056053;21176.682349764767;21347.67978480324;976.3200015956246;984.8768903887014;985.1183191043975;1001.2140469731225;1013.0578561937322;10785.352878827296;11087.50106245221;11129.165312601588;11173.608923687794;11216;206091;206195;207069;208216;209195;41614.375784363256;41768.791156044026;41789.16421671549;41858.37212441816;41871.37192942108;1168.5033860609376;1247.95008199671;1256.9371531423392;1257.1577043380773;1265.4558539827779;19822.702659459832;20277.59444811125;20776.026277503614;20835.479113022295;20849.79150208539;31017.224569385948;31084.533731993586;31202.843985779928;31210.68789312078;31230.843845780626;216244;217298;217570;217739;218014;29127.85436072806;29211.123666290045;29217.85391073031;29232.853835730686;29246;35281.647183527835;35625.46561801627;36188.45717314295;36200.27599448049;36395.08839292903;26940.461190776467;27280.590791138548;27333.316667083483;27835;28288;27010.864945675145;27282;27902.581461277692;27997.160085197476;28223.435531288847;29939.401211976074;30325.848370758005;30522.847385763816;30647.387052259277;30683.386332273676;26123.346916327242;26283.54594702503;26710.86644566765;27054.1883743488;27189.456210875276;19491;20319.390418287476;20496;20498.487537811077;20696.689549656465 15:39:09 INFO - PID 10095 | |2;jquery.html;393.8818354493651;407.2323669882273;426.63522688101665;437.2348390316945;439.12833026442524;12689;14425.206613636246;19062.04689765513;19488.90255548722;19606.31377901774;18014.459566213;18586.721199182022;18848.5287867803;19264.422067338;19499.5125121872;5425;5469.671819690831;5632.5212356949505;5638.605297629168;5680.460356266169;3423.1955490459723;5633.971830140844;5730.656160630355;5739.684317362543;5754.798582049629;3613.0606042428894;5419.701916394597;5666;5671.461211184931;5681.062624666925;5600.159976003632;5602.803901863456;5667.319921609413;5690.516306113986;5697;5013.5989120870245;5136.101182293084;5138.640295179339;5138.743062846843;5156.278121063054;22211.777882221133;22499.77500224993;22595.88702056479;22608.20871269514;22993.080276788907;1553.2777258574818;1572.3553343129377;1583.5566041508396;1583.6436801719635;1618.9595260118474;13700.725985480234;14089.225092619901;14210.218437985906;14383.568492945229;15041.172735499653;1811.583335832766;1824.835764781176;1874.9062546872738;1906.066027646457;1913.0912816412233;91411;91786;95244.52377738067;95463;96718;10758.677239682822;10998.34009959405;11042.33745975244;11148.554057837595;11183.217174797848;15821.762673559906;15874;15933.12367819781;15935.521934341989;15977.840221597868;7157.585987982102;7265.4016116454295;7302.525335853259;7472.364848987897;7492.51298665585;6552.541322107502;6614.404703576605;6757.560758550679;6798.8300292492095;6821;6926.930730692729;7111.53775004623;7120.821979450555;7145.285471452813;7195.676194571257;1985.9813084112357;2043.5810658814908;2099.6535571630816;2102.8107470327745;2228.6039067875304;794.7417089445953;866.8699695045667;869.2307308032437;869.3742701148892;874.1826392323198;16646.50060498187;16773.412930547373;17383.304667813398;17552.64894702099;17891.37380191687;864.4381152251087;866.6143566113019;880.9691660791841;882.4969767232744;889.515214208258;9334.206592439583;9335.06649335061;9634.759131021641;9694.175995040501;9853.556589953469;449611;492033;492496;492791.5766738652;502149;89972.5501372489;92136;93501;93645;93913.53043234877;1084.4902895639036;1101.8512500812287;1144.2219290882113;1146.2606618730872;1149.6321177223376;17321.30714771395;17614.735778963583;18203;18203.908980455013;18294.359697410528;41839.37240941328;41922;42385.57614423816;42717.78641106775;43048.139037218454;53071;53840.19239711486;55135.72432137813;55339.44660553343;56151.71924140353;8071.112177660335;8149.266566009088;8210.055843577826;8349;8425.410221284452;11958.282503049844;12615;12712.555060572835;13466.326683665973;13756.105853119516;9224.215941644767;9733;10487.423191724529;10502.10732087781;10508.632197873343;9639.277054220822;10219.540120694735;10238.53926573291;10270.948645256725;10921.890781092088;9528.666496672584;10223.335483193569;10701.19741019411;10961.945190273998;11087.611933582286;8015.278624923785;8077.4749641275475;8154.266116049584;8278.461899976483;8350.624221909908;9992.200623950212;10089.344192627455;10186.439745813756;10723.89276107229;10914 15:39:09 INFO - PID 10095 | |3;mootools.html;1292.3279894454884;1354.5936219134257;1371.7599420101485;1375.154280117728;1378.1386633354155;9422.104900034503;9864.654737084204;9885.308028438012;9902.554385052672;9903.702888913325;9848.310618256724;10100.141487973531;10170.64402745904;10183.745406364844;10184.898151018488;2216.7894050065256;2280.133549251282;2281.2471884278148;2285.8399912006166;2290.80528155107;1842.309134074722;1903.990884831035;2151.806337429631;2221.7778222177735;2263.524659821431;2162.19998600518;2258.153192552793;2260.389694782408;2261.570301642691;2267.0818318581;2169.8481106322565;2217.4567231028423;2226;2227.7772222777753;2253.267688001406;2215.944601384962;2224.9555008899733;2226.4322597737473;2226.4656482444257;2227.866328020324;9660.90339096607;9667.516624168833;9768.609255629766;9798.559064842098;9799.16707079899;5301.496357845998;5436.21174929637;5648.576356773258;5650.6892120933335;5652.858678533028;3173.3653269346223;3332.0670212340583;3402.608699999507;3406.863725450979;3417.487376893461;1099.0535652346314;1121.147927575049;1145.8682251541097;1148.4774427635489;1160.9303441793436;14289.214093224868;14548.854511454856;14560.70878582433;14624.926875365662;14635.70728585433;4906.975465122651;5090.211017292326;5132.358455193101;5153.948460515422;5239.318888544541;12207.45066471993;12216;12219;12219.900208981056;12235.143539952118;5681.403452637496;5682.857928551736;5687.51656109227;5689.402612725687;5691.630044047207;4993.425756038029;5019.171836646912;5080.669756465818;5093;5136.512031357015;4081.076079439744;4111.321631930758;4236.4492615959725;4247.086876321606;4297.957020429818;1163.3717792392013;1281.14803655568;1328.3955800111119;1343.1202562321696;1344.0860215053858;544.3576579635989;653.6470306034784;703.5356664601441;711.1004579207307;742.3652776875801;5071.112555302807;5204.375474942955;5204.516712736852;5228.346456692913;5470.890582188334;799.8640231160716;813.7477382011477;824.8432797768525;832.4297855968681;834.4826207751112;3617.1680513482047;3655.3785856404475;3680.7607505512055;3751.464252387435;3826;12594.748105038032;13192.20846749198;13208.801867971988;13219.206847589176;13224.801627975588;13058.931151179466;13061.412236449383;13095.410706518229;13099.410526526139;13116.672083197996;9267.814643707088;9411.952940235255;9616.423014619146;9624.75938101553;9627.229821614254;5559.332880054258;5589.133684278943;5671.6597004179885;5708.143778433268;5795.59430839854;11417.486213120263;11453.427328633701;11522.884771152181;11615.88384116148;11751.941240293743;11839;11875.465604047666;11928.880711192776;11965.461554230254;12029.819552706542;7556.546607203585;7672.194419586086;7704.768856934301;7734.303912647663;7737.148913619385;9010.50442225684;9219.124183202584;9294.581743821409;9313.208377288007;9342.112499312554;7637.465377423527;7756.495827771177;7759.883601746092;7823.061232652118;7951.045874495097;7704.691812327668;7807.6096195188875;7842.490238134503;7892.565908875067;8063.072746633978;6395.584287021329;6503;6515.6742162892615;6520.641364724986;6526;4860.513948605111;4924.586952393373;4955.1576232039915;5070.5154474308065;5164.664296820694;4893;4902.779374928208;5004.999000199902;5010.924836127534;5042.4705405931845 15:39:09 INFO - PID 10095 | |4;prototype.html;365.6471504997677;395.28256214969826;406.87590284963073;407.11655707115557;410.9979450102749;5426.1046927257;5453.182022696597;5453.182022696597;5456.181572764087;5462.945370546298;5087.694738315695;5222.138347172721;5257.342832145981;5261.973690131554;5340.519353258206;4041.5958404159496;4044.1102957349485;4044.3933409988445;4044.5146582410152;4048.3117869962175;4064.841520166753;4072.3687828386646;4073.8370465181506;4076.5145800340724;4077.1234184650293;3901.765894046352;3978.164585437047;4017.819198136091;4019.5779443158485;4032.2943484890175;3977.3636218204947;4002.799860006988;4016.116454380032;4018.2365350583295;4023.7786921719294;3504.9824750876337;3507.298540291926;3528.659109538359;3534.6465353464705;3537.239493508908;5003.649744517885;5093.363329583802;5104.489551044903;5116;5121.539061484447;4722.433308003027;4741.83403580873;4751;4755.358026666425;4763.976180119112;5567.832965011056;5576.972115139439;5579.414161513064;5581.609287349887;5590.664560126364;3948.723589348747;3958.4656071430277;3970.6426421621904;3971.702122340836;3976.7216294859372;5633.746481408347;5637.436256374371;5763.423657634287;5802.941970580325;5880.117982302646;4055.5538890721996;4065.2276067547073;4067.4102255172834;4068.613481719232;4081.4490043844294;4120.896977575585;4135.483064616923;4141.81361838718;4147.050886083536;4148.398482220061;4458.706974977285;4561.429821272341;4623.352730617717;4707.152712511713;4729.290606409066;5588.552915766729;5598.272224610856;5599.272094627672;5604.579656525777;5605;1394.8047273381735;1430.1562078373809;1438.8561143885527;1443.4370595467776;1445.2990299704634;954.0936110694868;957.6408846682494;960.2989817433313;960.6973803252093;972.9027097290356;4879.780409881564;4889.435380678149;4905.779239934212;4909.018196360742;4912.680675756064;5800;5821.88356232873;5825.825225243249;5831.06702927538;5866.823995280149;4724.4094488188975;4859.173940430135;4869.269609558594;4873.6832105913;4893.975530122398;3074.9692503074684;3081.383723255358;3083.198368424226;3106.285554322473;3107.207662046164;5377.677339359651;5388.649737767033;5415.640409470414;5424.810131645373;5426.8914621707345;5764.769409223584;5918.8816223675285;5928.318243401977;5964.522838172936;5968.37332080134;5369.114096174166;5375.704336261465;5390.460953904578;5401.756920938567;5408.3509978802795;5587.385387607279;5767.5385969121535;5770.942290577041;5802.564807639359;5829.183914251923;5696.430356964271;5716.657000579979;5723.3418156912485;5748.942510575008;5751.48236658686;5190.506901844319;5225.268462415341;5323.600729945347;5362.785488580413;5386.649867758583;4051.5948405159247;4057.736247143926;4072.511298644063;4075.1238483726142;4083.8570650027104;5569.916451253315;5755.280589926259;5791.305043394819;5795.217645617956;5811.680357580373;5576.581756368208;5603.635763675348;5616;5626.85932851682;5648.774049038157;5589.888202236014;5611.204414587293;5620.437956204347;5621.128725047624;5625.606207565431;5334.573234141337;5487.585462396532;5525.198846167364;5534.529564987021;5538.778448862;5615.466530679579;5618.016847051831;5628.887422251614;5650.971745141248;5670.659760414388;5522.978249023943;5525.171224316385;5525.198846167364;5543.8891222174525;5548.250986116984 15:39:09 INFO - PID 10095 | |5;yui.html;667.3560014585925;667.6194569095614;670.4636290967227;674.5446823394213;716.1084449859925;13262.734745305088;14095.71808563828;14120.576382708523;14176.362063707133;14197.929010354934;13897.652558686037;14012.29938503076;14041.22773247471;14161;14162.150270983748;893.7408151636017;905.0723008915849;916.3722849847842;936.0686117313248;951.6811868024221;900.9819803603924;949.2453499467905;955.2167222877209;955.2883102088954;956.7273327101777;954.4511905654242;1012.0891197921856;1013.108464551194;1014.6245889021072;1014.8325526288154;938.7934654376061;992.1665800727387;992.6476100984191;994.602159136344;996.5565323431076;696.8257935516122;721.7329588052402;740.6333864736989;740.7222291640635;740.76665850257;13352.599422017354;13672.52146174879;14106.224157671324;14577.708445831024;14686.632834179125;14113.717725645532;14577.671594246138;14590.197539135343;14624.926875365662;14711.926440367837;10616.893831061745;10645.223621040688;10766.946165269203;10814.188935829845;10877.292975956616;2740.287525243431;2750.8899644014214;2771.3210263485375;2813.831170129799;2870.512012957802;66679;67046.66476667635;67097;67523.66238168826;68051.65974170147;10721.463926803628;10832.512536935857;10940.617078402218;11082.556697732161;11333.619939812566;21828.976252244807;22160.445988850086;22176.334709958726;22226.666600001012;22375.776242237695;6571.851381012475;6597.30728273534;6692.59844409337;6737.629430381278;6857.828554286183;3315.502674598781;3358.580177477815;3412.19813343864;3418.67522585354;3496.900723496679;3588.2285308658766;3641.5083963665097;3645.5260816093737;3672.412414013745;3685.7235707322056;627.1658693937053;628.4187126907592;631.4380201620561;642.945349645276;646.3859333632973;509.6228790694859;536.9114096174166;540.1169088540187;541.4937033873341;548.3760207407615;7195.280471952868;7206.855862882713;7325.157606875171;7340.44946629005;7857.1357150713375;444.5792658971931;481.27568010144506;525.8720045502453;536.8845698174833;551.31361454988;3624.873129440457;3722.8696995605565;3737.757045792069;3924.803759811998;3946.467226924386;63219.683901580196;63389.68305158445;65468;65653.67173164104;67046.66476667683;54206;55203.44796552063;55451;55610;56053.439465604824;46707.53292467168;46950.29574556453;47360;48612.513874861506;49060.509394905595;8100.432969692065;8419.242268195892;8448.619812108593;8465.492070475791;8634.654613815377;24429.14497992562;25224.74775252224;25329.366765831;25736.8713156433;26554.203373898814;30974.53538196884;31052.53421198729;31278.687213128487;31335.21661958469;32244.677553224166;10596.258261921592;10667.733306667395;10710.625128120479;10791.190660700322;10941.507632156412;11740.647780566596;11883.524659013543;11943.104267179822;11995.940020300191;12384.56654017105;10390.636327728493;10721.195910306602;10725.89274107249;10831.837522437012;10924.2899211551;10459.738506537398;10517.316374435637;10528.105111065644;10530.31552949056;10647.361158330525;10282.126019288444;10450.425226612306;10570.630027948984;10710.89289107099;11101.611443599435;8190.590470476572;8394.916050839658;8411.411201215857;8560.785980350542;8648.56757162152;8537.701180458655;8799.516026618341;8856.512891791013;8943.418677785923;8953.552322383724 15:39:09 INFO - PID 10095 | __end_tp_report 15:39:09 INFO - PID 10095 | __start_cc_report 15:39:09 INFO - PID 10095 | _x_x_mozilla_cycle_collect,1448 15:39:09 INFO - PID 10095 | __end_cc_report 15:39:09 INFO - PID 10095 | __startTimestamp1491259149615__endTimestamp 15:39:09 INFO - PID 10095 | 15:39:09 INFO - PID 10095 | ------- Summary: start ------- 15:39:09 INFO - PID 10095 | Number of tests: 6 15:39:09 INFO - PID 10095 | 15:39:09 INFO - PID 10095 | [#0] dojo.html Cycles:165 Average:5197.28 Median:5328.81 stddev:610.49 (11.5%) stddev-sans-first:581.25 15:39:09 INFO - PID 10095 | Values: 2744.2 2766.1 2779.4 2797.5 2818.2 5154.5 5260.1 5280.1 5281.4 5329.9 5275.6 5286.5 5287.7 5288.1 5302.3 4612.2 4683.9 4714.7 4719.0 4768.5 4726.7 4743.7 4763.9 4773.5 4774.1 4741.8 4744.6 4752.5 4764.0 4785.5 4698.8 4728.3 4730.9 4735.9 4755.3 4726.2 4751.7 4767.9 4790.7 4812.4 4763.9 4955.8 5144.2 5176.1 5183.8 5566.5 5632.0 5633.6 5638.4 5639.6 5664.6 5781.7 5783.3 5786.9 5789.9 5300.5 5300.6 5303.0 5303.1 5303.7 5853.6 5864.4 5867.3 5868.8 5869.8 5492.3 5554.1 5555.0 5558.2 5559.9 5678.1 5684.1 5698.5 5703.2 5758.1 5681.2 5714.9 5730.0 5731.4 5738.5 5515.9 5584.1 5587.3 5589.7 5658.2 4677.8 4688.1 4692.3 4697.0 4699.4 4026.0 4026.6 4027.5 4062.5 4074.4 4820.5 4829.4 4834.7 4852.7 4878.0 5626.5 5695.0 5702.7 5757.2 5764.4 4778.0 4780.5 4782.4 4785.2 4791.7 4947.0 5025.9 5042.0 5078.0 5080.3 5279.8 5326.0 5327.1 5328.8 5358.7 5752.3 5753.9 5755.7 5758.4 5764.7 5148.1 5216.2 5217.1 5236.8 5373.5 5627.9 5649.4 5684.2 5698.9 5699.8 5707.6 5742.3 5759.2 5763.6 5769.9 5423.9 5486.0 5551.7 5553.5 5554.1 5484.1 5510.5 5529.9 5534.7 5541.2 5479.7 5480.1 5481.6 5483.3 5513.3 5551.5 5570.1 5573.1 5575.3 5584.8 5270.9 5373.4 5393.1 5395.1 5466.9 15:39:09 INFO - PID 10095 | 15:39:09 INFO - PID 10095 | [#1] ext.html Cycles:180 Average:33514.11 Median:2966.98 stddev:50793.47 (1712.0%) stddev-sans-first:50875.72 15:39:09 INFO - PID 10095 | Values: 569.4 629.4 640.4 1079.2 1091.5 27740.9 34210.0 34816.8 34870.0 34893.8 36844.4 37227.4 37305.4 37365.3 37370.8 5136.6 7208.0 7373.4 7374.9 7375.3 5511.6 7022.3 7219.1 7231.3 7233.2 7315.7 7367.2 7367.3 7373.9 7375.2 7294.2 7315.3 7346.7 7360.2 7362.6 7071.3 7143.0 7144.1 7146.1 7147.9 33848.5 34064.0 34150.5 34153.5 34177.5 2556.8 2587.1 2587.3 2591.4 2648.4 23619.3 23741.8 23742.9 23955.4 24128.2 2889.9 2964.4 2966.8 2967.1 2970.0 154696.0 154975.2 155060.0 155524.0 155577.0 43938.6 43963.6 44290.8 44421.8 44431.0 46558.5 46650.5 46652.8 46778.5 46823.0 12276.9 12650.1 12651.4 12672.2 12683.0 8440.5 8854.4 10151.1 10162.5 10176.2 10990.6 11127.5 11131.1 12221.9 12351.8 5034.2 5217.9 5236.6 5269.8 5292.2 873.7 900.4 912.5 922.4 940.2 20261.9 21124.6 21173.4 21176.7 21347.7 976.3 984.9 985.1 1001.2 1013.1 10785.4 11087.5 11129.2 11173.6 11216.0 206091.0 206195.0 207069.0 208216.0 209195.0 41614.4 41768.8 41789.2 41858.4 41871.4 1168.5 1248.0 1256.9 1257.2 1265.5 19822.7 20277.6 20776.0 20835.5 20849.8 31017.2 31084.5 31202.8 31210.7 31230.8 216244.0 217298.0 217570.0 217739.0 218014.0 29127.9 29211.1 29217.9 29232.9 29246.0 35281.6 35625.5 36188.5 36200.3 36395.1 26940.5 27280.6 27333.3 27835.0 28288.0 27010.9 27282.0 27902.6 27997.2 28223.4 29939.4 30325.8 30522.8 30647.4 30683.4 26123.3 26283.5 26710.9 27054.2 27189.5 19491.0 20319.4 20496.0 20498.5 20696.7 15:39:09 INFO - PID 10095 | 15:39:09 INFO - PID 10095 | [#2] jquery.html Cycles:180 Average:28928.57 Median:438.18 stddev:80494.30 (18370.1%) stddev-sans-first:80691.59 15:39:09 INFO - PID 10095 | Values: 393.9 407.2 426.6 437.2 439.1 12689.0 14425.2 19062.0 19488.9 19606.3 18014.5 18586.7 18848.5 19264.4 19499.5 5425.0 5469.7 5632.5 5638.6 5680.5 3423.2 5634.0 5730.7 5739.7 5754.8 3613.1 5419.7 5666.0 5671.5 5681.1 5600.2 5602.8 5667.3 5690.5 5697.0 5013.6 5136.1 5138.6 5138.7 5156.3 22211.8 22499.8 22595.9 22608.2 22993.1 1553.3 1572.4 1583.6 1583.6 1619.0 13700.7 14089.2 14210.2 14383.6 15041.2 1811.6 1824.8 1874.9 1906.1 1913.1 91411.0 91786.0 95244.5 95463.0 96718.0 10758.7 10998.3 11042.3 11148.6 11183.2 15821.8 15874.0 15933.1 15935.5 15977.8 7157.6 7265.4 7302.5 7472.4 7492.5 6552.5 6614.4 6757.6 6798.8 6821.0 6926.9 7111.5 7120.8 7145.3 7195.7 1986.0 2043.6 2099.7 2102.8 2228.6 794.7 866.9 869.2 869.4 874.2 16646.5 16773.4 17383.3 17552.6 17891.4 864.4 866.6 881.0 882.5 889.5 9334.2 9335.1 9634.8 9694.2 9853.6 449611.0 492033.0 492496.0 492791.6 502149.0 89972.6 92136.0 93501.0 93645.0 93913.5 1084.5 1101.9 1144.2 1146.3 1149.6 17321.3 17614.7 18203.0 18203.9 18294.4 41839.4 41922.0 42385.6 42717.8 43048.1 53071.0 53840.2 55135.7 55339.4 56151.7 8071.1 8149.3 8210.1 8349.0 8425.4 11958.3 12615.0 12712.6 13466.3 13756.1 9224.2 9733.0 10487.4 10502.1 10508.6 9639.3 10219.5 10238.5 10270.9 10921.9 9528.7 10223.3 10701.2 10961.9 11087.6 8015.3 8077.5 8154.3 8278.5 8350.6 9992.2 10089.3 10186.4 10723.9 10914.0 15:39:09 INFO - PID 10095 | 15:39:09 INFO - PID 10095 | [#3] mootools.html Cycles:180 Average:6233.84 Median:4897.89 stddev:3986.36 (81.4%) stddev-sans-first:3980.25 15:39:09 INFO - PID 10095 | Values: 1292.3 1354.6 1371.8 1375.2 1378.1 9422.1 9864.7 9885.3 9902.6 9903.7 9848.3 10100.1 10170.6 10183.7 10184.9 2216.8 2280.1 2281.2 2285.8 2290.8 1842.3 1904.0 2151.8 2221.8 2263.5 2162.2 2258.2 2260.4 2261.6 2267.1 2169.8 2217.5 2226.0 2227.8 2253.3 2215.9 2225.0 2226.4 2226.5 2227.9 9660.9 9667.5 9768.6 9798.6 9799.2 5301.5 5436.2 5648.6 5650.7 5652.9 3173.4 3332.1 3402.6 3406.9 3417.5 1099.1 1121.1 1145.9 1148.5 1160.9 14289.2 14548.9 14560.7 14624.9 14635.7 4907.0 5090.2 5132.4 5153.9 5239.3 12207.5 12216.0 12219.0 12219.9 12235.1 5681.4 5682.9 5687.5 5689.4 5691.6 4993.4 5019.2 5080.7 5093.0 5136.5 4081.1 4111.3 4236.4 4247.1 4298.0 1163.4 1281.1 1328.4 1343.1 1344.1 544.4 653.6 703.5 711.1 742.4 5071.1 5204.4 5204.5 5228.3 5470.9 799.9 813.7 824.8 832.4 834.5 3617.2 3655.4 3680.8 3751.5 3826.0 12594.7 13192.2 13208.8 13219.2 13224.8 13058.9 13061.4 13095.4 13099.4 13116.7 9267.8 9412.0 9616.4 9624.8 9627.2 5559.3 5589.1 5671.7 5708.1 5795.6 11417.5 11453.4 11522.9 11615.9 11751.9 11839.0 11875.5 11928.9 11965.5 12029.8 7556.5 7672.2 7704.8 7734.3 7737.1 9010.5 9219.1 9294.6 9313.2 9342.1 7637.5 7756.5 7759.9 7823.1 7951.0 7704.7 7807.6 7842.5 7892.6 8063.1 6395.6 6503.0 6515.7 6520.6 6526.0 4860.5 4924.6 4955.2 5070.5 5164.7 4893.0 4902.8 5005.0 5010.9 5042.5 15:39:09 INFO - PID 10095 | 15:39:09 INFO - PID 10095 | [#4] prototype.html Cycles:180 Average:4624.85 Median:5292.79 stddev:1351.65 (25.5%) stddev-sans-first:1317.09 15:39:09 INFO - PID 10095 | Values: 365.6 395.3 406.9 407.1 411.0 5426.1 5453.2 5453.2 5456.2 5462.9 5087.7 5222.1 5257.3 5262.0 5340.5 4041.6 4044.1 4044.4 4044.5 4048.3 4064.8 4072.4 4073.8 4076.5 4077.1 3901.8 3978.2 4017.8 4019.6 4032.3 3977.4 4002.8 4016.1 4018.2 4023.8 3505.0 3507.3 3528.7 3534.6 3537.2 5003.6 5093.4 5104.5 5116.0 5121.5 4722.4 4741.8 4751.0 4755.4 4764.0 5567.8 5577.0 5579.4 5581.6 5590.7 3948.7 3958.5 3970.6 3971.7 3976.7 5633.7 5637.4 5763.4 5802.9 5880.1 4055.6 4065.2 4067.4 4068.6 4081.4 4120.9 4135.5 4141.8 4147.1 4148.4 4458.7 4561.4 4623.4 4707.2 4729.3 5588.6 5598.3 5599.3 5604.6 5605.0 1394.8 1430.2 1438.9 1443.4 1445.3 954.1 957.6 960.3 960.7 972.9 4879.8 4889.4 4905.8 4909.0 4912.7 5800.0 5821.9 5825.8 5831.1 5866.8 4724.4 4859.2 4869.3 4873.7 4894.0 3075.0 3081.4 3083.2 3106.3 3107.2 5377.7 5388.6 5415.6 5424.8 5426.9 5764.8 5918.9 5928.3 5964.5 5968.4 5369.1 5375.7 5390.5 5401.8 5408.4 5587.4 5767.5 5770.9 5802.6 5829.2 5696.4 5716.7 5723.3 5748.9 5751.5 5190.5 5225.3 5323.6 5362.8 5386.6 4051.6 4057.7 4072.5 4075.1 4083.9 5569.9 5755.3 5791.3 5795.2 5811.7 5576.6 5603.6 5616.0 5626.9 5648.8 5589.9 5611.2 5620.4 5621.1 5625.6 5334.6 5487.6 5525.2 5534.5 5538.8 5615.5 5618.0 5628.9 5651.0 5670.7 5523.0 5525.2 5525.2 5543.9 5548.3 15:39:09 INFO - PID 10095 | 15:39:09 INFO - PID 10095 | [#5] yui.html Cycles:180 Average:14098.33 Median:3730.31 stddev:17579.71 (471.3%) stddev-sans-first:17600.10 15:39:09 INFO - PID 10095 | Values: 667.4 667.6 670.5 674.5 716.1 13262.7 14095.7 14120.6 14176.4 14197.9 13897.7 14012.3 14041.2 14161.0 14162.2 893.7 905.1 916.4 936.1 951.7 901.0 949.2 955.2 955.3 956.7 954.5 1012.1 1013.1 1014.6 1014.8 938.8 992.2 992.6 994.6 996.6 696.8 721.7 740.6 740.7 740.8 13352.6 13672.5 14106.2 14577.7 14686.6 14113.7 14577.7 14590.2 14624.9 14711.9 10616.9 10645.2 10766.9 10814.2 10877.3 2740.3 2750.9 2771.3 2813.8 2870.5 66679.0 67046.7 67097.0 67523.7 68051.7 10721.5 10832.5 10940.6 11082.6 11333.6 21829.0 22160.4 22176.3 22226.7 22375.8 6571.9 6597.3 6692.6 6737.6 6857.8 3315.5 3358.6 3412.2 3418.7 3496.9 3588.2 3641.5 3645.5 3672.4 3685.7 627.2 628.4 631.4 642.9 646.4 509.6 536.9 540.1 541.5 548.4 7195.3 7206.9 7325.2 7340.4 7857.1 444.6 481.3 525.9 536.9 551.3 3624.9 3722.9 3737.8 3924.8 3946.5 63219.7 63389.7 65468.0 65653.7 67046.7 54206.0 55203.4 55451.0 55610.0 56053.4 46707.5 46950.3 47360.0 48612.5 49060.5 8100.4 8419.2 8448.6 8465.5 8634.7 24429.1 25224.7 25329.4 25736.9 26554.2 30974.5 31052.5 31278.7 31335.2 32244.7 10596.3 10667.7 10710.6 10791.2 10941.5 11740.6 11883.5 11943.1 11995.9 12384.6 10390.6 10721.2 10725.9 10831.8 10924.3 10459.7 10517.3 10528.1 10530.3 10647.4 10282.1 10450.4 10570.6 10710.9 11101.6 8190.6 8394.9 8411.4 8560.8 8648.6 8537.7 8799.5 8856.5 8943.4 8953.6 15:39:09 INFO - PID 10095 | -------- Summary: end -------- 15:39:09 INFO - PID 10095 | 15:39:10 INFO - TEST-INFO | 10095: exit 0 15:39:10 INFO - TEST-OK | dromaeo_css | took 1124793ms 15:39:10 INFO - TEST-START | kraken 15:39:10 INFO - operating with platform_type : linux_ 15:39:10 INFO - Initialising browser for kraken test... 15:39:10 INFO - TEST-INFO | started process 10427 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyDhY5B/profile http://localhost:51325/getInfo.html) 15:39:14 INFO - PID 10427 | __metrics Screen width/height:1600/1200 15:39:14 INFO - PID 10427 | colorDepth:24 15:39:14 INFO - PID 10427 | Browser inner width/height: 1024/697 15:39:14 INFO - PID 10427 | __metrics 15:39:15 INFO - PID 10427 | 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" 15:39:15 INFO - PID 10427 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:39:16 INFO - TEST-INFO | 10427: exit 0 15:39:16 INFO - Browser initialized. 15:39:16 INFO - Running cycle 1/1 for kraken test... 15:39:16 INFO - TEST-INFO | started process 10529 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyDhY5B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:39:28 INFO - PID 10529 | RSS: Main: 166125568 15:39:28 INFO - PID 10529 | 15:39:31 INFO - PID 10529 | Cycle 1(1): loaded http://localhost:51325/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51325/tests/kraken/driver.html?testName=audio-beat-detection) 15:39:32 INFO - PID 10529 | RSS: Main: 225353728 15:39:32 INFO - PID 10529 | 15:39:35 INFO - PID 10529 | Cycle 1(1): loaded http://localhost:51325/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51325/tests/kraken/driver.html?testName=audio-dft) 15:39:35 INFO - PID 10529 | RSS: Main: 204603392 15:39:35 INFO - PID 10529 | 15:39:38 INFO - PID 10529 | Cycle 1(1): loaded http://localhost:51325/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51325/tests/kraken/driver.html?testName=audio-fft) 15:39:39 INFO - PID 10529 | RSS: Main: 288718848 15:39:39 INFO - PID 10529 | 15:39:41 INFO - PID 10529 | Cycle 1(1): loaded http://localhost:51325/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51325/tests/kraken/driver.html?testName=audio-oscillator) 15:39:42 INFO - PID 10529 | RSS: Main: 199802880 15:39:42 INFO - PID 10529 | 15:39:44 INFO - PID 10529 | Cycle 1(1): loaded http://localhost:51325/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51325/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:39:45 INFO - PID 10529 | RSS: Main: 205619200 15:39:45 INFO - PID 10529 | 15:39:48 INFO - PID 10529 | Cycle 1(1): loaded http://localhost:51325/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51325/tests/kraken/driver.html?testName=imaging-darkroom) 15:39:49 INFO - PID 10529 | RSS: Main: 241508352 15:39:49 INFO - PID 10529 | 15:39:52 INFO - PID 10529 | Cycle 1(1): loaded http://localhost:51325/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51325/tests/kraken/driver.html?testName=imaging-desaturate) 15:39:53 INFO - PID 10529 | RSS: Main: 234967040 15:39:53 INFO - PID 10529 | 15:39:56 INFO - PID 10529 | Cycle 1(1): loaded http://localhost:51325/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51325/tests/kraken/driver.html?testName=json-parse-financial) 15:39:56 INFO - PID 10529 | RSS: Main: 236822528 15:39:56 INFO - PID 10529 | 15:39:58 INFO - PID 10529 | Cycle 1(1): loaded http://localhost:51325/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51325/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:39:59 INFO - PID 10529 | RSS: Main: 201195520 15:39:59 INFO - PID 10529 | 15:40:00 INFO - PID 10529 | Cycle 1(1): loaded http://localhost:51325/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51325/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:40:01 INFO - PID 10529 | RSS: Main: 209317888 15:40:01 INFO - PID 10529 | 15:40:03 INFO - PID 10529 | Cycle 1(1): loaded http://localhost:51325/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51325/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:40:04 INFO - PID 10529 | RSS: Main: 219463680 15:40:04 INFO - PID 10529 | 15:40:07 INFO - PID 10529 | Cycle 1(1): loaded http://localhost:51325/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51325/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:40:08 INFO - PID 10529 | RSS: Main: 227815424 15:40:08 INFO - PID 10529 | 15:40:11 INFO - PID 10529 | Cycle 1(1): loaded http://localhost:51325/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51325/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:40:11 INFO - PID 10529 | RSS: Main: 225198080 15:40:11 INFO - PID 10529 | 15:40:13 INFO - PID 10529 | Cycle 1(1): loaded http://localhost:51325/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51325/tests/kraken/driver.html?testName=ai-astar) 15:40:14 INFO - PID 10529 | RSS: Main: 293134336 15:40:14 INFO - PID 10529 | 15:40:14 INFO - PID 10529 | __start_tp_report 15:40:14 INFO - PID 10529 | _x_x_mozilla_page_load 15:40:14 INFO - PID 10529 | _x_x_mozilla_page_load_details 15:40:14 INFO - PID 10529 | |i|pagename|runs| 15:40:14 INFO - PID 10529 | |0;ai-astar;105;112;113;113;112;111;112;112;110;113 15:40:14 INFO - PID 10529 | |1;audio-beat-detection;150;126;136;177;127;125;130;125;160;125 15:40:14 INFO - PID 10529 | |2;audio-dft;163;163;164;164;165;169;164;164;167;163 15:40:14 INFO - PID 10529 | |3;audio-fft;75;75;77;114;77;76;76;77;93;75 15:40:14 INFO - PID 10529 | |4;audio-oscillator;83;83;115;85;84;83;103;84;84;105 15:40:14 INFO - PID 10529 | |5;imaging-gaussian-blur;114;113;114;114;114;113;119;113;114;114 15:40:14 INFO - PID 10529 | |6;imaging-darkroom;149;150;149;151;151;151;151;161;151;151 15:40:14 INFO - PID 10529 | |7;imaging-desaturate;94;94;94;97;98;95;95;94;94;94 15:40:14 INFO - PID 10529 | |8;json-parse-financial;52;52;52;52;53;53;53;53;52;52 15:40:14 INFO - PID 10529 | |9;json-stringify-tinderbox;56;56;56;56;55;56;57;55;55;55 15:40:14 INFO - PID 10529 | |10;stanford-crypto-aes;83;91;83;84;83;82;81;82;81;82 15:40:14 INFO - PID 10529 | |11;stanford-crypto-ccm;137;138;139;133;145;135;139;132;185;130 15:40:14 INFO - PID 10529 | |12;stanford-crypto-pbkdf2;192;195;193;207;191;192;190;193;199;198 15:40:14 INFO - PID 10529 | |13;stanford-crypto-sha256-iterative;71;71;71;69;72;72;77;76;74;75 15:40:14 INFO - PID 10529 | __end_tp_report 15:40:14 INFO - PID 10529 | __start_cc_report 15:40:14 INFO - PID 10529 | _x_x_mozilla_cycle_collect,2015 15:40:14 INFO - PID 10529 | __end_cc_report 15:40:14 INFO - PID 10529 | __startTimestamp1491259214010__endTimestamp 15:40:14 INFO - PID 10529 | 15:40:14 INFO - PID 10529 | ------- Summary: start ------- 15:40:14 INFO - PID 10529 | Number of tests: 14 15:40:14 INFO - PID 10529 | 15:40:14 INFO - PID 10529 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:2.41 (2.1%) stddev-sans-first:1.00 15:40:14 INFO - PID 10529 | Values: 105.0 112.0 113.0 113.0 112.0 111.0 112.0 112.0 110.0 113.0 15:40:14 INFO - PID 10529 | 15:40:14 INFO - PID 10529 | [#1] audio-beat-detection Cycles:10 Average:138.10 Median:133.00 stddev:18.22 (13.7%) stddev-sans-first:18.81 15:40:14 INFO - PID 10529 | Values: 150.0 126.0 136.0 177.0 127.0 125.0 130.0 125.0 160.0 125.0 15:40:14 INFO - PID 10529 | 15:40:14 INFO - PID 10529 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:1.96 (1.2%) stddev-sans-first:1.99 15:40:14 INFO - PID 10529 | Values: 163.0 163.0 164.0 164.0 165.0 169.0 164.0 164.0 167.0 163.0 15:40:14 INFO - PID 10529 | 15:40:14 INFO - PID 10529 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.50 stddev:12.63 (16.5%) stddev-sans-first:13.18 15:40:14 INFO - PID 10529 | Values: 75.0 75.0 77.0 114.0 77.0 76.0 76.0 77.0 93.0 75.0 15:40:14 INFO - PID 10529 | 15:40:14 INFO - PID 10529 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:83.50 stddev:11.98 (14.3%) stddev-sans-first:12.36 15:40:14 INFO - PID 10529 | Values: 83.0 83.0 115.0 85.0 84.0 83.0 103.0 84.0 84.0 105.0 15:40:14 INFO - PID 10529 | 15:40:14 INFO - PID 10529 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:1.75 (1.5%) stddev-sans-first:1.86 15:40:14 INFO - PID 10529 | Values: 114.0 113.0 114.0 114.0 114.0 113.0 119.0 113.0 114.0 114.0 15:40:14 INFO - PID 10529 | 15:40:14 INFO - PID 10529 | [#6] imaging-darkroom Cycles:10 Average:151.50 Median:151.00 stddev:3.44 (2.3%) stddev-sans-first:3.53 15:40:14 INFO - PID 10529 | Values: 149.0 150.0 149.0 151.0 151.0 151.0 151.0 161.0 151.0 151.0 15:40:14 INFO - PID 10529 | 15:40:14 INFO - PID 10529 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:94.50 stddev:1.45 (1.5%) stddev-sans-first:1.50 15:40:14 INFO - PID 10529 | Values: 94.0 94.0 94.0 97.0 98.0 95.0 95.0 94.0 94.0 94.0 15:40:14 INFO - PID 10529 | 15:40:14 INFO - PID 10529 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:52.50 stddev:0.52 (1.0%) stddev-sans-first:0.53 15:40:14 INFO - PID 10529 | Values: 52.0 52.0 52.0 52.0 53.0 53.0 53.0 53.0 52.0 52.0 15:40:14 INFO - PID 10529 | 15:40:14 INFO - PID 10529 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:56.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 15:40:14 INFO - PID 10529 | Values: 56.0 56.0 56.0 56.0 55.0 56.0 57.0 55.0 55.0 55.0 15:40:14 INFO - PID 10529 | 15:40:14 INFO - PID 10529 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:2.90 (3.5%) stddev-sans-first:3.07 15:40:14 INFO - PID 10529 | Values: 83.0 91.0 83.0 84.0 83.0 82.0 81.0 82.0 81.0 82.0 15:40:14 INFO - PID 10529 | 15:40:14 INFO - PID 10529 | [#11] stanford-crypto-ccm Cycles:10 Average:141.30 Median:138.50 stddev:15.94 (11.5%) stddev-sans-first:16.83 15:40:14 INFO - PID 10529 | Values: 137.0 138.0 139.0 133.0 145.0 135.0 139.0 132.0 185.0 130.0 15:40:14 INFO - PID 10529 | 15:40:14 INFO - PID 10529 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.00 Median:194.00 stddev:5.12 (2.6%) stddev-sans-first:5.32 15:40:14 INFO - PID 10529 | Values: 192.0 195.0 193.0 207.0 191.0 192.0 190.0 193.0 199.0 198.0 15:40:14 INFO - PID 10529 | 15:40:14 INFO - PID 10529 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:73.00 stddev:2.57 (3.5%) stddev-sans-first:2.65 15:40:14 INFO - PID 10529 | Values: 71.0 71.0 71.0 69.0 72.0 72.0 77.0 76.0 74.0 75.0 15:40:14 INFO - PID 10529 | -------- Summary: end -------- 15:40:14 INFO - PID 10529 | 15:40:15 INFO - TEST-INFO | 10529: exit 0 15:40:15 INFO - TEST-OK | kraken | took 64957ms 15:40:15 INFO - SUITE-END | took 1189s 15:40:15 INFO - Completed test suite (00:19:49) 15:40:15 INFO - javascript benchmark 15:40:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6623.155072622569, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2744.2178978990987, 2766.0871912268954, 2779.3607470281822, 2797.523732559126, 2818.210900947734, 5154.536091751751, 5260.053190425722, 5280.102382594959, 5281.419043905167, 5329.92005119923, 5275.551578115865, 5286.471352864712, 5287.735613219343, 5288.127458969275, 5302.257683924244, 4612.1928662484015, 4683.859484215479, 4714.669973101884, 4718.952810471903, 4768.499307572707, 4726.66913316068, 4743.739094349809, 4763.880902977436, 4773.546513081252, 4774.140654682155, 4741.8103275868925, 4744.572988431058, 4752.548507891762, 4764.0, 4785.545373189559, 4698.835540756074, 4728.267118596623, 4730.858074257743, 4735.881602959919, 4755.286706993944, 4726.196546587088, 4751.738654374008, 4767.856964291077, 4790.712557246541, 4812.350332705075, 4763.873489560812, 4955.801767929314, 5144.151215049513, 5176.145935920568, 5183.818566350197, 5566.471185237396, 5632.042552765999, 5633.63381380209, 5638.436156384329, 5639.605227634067, 5664.603477756558, 5781.739821708034, 5783.277090363705, 5786.855328616776, 5789.88420231593, 5300.522952934254, 5300.602454815904, 5303.04545181871, 5303.098473259555, 5303.708296043677, 5853.560982926298, 5864.44287792659, 5867.295924489089, 5868.794592189253, 5869.8239052828485, 5492.258545096441, 5554.1391084381985, 5555.0, 5558.194061861008, 5559.861003474945, 5678.063119585222, 5684.09054551278, 5698.458646428583, 5703.201551782754, 5758.0787074068785, 5681.176229446707, 5714.857128571736, 5729.9713501432225, 5731.398203188605, 5738.483536481736, 5515.889682206333, 5584.078627026495, 5587.3015873015875, 5589.692566908859, 5658.236138121383, 4677.836275730333, 4688.085823264499, 4692.296155576691, 4697.0, 4699.412573428322, 4025.959740402617, 4026.617471340218, 4027.476428064333, 4062.51249850014, 4074.3888416737727, 4820.542048505386, 4829.396325459317, 4834.709917404896, 4852.733099679552, 4878.048780487842, 5626.549876009909, 5695.003374409462, 5702.6863522506665, 5757.165211044375, 5764.423557644286, 4777.976110119427, 4780.54584814449, 4782.378290822171, 4785.162596545661, 4791.688540244873, 4947.0, 5025.924611130836, 5042.0, 5078.035173317058, 5080.314157588752, 5279.841604751864, 5326.0, 5327.147656374961, 5328.813491527778, 5358.732063396893, 5752.30972283312, 5753.9136912945505, 5755.71221438918, 5758.366579676316, 5764.7405866736935, 5148.073346797462, 5216.191490319006, 5217.06092903281, 5236.842894713165, 5373.489518495737, 5627.8593035174445, 5649.378568357395, 5684.204211410323, 5698.886022279448, 5699.772009119754, 5707.571932105026, 5742.339630942495, 5759.1649210865025, 5763.567732420169, 5769.94230057694, 5423.891522169455, 5485.985092757693, 5551.666899986014, 5553.4724201200825, 5554.08357620988, 5484.095124304445, 5510.504054635102, 5529.889402212014, 5534.667919924817, 5541.168824676331, 5479.671219726829, 5480.123180291134, 5481.616286859881, 5483.341998960151, 5513.338399392099, 5551.472610102034, 5570.136628822539, 5573.058391791762, 5575.275214222125, 5584.804531841366, 5270.947290527046, 5373.435789242073, 5393.083175860034, 5395.082835917982, 5466.863328416822], "value": 5153.3777207562625, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.3907518954718, 629.4020680353665, 640.388429050257, 1079.1636481726662, 1091.5360971587074, 27740.861295693518, 34210.0, 34816.82591587039, 34870.0, 34893.82553087231, 36844.44733329002, 37227.441588376125, 37305.440418393744, 37365.25269494609, 37370.8131459343, 5136.563392111675, 7208.0, 7373.373263272601, 7374.926250737478, 7375.299346562068, 5511.641743286674, 7022.297770222988, 7219.0976127984, 7231.3130252625915, 7233.168185658637, 7315.707371705125, 7367.226441223675, 7367.263273672644, 7373.926260737378, 7375.151857536398, 7294.234105418935, 7315.30504602062, 7346.742863999788, 7360.2271761465345, 7362.558246505227, 7071.328223818729, 7142.964285178593, 7144.106986626672, 7146.106736657918, 7147.857042859166, 33848.49227261593, 34064.0, 34150.48774268388, 34153.487697684555, 34177.487337689956, 2556.821022528424, 2587.107447930461, 2587.275562842407, 2591.403977085262, 2648.351153967271, 23619.29142125739, 23741.7625823743, 23742.881285593634, 23955.40111497209, 24128.155514556907, 2889.927751806201, 2964.392299578581, 2966.821990680566, 2967.139529536432, 2969.9554506682416, 154696.0, 154975.22512387478, 155059.99999999886, 155524.0, 155577.0, 43938.56061439409, 43963.56036439659, 44290.77854610706, 44421.77789111034, 44431.0, 46558.53441465542, 46650.533494665295, 46652.76673616678, 46778.53221467742, 46823.0, 12276.938615306866, 12650.114491985472, 12651.367431628381, 12672.239665620093, 12683.0, 8440.451370660887, 8854.38019338653, 10151.137153342048, 10162.4918754062, 10176.185905127571, 10990.560377584967, 11127.499262533205, 11131.053860421793, 12221.877781222252, 12351.752964940652, 5034.194528875362, 5217.895642087213, 5236.6334356595435, 5269.762860671279, 5292.206169074592, 873.6592728835759, 900.4237288135598, 912.4662072687552, 922.4327038871046, 940.1632547033146, 20261.898690506452, 21124.577508450053, 21173.364799056053, 21176.682349764767, 21347.67978480324, 976.3200015956246, 984.8768903887014, 985.1183191043975, 1001.2140469731225, 1013.0578561937322, 10785.352878827296, 11087.50106245221, 11129.165312601588, 11173.608923687794, 11216.0, 206091.0, 206195.0, 207069.0, 208216.0, 209195.0, 41614.375784363256, 41768.791156044026, 41789.16421671549, 41858.37212441816, 41871.37192942108, 1168.5033860609376, 1247.95008199671, 1256.9371531423392, 1257.1577043380773, 1265.4558539827779, 19822.702659459832, 20277.59444811125, 20776.026277503614, 20835.479113022295, 20849.79150208539, 31017.224569385948, 31084.533731993586, 31202.843985779928, 31210.68789312078, 31230.843845780626, 216244.0, 217298.0, 217570.0, 217739.0, 218014.0, 29127.85436072806, 29211.123666290045, 29217.85391073031, 29232.853835730686, 29246.0, 35281.647183527835, 35625.46561801627, 36188.45717314295, 36200.27599448049, 36395.08839292903, 26940.461190776467, 27280.590791138548, 27333.316667083483, 27835.0, 28288.0, 27010.864945675145, 27282.0, 27902.581461277692, 27997.160085197476, 28223.435531288847, 29939.401211976074, 30325.848370758005, 30522.847385763816, 30647.387052259277, 30683.386332273676, 26123.346916327242, 26283.54594702503, 26710.86644566765, 27054.1883743488, 27189.456210875276, 19491.0, 20319.390418287476, 20496.0, 20498.487537811077, 20696.689549656465], "value": 14710.028302073382, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.8818354493651, 407.2323669882273, 426.63522688101665, 437.2348390316945, 439.12833026442524, 12689.0, 14425.206613636246, 19062.04689765513, 19488.90255548722, 19606.31377901774, 18014.459566213, 18586.721199182022, 18848.5287867803, 19264.422067338, 19499.5125121872, 5425.0, 5469.671819690831, 5632.5212356949505, 5638.605297629168, 5680.460356266169, 3423.1955490459723, 5633.971830140844, 5730.656160630355, 5739.684317362543, 5754.798582049629, 3613.0606042428894, 5419.701916394597, 5666.0, 5671.461211184931, 5681.062624666925, 5600.159976003632, 5602.803901863456, 5667.319921609413, 5690.516306113986, 5697.0, 5013.5989120870245, 5136.101182293084, 5138.640295179339, 5138.743062846843, 5156.278121063054, 22211.777882221133, 22499.77500224993, 22595.88702056479, 22608.20871269514, 22993.080276788907, 1553.2777258574818, 1572.3553343129377, 1583.5566041508396, 1583.6436801719635, 1618.9595260118474, 13700.725985480234, 14089.225092619901, 14210.218437985906, 14383.568492945229, 15041.172735499653, 1811.583335832766, 1824.835764781176, 1874.9062546872738, 1906.066027646457, 1913.0912816412233, 91411.0, 91786.0, 95244.52377738067, 95463.0, 96718.0, 10758.677239682822, 10998.34009959405, 11042.33745975244, 11148.554057837595, 11183.217174797848, 15821.762673559906, 15874.0, 15933.12367819781, 15935.521934341989, 15977.840221597868, 7157.585987982102, 7265.4016116454295, 7302.525335853259, 7472.364848987897, 7492.51298665585, 6552.541322107502, 6614.404703576605, 6757.560758550679, 6798.8300292492095, 6821.0, 6926.930730692729, 7111.53775004623, 7120.821979450555, 7145.285471452813, 7195.676194571257, 1985.9813084112357, 2043.5810658814908, 2099.6535571630816, 2102.8107470327745, 2228.6039067875304, 794.7417089445953, 866.8699695045667, 869.2307308032437, 869.3742701148892, 874.1826392323198, 16646.50060498187, 16773.412930547373, 17383.304667813398, 17552.64894702099, 17891.37380191687, 864.4381152251087, 866.6143566113019, 880.9691660791841, 882.4969767232744, 889.515214208258, 9334.206592439583, 9335.06649335061, 9634.759131021641, 9694.175995040501, 9853.556589953469, 449611.0, 492033.0, 492496.0, 492791.5766738652, 502149.0, 89972.5501372489, 92136.0, 93501.0, 93645.0, 93913.53043234877, 1084.4902895639036, 1101.8512500812287, 1144.2219290882113, 1146.2606618730872, 1149.6321177223376, 17321.30714771395, 17614.735778963583, 18203.0, 18203.908980455013, 18294.359697410528, 41839.37240941328, 41922.0, 42385.57614423816, 42717.78641106775, 43048.139037218454, 53071.0, 53840.19239711486, 55135.72432137813, 55339.44660553343, 56151.71924140353, 8071.112177660335, 8149.266566009088, 8210.055843577826, 8349.0, 8425.410221284452, 11958.282503049844, 12615.0, 12712.555060572835, 13466.326683665973, 13756.105853119516, 9224.215941644767, 9733.0, 10487.423191724529, 10502.10732087781, 10508.632197873343, 9639.277054220822, 10219.540120694735, 10238.53926573291, 10270.948645256725, 10921.890781092088, 9528.666496672584, 10223.335483193569, 10701.19741019411, 10961.945190273998, 11087.611933582286, 8015.278624923785, 8077.4749641275475, 8154.266116049584, 8278.461899976483, 8350.624221909908, 9992.200623950212, 10089.344192627455, 10186.439745813756, 10723.89276107229, 10914.0], "value": 8938.897979446501, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1292.3279894454884, 1354.5936219134257, 1371.7599420101485, 1375.154280117728, 1378.1386633354155, 9422.104900034503, 9864.654737084204, 9885.308028438012, 9902.554385052672, 9903.702888913325, 9848.310618256724, 10100.141487973531, 10170.64402745904, 10183.745406364844, 10184.898151018488, 2216.7894050065256, 2280.133549251282, 2281.2471884278148, 2285.8399912006166, 2290.80528155107, 1842.309134074722, 1903.990884831035, 2151.806337429631, 2221.7778222177735, 2263.524659821431, 2162.19998600518, 2258.153192552793, 2260.389694782408, 2261.570301642691, 2267.0818318581, 2169.8481106322565, 2217.4567231028423, 2226.0, 2227.7772222777753, 2253.267688001406, 2215.944601384962, 2224.9555008899733, 2226.4322597737473, 2226.4656482444257, 2227.866328020324, 9660.90339096607, 9667.516624168833, 9768.609255629766, 9798.559064842098, 9799.16707079899, 5301.496357845998, 5436.21174929637, 5648.576356773258, 5650.6892120933335, 5652.858678533028, 3173.3653269346223, 3332.0670212340583, 3402.608699999507, 3406.863725450979, 3417.487376893461, 1099.0535652346314, 1121.147927575049, 1145.8682251541097, 1148.4774427635489, 1160.9303441793436, 14289.214093224868, 14548.854511454856, 14560.70878582433, 14624.926875365662, 14635.70728585433, 4906.975465122651, 5090.211017292326, 5132.358455193101, 5153.948460515422, 5239.318888544541, 12207.45066471993, 12216.0, 12219.0, 12219.900208981056, 12235.143539952118, 5681.403452637496, 5682.857928551736, 5687.51656109227, 5689.402612725687, 5691.630044047207, 4993.425756038029, 5019.171836646912, 5080.669756465818, 5093.0, 5136.512031357015, 4081.076079439744, 4111.321631930758, 4236.4492615959725, 4247.086876321606, 4297.957020429818, 1163.3717792392013, 1281.14803655568, 1328.3955800111119, 1343.1202562321696, 1344.0860215053858, 544.3576579635989, 653.6470306034784, 703.5356664601441, 711.1004579207307, 742.3652776875801, 5071.112555302807, 5204.375474942955, 5204.516712736852, 5228.346456692913, 5470.890582188334, 799.8640231160716, 813.7477382011477, 824.8432797768525, 832.4297855968681, 834.4826207751112, 3617.1680513482047, 3655.3785856404475, 3680.7607505512055, 3751.464252387435, 3826.0, 12594.748105038032, 13192.20846749198, 13208.801867971988, 13219.206847589176, 13224.801627975588, 13058.931151179466, 13061.412236449383, 13095.410706518229, 13099.410526526139, 13116.672083197996, 9267.814643707088, 9411.952940235255, 9616.423014619146, 9624.75938101553, 9627.229821614254, 5559.332880054258, 5589.133684278943, 5671.6597004179885, 5708.143778433268, 5795.59430839854, 11417.486213120263, 11453.427328633701, 11522.884771152181, 11615.88384116148, 11751.941240293743, 11839.0, 11875.465604047666, 11928.880711192776, 11965.461554230254, 12029.819552706542, 7556.546607203585, 7672.194419586086, 7704.768856934301, 7734.303912647663, 7737.148913619385, 9010.50442225684, 9219.124183202584, 9294.581743821409, 9313.208377288007, 9342.112499312554, 7637.465377423527, 7756.495827771177, 7759.883601746092, 7823.061232652118, 7951.045874495097, 7704.691812327668, 7807.6096195188875, 7842.490238134503, 7892.565908875067, 8063.072746633978, 6395.584287021329, 6503.0, 6515.6742162892615, 6520.641364724986, 6526.0, 4860.513948605111, 4924.586952393373, 4955.1576232039915, 5070.5154474308065, 5164.664296820694, 4893.0, 4902.779374928208, 5004.999000199902, 5010.924836127534, 5042.4705405931845], "value": 4727.472088429962, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.6471504997677, 395.28256214969826, 406.87590284963073, 407.11655707115557, 410.9979450102749, 5426.1046927257, 5453.182022696597, 5453.182022696597, 5456.181572764087, 5462.945370546298, 5087.694738315695, 5222.138347172721, 5257.342832145981, 5261.973690131554, 5340.519353258206, 4041.5958404159496, 4044.1102957349485, 4044.3933409988445, 4044.5146582410152, 4048.3117869962175, 4064.841520166753, 4072.3687828386646, 4073.8370465181506, 4076.5145800340724, 4077.1234184650293, 3901.765894046352, 3978.164585437047, 4017.819198136091, 4019.5779443158485, 4032.2943484890175, 3977.3636218204947, 4002.799860006988, 4016.116454380032, 4018.2365350583295, 4023.7786921719294, 3504.9824750876337, 3507.298540291926, 3528.659109538359, 3534.6465353464705, 3537.239493508908, 5003.649744517885, 5093.363329583802, 5104.489551044903, 5116.0, 5121.539061484447, 4722.433308003027, 4741.83403580873, 4751.0, 4755.358026666425, 4763.976180119112, 5567.832965011056, 5576.972115139439, 5579.414161513064, 5581.609287349887, 5590.664560126364, 3948.723589348747, 3958.4656071430277, 3970.6426421621904, 3971.702122340836, 3976.7216294859372, 5633.746481408347, 5637.436256374371, 5763.423657634287, 5802.941970580325, 5880.117982302646, 4055.5538890721996, 4065.2276067547073, 4067.4102255172834, 4068.613481719232, 4081.4490043844294, 4120.896977575585, 4135.483064616923, 4141.81361838718, 4147.050886083536, 4148.398482220061, 4458.706974977285, 4561.429821272341, 4623.352730617717, 4707.152712511713, 4729.290606409066, 5588.552915766729, 5598.272224610856, 5599.272094627672, 5604.579656525777, 5605.0, 1394.8047273381735, 1430.1562078373809, 1438.8561143885527, 1443.4370595467776, 1445.2990299704634, 954.0936110694868, 957.6408846682494, 960.2989817433313, 960.6973803252093, 972.9027097290356, 4879.780409881564, 4889.435380678149, 4905.779239934212, 4909.018196360742, 4912.680675756064, 5800.0, 5821.88356232873, 5825.825225243249, 5831.06702927538, 5866.823995280149, 4724.4094488188975, 4859.173940430135, 4869.269609558594, 4873.6832105913, 4893.975530122398, 3074.9692503074684, 3081.383723255358, 3083.198368424226, 3106.285554322473, 3107.207662046164, 5377.677339359651, 5388.649737767033, 5415.640409470414, 5424.810131645373, 5426.8914621707345, 5764.769409223584, 5918.8816223675285, 5928.318243401977, 5964.522838172936, 5968.37332080134, 5369.114096174166, 5375.704336261465, 5390.460953904578, 5401.756920938567, 5408.3509978802795, 5587.385387607279, 5767.5385969121535, 5770.942290577041, 5802.564807639359, 5829.183914251923, 5696.430356964271, 5716.657000579979, 5723.3418156912485, 5748.942510575008, 5751.48236658686, 5190.506901844319, 5225.268462415341, 5323.600729945347, 5362.785488580413, 5386.649867758583, 4051.5948405159247, 4057.736247143926, 4072.511298644063, 4075.1238483726142, 4083.8570650027104, 5569.916451253315, 5755.280589926259, 5791.305043394819, 5795.217645617956, 5811.680357580373, 5576.581756368208, 5603.635763675348, 5616.0, 5626.85932851682, 5648.774049038157, 5589.888202236014, 5611.204414587293, 5620.437956204347, 5621.128725047624, 5625.606207565431, 5334.573234141337, 5487.585462396532, 5525.198846167364, 5534.529564987021, 5538.778448862, 5615.466530679579, 5618.016847051831, 5628.887422251614, 5650.971745141248, 5670.659760414388, 5522.978249023943, 5525.171224316385, 5525.198846167364, 5543.8891222174525, 5548.250986116984], "value": 4215.832328159663, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.3560014585925, 667.6194569095614, 670.4636290967227, 674.5446823394213, 716.1084449859925, 13262.734745305088, 14095.71808563828, 14120.576382708523, 14176.362063707133, 14197.929010354934, 13897.652558686037, 14012.29938503076, 14041.22773247471, 14161.0, 14162.150270983748, 893.7408151636017, 905.0723008915849, 916.3722849847842, 936.0686117313248, 951.6811868024221, 900.9819803603924, 949.2453499467905, 955.2167222877209, 955.2883102088954, 956.7273327101777, 954.4511905654242, 1012.0891197921856, 1013.108464551194, 1014.6245889021072, 1014.8325526288154, 938.7934654376061, 992.1665800727387, 992.6476100984191, 994.602159136344, 996.5565323431076, 696.8257935516122, 721.7329588052402, 740.6333864736989, 740.7222291640635, 740.76665850257, 13352.599422017354, 13672.52146174879, 14106.224157671324, 14577.708445831024, 14686.632834179125, 14113.717725645532, 14577.671594246138, 14590.197539135343, 14624.926875365662, 14711.926440367837, 10616.893831061745, 10645.223621040688, 10766.946165269203, 10814.188935829845, 10877.292975956616, 2740.287525243431, 2750.8899644014214, 2771.3210263485375, 2813.831170129799, 2870.512012957802, 66679.0, 67046.66476667635, 67097.0, 67523.66238168826, 68051.65974170147, 10721.463926803628, 10832.512536935857, 10940.617078402218, 11082.556697732161, 11333.619939812566, 21828.976252244807, 22160.445988850086, 22176.334709958726, 22226.666600001012, 22375.776242237695, 6571.851381012475, 6597.30728273534, 6692.59844409337, 6737.629430381278, 6857.828554286183, 3315.502674598781, 3358.580177477815, 3412.19813343864, 3418.67522585354, 3496.900723496679, 3588.2285308658766, 3641.5083963665097, 3645.5260816093737, 3672.412414013745, 3685.7235707322056, 627.1658693937053, 628.4187126907592, 631.4380201620561, 642.945349645276, 646.3859333632973, 509.6228790694859, 536.9114096174166, 540.1169088540187, 541.4937033873341, 548.3760207407615, 7195.280471952868, 7206.855862882713, 7325.157606875171, 7340.44946629005, 7857.1357150713375, 444.5792658971931, 481.27568010144506, 525.8720045502453, 536.8845698174833, 551.31361454988, 3624.873129440457, 3722.8696995605565, 3737.757045792069, 3924.803759811998, 3946.467226924386, 63219.683901580196, 63389.68305158445, 65468.0, 65653.67173164104, 67046.66476667683, 54206.0, 55203.44796552063, 55451.0, 55610.0, 56053.439465604824, 46707.53292467168, 46950.29574556453, 47360.0, 48612.513874861506, 49060.509394905595, 8100.432969692065, 8419.242268195892, 8448.619812108593, 8465.492070475791, 8634.654613815377, 24429.14497992562, 25224.74775252224, 25329.366765831, 25736.8713156433, 26554.203373898814, 30974.53538196884, 31052.53421198729, 31278.687213128487, 31335.21661958469, 32244.677553224166, 10596.258261921592, 10667.733306667395, 10710.625128120479, 10791.190660700322, 10941.507632156412, 11740.647780566596, 11883.524659013543, 11943.104267179822, 11995.940020300191, 12384.56654017105, 10390.636327728493, 10721.195910306602, 10725.89274107249, 10831.837522437012, 10924.2899211551, 10459.738506537398, 10517.316374435637, 10528.105111065644, 10530.31552949056, 10647.361158330525, 10282.126019288444, 10450.425226612306, 10570.630027948984, 10710.89289107099, 11101.611443599435, 8190.590470476572, 8394.916050839658, 8411.411201215857, 8560.785980350542, 8648.56757162152, 8537.701180458655, 8799.516026618341, 8856.512891791013, 8943.418677785923, 8953.552322383724], "value": 6249.632236682263, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 113.0, 113.0, 112.0, 111.0, 112.0, 112.0, 110.0, 113.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 126.0, 136.0, 177.0, 127.0, 125.0, 130.0, 125.0, 160.0, 125.0], "value": 138.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 164.0, 165.0, 169.0, 164.0, 164.0, 167.0, 163.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 114.0, 77.0, 76.0, 76.0, 77.0, 93.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 115.0, 85.0, 84.0, 83.0, 103.0, 84.0, 84.0, 105.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 114.0, 114.0, 113.0, 119.0, 113.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 149.0, 151.0, 151.0, 151.0, 151.0, 161.0, 151.0, 151.0], "value": 151.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 97.0, 98.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 52.0, 53.0, 53.0, 53.0, 53.0, 52.0, 52.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 55.0, 56.0, 57.0, 55.0, 55.0, 55.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 91.0, 83.0, 84.0, 83.0, 82.0, 81.0, 82.0, 81.0, 82.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 138.0, 139.0, 133.0, 145.0, 135.0, 139.0, 132.0, 185.0, 130.0], "value": 141.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 195.0, 193.0, 207.0, 191.0, 192.0, 190.0, 193.0, 199.0, 198.0], "value": 195.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 71.0, 69.0, 72.0, 72.0, 77.0, 76.0, 74.0, 75.0], "value": 72.8, "unit": "score"}]}]} 15:40:15 INFO - Return code: 0 15:40:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:40:15 ERROR - # TBPL SUCCESS # 15:40:15 INFO - Running post-action listener: _resource_record_post_action 15:40:15 INFO - [mozharness: 2017-04-03 22:40:15.778157Z] Finished run-tests step (success) 15:40:15 INFO - Running post-run listener: _resource_record_post_run 15:40:15 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 4096; Write bytes: 377937920; Read time: 20; Write time: 209156 15:40:15 INFO - TinderboxPrint: CPU usage
13.0% 15:40:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 15:40:15 INFO - TinderboxPrint: I/O write bytes / time
377,937,920 / 209,156 15:40:15 INFO - TinderboxPrint: CPU idle
8,372.4 (87.0%) 15:40:15 INFO - TinderboxPrint: CPU user
1,207.5 (12.5%) 15:40:15 INFO - TinderboxPrint: Swap in / out
0 / 0 15:40:15 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115044352; Read time: 0; Write time: 96124 15:40:15 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 262512640; Read time: 0; Write time: 113008 15:40:16 INFO - Running post-run listener: _upload_blobber_files 15:40:16 INFO - Blob upload gear active. 15:40:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:40:16 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 15:40:16 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:40:16 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:40:16 INFO - (blobuploader) - INFO - Open directory for files ... 15:40:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:40:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:40:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:40:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:40:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:40:17 INFO - (blobuploader) - INFO - Done attempting. 15:40:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:40:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:40:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:40:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:40:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:40:18 INFO - (blobuploader) - INFO - Done attempting. 15:40:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:40:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:40:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:40:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:40:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:40:19 INFO - (blobuploader) - INFO - Done attempting. 15:40:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:40:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:40:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:40:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:40:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:40:22 INFO - (blobuploader) - INFO - Done attempting. 15:40:22 INFO - (blobuploader) - INFO - Iteration through files over. 15:40:22 INFO - Return code: 0 15:40:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:40:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:40:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a196aab9af0692fdef6ccceb9368c28531ffb8ef72f51ecc047b9a874ff957c264738e5275ffb4822b892c363798727acb7dad3b7d9048f4e6c92393dca0842", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9905752a593c0d6bc85ddbdb64c2bb73e22a7fbb3a2c373ace69f422324567d14bdd479f5bb6435bfc68af41ca36b75135d9f5d02d6c9bbc4e21feef4c3470ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8a3e265126981325ca307e5015a5e668737cedbcf5b655fa56441e9ff773a71e2399b6e67d48edd83fa96bfb04d479a3d18f3183be30a9bdd2e60268edc8305", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c2beeb1ccbcf45dd564e4a81817fe3455e635dc9b736a16325a60c2736bd801aeffb64af9dd3b8d3239b54fb063f6d7abe8c3dea4f56e1c95e1eb78a3fe0a54"} 15:40:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:40:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:40:22 INFO - Contents: 15:40:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a196aab9af0692fdef6ccceb9368c28531ffb8ef72f51ecc047b9a874ff957c264738e5275ffb4822b892c363798727acb7dad3b7d9048f4e6c92393dca0842", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9905752a593c0d6bc85ddbdb64c2bb73e22a7fbb3a2c373ace69f422324567d14bdd479f5bb6435bfc68af41ca36b75135d9f5d02d6c9bbc4e21feef4c3470ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8a3e265126981325ca307e5015a5e668737cedbcf5b655fa56441e9ff773a71e2399b6e67d48edd83fa96bfb04d479a3d18f3183be30a9bdd2e60268edc8305", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c2beeb1ccbcf45dd564e4a81817fe3455e635dc9b736a16325a60c2736bd801aeffb64af9dd3b8d3239b54fb063f6d7abe8c3dea4f56e1c95e1eb78a3fe0a54"} 15:40:22 INFO - Running post-run listener: copy_logs_to_upload_dir 15:40:22 INFO - Copying logs to upload dir... 15:40:22 INFO - mkdir: /builds/slave/test/build/upload/logs 15:40:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.002845 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-04-03 15:40:22.313715) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 15:40:22.317258) ========= 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=0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677 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/sha512/8a196aab9af0692fdef6ccceb9368c28531ffb8ef72f51ecc047b9a874ff957c264738e5275ffb4822b892c363798727acb7dad3b7d9048f4e6c92393dca0842", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9905752a593c0d6bc85ddbdb64c2bb73e22a7fbb3a2c373ace69f422324567d14bdd479f5bb6435bfc68af41ca36b75135d9f5d02d6c9bbc4e21feef4c3470ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8a3e265126981325ca307e5015a5e668737cedbcf5b655fa56441e9ff773a71e2399b6e67d48edd83fa96bfb04d479a3d18f3183be30a9bdd2e60268edc8305", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c2beeb1ccbcf45dd564e4a81817fe3455e635dc9b736a16325a60c2736bd801aeffb64af9dd3b8d3239b54fb063f6d7abe8c3dea4f56e1c95e1eb78a3fe0a54"} build_url:https://queue.taskcluster.net/v1/task/HUZCYkopRRifab-IdBq9ew/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011463 build_url: 'https://queue.taskcluster.net/v1/task/HUZCYkopRRifab-IdBq9ew/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a196aab9af0692fdef6ccceb9368c28531ffb8ef72f51ecc047b9a874ff957c264738e5275ffb4822b892c363798727acb7dad3b7d9048f4e6c92393dca0842", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9905752a593c0d6bc85ddbdb64c2bb73e22a7fbb3a2c373ace69f422324567d14bdd479f5bb6435bfc68af41ca36b75135d9f5d02d6c9bbc4e21feef4c3470ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8a3e265126981325ca307e5015a5e668737cedbcf5b655fa56441e9ff773a71e2399b6e67d48edd83fa96bfb04d479a3d18f3183be30a9bdd2e60268edc8305", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c2beeb1ccbcf45dd564e4a81817fe3455e635dc9b736a16325a60c2736bd801aeffb64af9dd3b8d3239b54fb063f6d7abe8c3dea4f56e1c95e1eb78a3fe0a54"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 15:40:22.342411) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 15:40:22.342748) ========= 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=0333a256a5e4f052382dd180000001b1-1491257955.29479-2145825677 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 15:40:22.426479) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 15:40:22.426809) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 15:40:22.427109) ========= ========= Total master_lag: 0.16 =========