builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs slave: talos-linux64-ix-075 starttime: 1494278993.27 results: success (0) revision: bab7046ee2d82345d7d5b33b8ae4009c7e365176 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 14:29:53.273259) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 14:29:53.273934) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 14:29:53.274362) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 14:29:53.293064) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 14:29:53.293422) ========= 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=fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-08 14:29:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-05-08 14:29:53 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115738 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 14:29:53.426773) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 14:29:53.427113) ========= 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=fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015133 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 14:29:53.476466) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-08 14:29:53.479979) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bab7046ee2d82345d7d5b33b8ae4009c7e365176 --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 bab7046ee2d82345d7d5b33b8ae4009c7e365176 --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=fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-08 14:29:53,820 truncating revision to first 12 chars 2017-05-08 14:29:53,820 Setting DEBUG logging. 2017-05-08 14:29:53,820 attempt 1/10 2017-05-08 14:29:53,820 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bab7046ee2d8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-08 14:29:54,998 unpacking tar archive at: mozilla-central-bab7046ee2d8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.473936 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-08 14:29:54.967388) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 14:29:54.970845) ========= script_repo_revision: bab7046ee2d82345d7d5b33b8ae4009c7e365176 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 14:29:54.971269) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 14:29:54.971539) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 14:29:54.982194) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-05-08 14:29:54.982595) ========= /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=fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:29:55 INFO - MultiFileLogger online at 20170508 14:29:55 in /builds/slave/test 14:29:55 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 14:29:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:29:55 INFO - {'append_to_log': False, 14:29:55 INFO - 'base_work_dir': '/builds/slave/test', 14:29:55 INFO - 'blob_upload_branch': 'Firefox', 14:29:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:29:55 INFO - 'branch': 'Firefox', 14:29:55 INFO - 'buildbot_json_path': 'buildprops.json', 14:29:55 INFO - 'config_files': ('talos/linux_config.py',), 14:29:55 INFO - 'default_actions': ('clobber', 14:29:55 INFO - 'read-buildbot-config', 14:29:55 INFO - 'download-and-extract', 14:29:55 INFO - 'populate-webroot', 14:29:55 INFO - 'create-virtualenv', 14:29:55 INFO - 'install', 14:29:55 INFO - 'run-tests'), 14:29:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:29:55 INFO - 'download_minidump_stackwalk': True, 14:29:55 INFO - 'download_symbols': 'ondemand', 14:29:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:29:55 INFO - 'tooltool.py': '/tools/tooltool.py', 14:29:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:29:55 INFO - '/tools/misc-python/virtualenv.py')}, 14:29:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:29:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:29:55 INFO - 'gecko_profile': False, 14:29:55 INFO - 'gecko_profile_interval': 0, 14:29:55 INFO - 'installer_path': 'installer.exe', 14:29:55 INFO - 'log_level': 'info', 14:29:55 INFO - 'log_name': 'talos', 14:29:55 INFO - 'log_to_console': True, 14:29:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:29:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:29:55 INFO - 'opt_config_files': (), 14:29:55 INFO - 'pip_index': False, 14:29:55 INFO - 'suite': 'dromaeojs', 14:29:55 INFO - 'system_bits': '32', 14:29:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:29:55 INFO - 'title': 'talos-linux64-ix-075', 14:29:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:29:55 INFO - 'use_talos_json': True, 14:29:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:29:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:29:55 INFO - 'work_dir': 'build'} 14:29:55 INFO - [mozharness: 2017-05-08 21:29:55.416227Z] Running clobber step. 14:29:55 INFO - Running pre-action listener: _resource_record_pre_action 14:29:55 INFO - Running main action method: clobber 14:29:55 INFO - rmtree: /builds/slave/test/build 14:29:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:29:56 INFO - Running post-action listener: _resource_record_post_action 14:29:56 INFO - [mozharness: 2017-05-08 21:29:56.349303Z] Finished clobber step (success) 14:29:56 INFO - [mozharness: 2017-05-08 21:29:56.349403Z] Running read-buildbot-config step. 14:29:56 INFO - Running pre-action listener: _resource_record_pre_action 14:29:56 INFO - Running main action method: read_buildbot_config 14:29:56 INFO - Using buildbot properties: 14:29:56 INFO - { 14:29:56 INFO - "project": "", 14:29:56 INFO - "product": "firefox", 14:29:56 INFO - "who": "kwierso@gmail.com", 14:29:56 INFO - "installer_path": "public/build/target.tar.bz2", 14:29:56 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs", 14:29:56 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 14:29:56 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs", 14:29:56 INFO - "stage_platform": "linux64-stylo", 14:29:56 INFO - "basedir": "/builds/slave/test", 14:29:56 INFO - "buildnumber": 85, 14:29:56 INFO - "platform": "ubuntu64_hw_stylo", 14:29:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:29:56 INFO - "slavebuilddir": "test", 14:29:56 INFO - "taskId": "Nq6dZ8IfRQqov0LIs55N3w", 14:29:56 INFO - "branch": "mozilla-central", 14:29:56 INFO - "script_repo_revision": "production", 14:29:56 INFO - "revision": "bab7046ee2d82345d7d5b33b8ae4009c7e365176", 14:29:56 INFO - "slavename": "talos-linux64-ix-075", 14:29:56 INFO - "repo_path": "mozilla-central" 14:29:56 INFO - } 14:29:56 INFO - Finding installer, test and symbols from parent task. 14:29:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nq6dZ8IfRQqov0LIs55N3w'}, attempt #1 14:29:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nq6dZ8IfRQqov0LIs55N3w'}, attempt #1 14:29:57 INFO - Task dependencies: FwB1HLWIQt6yclQF3vLb-A 14:29:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A'}, attempt #1 14:29:57 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.tar.bz2 14:29:57 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/test_packages.json 14:29:57 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.crashreporter-symbols.zip 14:29:57 INFO - Running post-action listener: _resource_record_post_action 14:29:57 INFO - [mozharness: 2017-05-08 21:29:57.711619Z] Finished read-buildbot-config step (success) 14:29:57 INFO - [mozharness: 2017-05-08 21:29:57.711835Z] Running download-and-extract step. 14:29:57 INFO - Running pre-action listener: _resource_record_pre_action 14:29:57 INFO - Running main action method: download_and_extract 14:29:57 INFO - mkdir: /builds/slave/test/build/tests 14:29: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')]} 14:29:57 INFO - trying https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.test_packages.json 14:29:57 INFO - Downloading https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:29:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:29:58 INFO - Downloaded 986 bytes. 14:29:58 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:29:58 INFO - Using the following test package requirements: 14:29:58 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:29:58 INFO - u'common': [u'target.common.tests.zip'], 14:29:58 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:29:58 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:29:58 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:29:58 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:29:58 INFO - u'mozbase': [u'target.common.tests.zip'], 14:29:58 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:29:58 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:29:58 INFO - u'web-platform': [u'target.common.tests.zip', 14:29:58 INFO - u'target.web-platform.tests.zip'], 14:29:58 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:29:58 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:29:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.common.tests.zip 14:29:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:29:58 INFO - Fetch https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.common.tests.zip into memory 14:29:59 INFO - Content-Length response header: 58446209 14:29:59 INFO - Bytes received: 58446209 14:30:09 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:30:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.common.tests.zip 14:30:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:30:09 INFO - Fetch https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.common.tests.zip into memory 14:30:10 INFO - Content-Length response header: 58446209 14:30:10 INFO - Bytes received: 58446209 14:30:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.talos.tests.zip 14:30:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:30:21 INFO - Fetch https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.talos.tests.zip into memory 14:30:22 INFO - Content-Length response header: 14409362 14:30:22 INFO - Bytes received: 14409362 14:30:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:22 INFO - trying https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.tar.bz2 14:30:22 INFO - Downloading https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:30:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:30:23 INFO - Downloaded 59930022 bytes. 14:30:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.tar.bz2 14:30:23 INFO - mkdir: /builds/slave/test/properties 14:30:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:30:23 INFO - Writing to file /builds/slave/test/properties/build_url 14:30:23 INFO - Contents: 14:30:23 INFO - build_url:https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.tar.bz2 14:30:23 INFO - Running post-action listener: _resource_record_post_action 14:30:23 INFO - Running post-action listener: set_extra_try_arguments 14:30:23 INFO - [mozharness: 2017-05-08 21:30:23.829523Z] Finished download-and-extract step (success) 14:30:23 INFO - [mozharness: 2017-05-08 21:30:23.829621Z] Running populate-webroot step. 14:30:23 INFO - Running pre-action listener: _resource_record_pre_action 14:30:23 INFO - Running main action method: populate_webroot 14:30:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:30:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:30:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:30:23 INFO - '--tppagecycles', 14:30:23 INFO - '7'], 14:30:23 INFO - 'tests': ['tsvgm']}}, 14:30:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:30:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:30:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:30:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:30:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:30:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:30:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:30:23 INFO - 'talos_options': ['--disable-e10s'], 14:30:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:30:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:30:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:30:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:30:23 INFO - 'talos_options': ['--disable-e10s'], 14:30:23 INFO - 'tests': ['damp', 'tps']}, 14:30:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:30:23 INFO - 'tests': ['damp', 'tps']}, 14:30:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:30:23 INFO - 'tests': ['dromaeo_dom']}, 14:30:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:30:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:30:23 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 14:30:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:30:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:30:23 INFO - 'tests': ['a11yr', 14:30:23 INFO - 'ts_paint', 14:30:23 INFO - 'tpaint', 14:30:23 INFO - 'sessionrestore', 14:30:23 INFO - 'sessionrestore_no_auto_restore', 14:30:23 INFO - 'tabpaint']}, 14:30:23 INFO - 'other-e10s': {'tests': ['a11yr', 14:30:23 INFO - 'ts_paint', 14:30:23 INFO - 'tpaint', 14:30:23 INFO - 'sessionrestore', 14:30:23 INFO - 'sessionrestore_no_auto_restore', 14:30:23 INFO - 'tabpaint']}, 14:30:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:30:23 INFO - 'ts_paint', 14:30:23 INFO - 'tpaint', 14:30:23 INFO - 'sessionrestore', 14:30:23 INFO - 'sessionrestore_no_auto_restore', 14:30:23 INFO - 'tabpaint']}, 14:30:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:30:23 INFO - 'ts_paint', 14:30:23 INFO - 'tpaint', 14:30:23 INFO - 'sessionrestore', 14:30:23 INFO - 'sessionrestore_no_auto_restore', 14:30:23 INFO - 'tabpaint']}, 14:30:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:30:23 INFO - 'tests': ['a11yr', 14:30:23 INFO - 'ts_paint', 14:30:23 INFO - 'tpaint', 14:30:23 INFO - 'sessionrestore', 14:30:23 INFO - 'sessionrestore_no_auto_restore', 14:30:23 INFO - 'tabpaint']}, 14:30:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:30:23 INFO - 'tests': ['a11yr', 14:30:23 INFO - 'ts_paint', 14:30:23 INFO - 'tpaint', 14:30:23 INFO - 'sessionrestore', 14:30:23 INFO - 'sessionrestore_no_auto_restore', 14:30:23 INFO - 'tabpaint']}, 14:30:23 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 14:30:23 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 14:30:23 INFO - 'bloom_basic_ref']}, 14:30:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:30:23 INFO - 'tests': ['tsvgx', 14:30:23 INFO - 'tsvgr_opacity', 14:30:23 INFO - 'tart', 14:30:23 INFO - 'tscrollx', 14:30:23 INFO - 'cart', 14:30:23 INFO - 'tsvg_static']}, 14:30:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:30:23 INFO - 'tsvgr_opacity', 14:30:23 INFO - 'tart', 14:30:23 INFO - 'tscrollx', 14:30:23 INFO - 'cart', 14:30:23 INFO - 'tsvg_static']}, 14:30:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:30:23 INFO - 'talos_options': ['--disable-e10s'], 14:30:23 INFO - 'tests': ['tp5o']}, 14:30:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:30:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:30:23 INFO - 'talos_options': ['--disable-e10s', 14:30:23 INFO - '--xperf_path', 14:30:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:30:23 INFO - 'tests': ['tp5n']}, 14:30:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:30:23 INFO - 'talos_options': ['--xperf_path', 14:30:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:30:23 INFO - 'tests': ['tp5n']}}, 14:30:23 INFO - 'talos.zip': {'path': '', 14:30:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:30:23 INFO - Running post-action listener: _resource_record_post_action 14:30:23 INFO - [mozharness: 2017-05-08 21:30:23.843274Z] Finished populate-webroot step (success) 14:30:23 INFO - [mozharness: 2017-05-08 21:30:23.843363Z] Running create-virtualenv step. 14:30:23 INFO - Running pre-action listener: _resource_record_pre_action 14:30:23 INFO - Running main action method: create_virtualenv 14:30:23 INFO - Creating virtualenv /builds/slave/test/build/venv 14:30:23 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 14:30:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:30:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:30:23 INFO - Using real prefix '/usr' 14:30:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:30:24 INFO - Installing distribute.............................................................................................................................................................................................done. 14:30:26 INFO - Installing pip.................done. 14:30:26 INFO - Return code: 0 14:30:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:30:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:30:26 INFO - Reading from file tmpfile_stdout 14:30:26 INFO - Output received: 14:30:26 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) 14:30:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:26 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 0xb1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe91770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8ea30>, '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 0xe8f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8fca0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871', '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 14:30:26 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 14:30:26 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 14:30:26 INFO - Using env: {'DISPLAY': ':0', 14:30:26 INFO - 'HOME': '/home/cltbld', 14:30:26 INFO - 'LANG': 'en_US.UTF-8', 14:30:26 INFO - 'LANGUAGE': 'en_US:en', 14:30:26 INFO - 'LOGNAME': 'cltbld', 14:30:26 INFO - 'MAIL': '/var/mail/cltbld', 14:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:26 INFO - 'MOZ_NO_REMOTE': '1', 14:30:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:26 INFO - 'NO_EM_RESTART': '1', 14:30:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:26 INFO - 'PWD': '/builds/slave/test', 14:30:26 INFO - 'SHELL': '/bin/bash', 14:30:26 INFO - 'SHLVL': '1', 14:30:26 INFO - 'TERM': 'linux', 14:30:26 INFO - 'TMOUT': '86400', 14:30:26 INFO - 'USER': 'cltbld', 14:30:26 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871', 14:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:26 INFO - '_': '/tools/buildbot/bin/python'} 14:30:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:26 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 14:30:26 INFO - Cleaning up... 14:30:26 INFO - Return code: 0 14:30:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:26 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 0xb1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe91770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8ea30>, '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 0xe8f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8fca0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871', '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 14:30:26 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 14:30:26 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 14:30:26 INFO - Using env: {'DISPLAY': ':0', 14:30:26 INFO - 'HOME': '/home/cltbld', 14:30:26 INFO - 'LANG': 'en_US.UTF-8', 14:30:26 INFO - 'LANGUAGE': 'en_US:en', 14:30:26 INFO - 'LOGNAME': 'cltbld', 14:30:26 INFO - 'MAIL': '/var/mail/cltbld', 14:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:26 INFO - 'MOZ_NO_REMOTE': '1', 14:30:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:26 INFO - 'NO_EM_RESTART': '1', 14:30:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:26 INFO - 'PWD': '/builds/slave/test', 14:30:26 INFO - 'SHELL': '/bin/bash', 14:30:26 INFO - 'SHLVL': '1', 14:30:26 INFO - 'TERM': 'linux', 14:30:26 INFO - 'TMOUT': '86400', 14:30:26 INFO - 'USER': 'cltbld', 14:30:26 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871', 14:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:26 INFO - '_': '/tools/buildbot/bin/python'} 14:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:27 INFO - Downloading/unpacking psutil>=3.1.1 14:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:30:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:30:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:30:28 INFO - Installing collected packages: psutil 14:30:28 INFO - Running setup.py install for psutil 14:30:28 INFO - building 'psutil._psutil_linux' extension 14:30:28 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 14:30:28 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 14:30:28 INFO - building 'psutil._psutil_posix' extension 14:30:28 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 14:30:28 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 14:30:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:30:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:30:28 INFO - Successfully installed psutil 14:30:28 INFO - Cleaning up... 14:30:28 INFO - Return code: 0 14:30:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:30:28 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')]} 14:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:28 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')]} 14:30:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:28 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 0xb1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe91770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8ea30>, '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 0xe8f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8fca0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871', '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 14:30:28 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 14:30:28 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 14:30:28 INFO - Using env: {'DISPLAY': ':0', 14:30:28 INFO - 'HOME': '/home/cltbld', 14:30:28 INFO - 'LANG': 'en_US.UTF-8', 14:30:28 INFO - 'LANGUAGE': 'en_US:en', 14:30:28 INFO - 'LOGNAME': 'cltbld', 14:30:28 INFO - 'MAIL': '/var/mail/cltbld', 14:30:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:28 INFO - 'MOZ_NO_REMOTE': '1', 14:30:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:28 INFO - 'NO_EM_RESTART': '1', 14:30:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:28 INFO - 'PWD': '/builds/slave/test', 14:30:28 INFO - 'SHELL': '/bin/bash', 14:30:28 INFO - 'SHLVL': '1', 14:30:28 INFO - 'TERM': 'linux', 14:30:28 INFO - 'TMOUT': '86400', 14:30:28 INFO - 'USER': 'cltbld', 14:30:28 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871', 14:30:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:28 INFO - '_': '/tools/buildbot/bin/python'} 14:30:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:30:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:30:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:30:30 INFO - Installing collected packages: mozsystemmonitor 14:30:30 INFO - Running setup.py install for mozsystemmonitor 14:30:30 INFO - Successfully installed mozsystemmonitor 14:30:30 INFO - Cleaning up... 14:30:30 INFO - Return code: 0 14:30:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:30:30 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')]} 14:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:30 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')]} 14:30:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:30 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 0xb1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe91770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8ea30>, '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 0xe8f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8fca0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871', '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 14:30:30 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 14:30:30 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 14:30:30 INFO - Using env: {'DISPLAY': ':0', 14:30:30 INFO - 'HOME': '/home/cltbld', 14:30:30 INFO - 'LANG': 'en_US.UTF-8', 14:30:30 INFO - 'LANGUAGE': 'en_US:en', 14:30:30 INFO - 'LOGNAME': 'cltbld', 14:30:30 INFO - 'MAIL': '/var/mail/cltbld', 14:30:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:30 INFO - 'MOZ_NO_REMOTE': '1', 14:30:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:30 INFO - 'NO_EM_RESTART': '1', 14:30:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:30 INFO - 'PWD': '/builds/slave/test', 14:30:30 INFO - 'SHELL': '/bin/bash', 14:30:30 INFO - 'SHLVL': '1', 14:30:30 INFO - 'TERM': 'linux', 14:30:30 INFO - 'TMOUT': '86400', 14:30:30 INFO - 'USER': 'cltbld', 14:30:30 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871', 14:30:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:30 INFO - '_': '/tools/buildbot/bin/python'} 14:30:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:30 INFO - Downloading/unpacking jsonschema==2.5.1 14:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:30:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:31 INFO - Downloading functools32-3.2.3-2.tar.gz 14:30:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:30:31 INFO - warning: no files found matching '*.txt' 14:30:31 INFO - no previously-included directories found matching 'build' 14:30:31 INFO - no previously-included directories found matching 'dist' 14:30:31 INFO - no previously-included directories found matching '.git*' 14:30:31 INFO - Installing collected packages: jsonschema, functools32 14:30:31 INFO - Running setup.py install for functools32 14:30:31 INFO - warning: no files found matching '*.txt' 14:30:31 INFO - no previously-included directories found matching 'build' 14:30:31 INFO - no previously-included directories found matching 'dist' 14:30:31 INFO - no previously-included directories found matching '.git*' 14:30:32 INFO - Successfully installed jsonschema functools32 14:30:32 INFO - Cleaning up... 14:30:32 INFO - Return code: 0 14:30:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe91770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8ea30>, '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 0xe8f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8fca0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871', '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 14:30:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:30:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:30:32 INFO - Using env: {'DISPLAY': ':0', 14:30:32 INFO - 'HOME': '/home/cltbld', 14:30:32 INFO - 'LANG': 'en_US.UTF-8', 14:30:32 INFO - 'LANGUAGE': 'en_US:en', 14:30:32 INFO - 'LOGNAME': 'cltbld', 14:30:32 INFO - 'MAIL': '/var/mail/cltbld', 14:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:32 INFO - 'MOZ_NO_REMOTE': '1', 14:30:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:32 INFO - 'NO_EM_RESTART': '1', 14:30:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:32 INFO - 'PWD': '/builds/slave/test', 14:30:32 INFO - 'SHELL': '/bin/bash', 14:30:32 INFO - 'SHLVL': '1', 14:30:32 INFO - 'TERM': 'linux', 14:30:32 INFO - 'TMOUT': '86400', 14:30:32 INFO - 'USER': 'cltbld', 14:30:32 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871', 14:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:32 INFO - '_': '/tools/buildbot/bin/python'} 14:30:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:30:32 INFO - Cleaning up... 14:30:32 INFO - Return code: 0 14:30:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe91770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8ea30>, '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 0xe8f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8fca0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871', '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 14:30:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:30:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:30:32 INFO - Using env: {'DISPLAY': ':0', 14:30:32 INFO - 'HOME': '/home/cltbld', 14:30:32 INFO - 'LANG': 'en_US.UTF-8', 14:30:32 INFO - 'LANGUAGE': 'en_US:en', 14:30:32 INFO - 'LOGNAME': 'cltbld', 14:30:32 INFO - 'MAIL': '/var/mail/cltbld', 14:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:32 INFO - 'MOZ_NO_REMOTE': '1', 14:30:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:32 INFO - 'NO_EM_RESTART': '1', 14:30:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:32 INFO - 'PWD': '/builds/slave/test', 14:30:32 INFO - 'SHELL': '/bin/bash', 14:30:32 INFO - 'SHLVL': '1', 14:30:32 INFO - 'TERM': 'linux', 14:30:32 INFO - 'TMOUT': '86400', 14:30:32 INFO - 'USER': 'cltbld', 14:30:32 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871', 14:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:32 INFO - '_': '/tools/buildbot/bin/python'} 14:30:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:32 INFO - Downloading/unpacking blobuploader==1.2.4 14:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:33 INFO - Downloading blobuploader-1.2.4.tar.gz 14:30:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:30:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:30:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:34 INFO - Downloading docopt-0.6.1.tar.gz 14:30:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:30:34 INFO - Installing collected packages: blobuploader, requests, docopt 14:30:34 INFO - Running setup.py install for blobuploader 14:30:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:30:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:30:34 INFO - Running setup.py install for requests 14:30:34 INFO - Running setup.py install for docopt 14:30:34 INFO - Successfully installed blobuploader requests docopt 14:30:34 INFO - Cleaning up... 14:30:34 INFO - Return code: 0 14:30:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:30:34 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')]} 14:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:34 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')]} 14:30:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:34 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 0xb1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe91770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8ea30>, '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 0xe8f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8fca0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871', '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 14:30:34 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 14:30:34 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 14:30:34 INFO - Using env: {'DISPLAY': ':0', 14:30:34 INFO - 'HOME': '/home/cltbld', 14:30:34 INFO - 'LANG': 'en_US.UTF-8', 14:30:34 INFO - 'LANGUAGE': 'en_US:en', 14:30:34 INFO - 'LOGNAME': 'cltbld', 14:30:34 INFO - 'MAIL': '/var/mail/cltbld', 14:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:34 INFO - 'MOZ_NO_REMOTE': '1', 14:30:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:34 INFO - 'NO_EM_RESTART': '1', 14:30:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:34 INFO - 'PWD': '/builds/slave/test', 14:30:34 INFO - 'SHELL': '/bin/bash', 14:30:34 INFO - 'SHLVL': '1', 14:30:34 INFO - 'TERM': 'linux', 14:30:34 INFO - 'TMOUT': '86400', 14:30:34 INFO - 'USER': 'cltbld', 14:30:34 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871', 14:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:34 INFO - '_': '/tools/buildbot/bin/python'} 14:30:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:30:35 INFO - Running setup.py (path:/tmp/pip-Tq1r0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:30:35 INFO - Running setup.py (path:/tmp/pip-1SXUIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:30:35 INFO - Running setup.py (path:/tmp/pip-N9cE7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:30:35 INFO - Running setup.py (path:/tmp/pip-9XxaRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:30:35 INFO - Running setup.py (path:/tmp/pip-LrYYaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:30:35 INFO - Running setup.py (path:/tmp/pip-_EjjNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:30:35 INFO - Running setup.py (path:/tmp/pip-bAPsgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:30:35 INFO - Running setup.py (path:/tmp/pip-eawYhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:30:35 INFO - Running setup.py (path:/tmp/pip-UD1JUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:30:35 INFO - Running setup.py (path:/tmp/pip-8006Po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:30:35 INFO - Running setup.py (path:/tmp/pip-xQNv3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:30:35 INFO - Running setup.py (path:/tmp/pip-m7KxEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:30:35 INFO - Running setup.py (path:/tmp/pip-Ay4gZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:30:36 INFO - Running setup.py (path:/tmp/pip-2NCbXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:30:36 INFO - Running setup.py (path:/tmp/pip-03g4_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:30:36 INFO - Running setup.py (path:/tmp/pip-JUthEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:30:36 INFO - Running setup.py (path:/tmp/pip-JhSaNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:30:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:30:36 INFO - Running setup.py install for manifestparser 14:30:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:30:36 INFO - Running setup.py install for mozcrash 14:30:36 INFO - Running setup.py install for mozdebug 14:30:36 INFO - Running setup.py install for mozdevice 14:30:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:30:36 INFO - Running setup.py install for mozfile 14:30:36 INFO - Running setup.py install for mozhttpd 14:30:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:30:36 INFO - Running setup.py install for mozinfo 14:30:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:30:36 INFO - Running setup.py install for mozInstall 14:30:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:30:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:30:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:30:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:30:37 INFO - Running setup.py install for mozleak 14:30:37 INFO - Running setup.py install for mozlog 14:30:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:30:37 INFO - Running setup.py install for moznetwork 14:30:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:30:37 INFO - Running setup.py install for mozprocess 14:30:37 INFO - Running setup.py install for mozprofile 14:30:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:30:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:30:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:30:37 INFO - Running setup.py install for mozrunner 14:30:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:30:37 INFO - Running setup.py install for mozscreenshot 14:30:37 INFO - Running setup.py install for moztest 14:30:37 INFO - Running setup.py install for mozversion 14:30:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:30:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:30:38 INFO - Cleaning up... 14:30:38 INFO - Return code: 0 14:30:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe91770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8ea30>, '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 0xe8f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8fca0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871', '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 14:30:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:30:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:30:38 INFO - Using env: {'DISPLAY': ':0', 14:30:38 INFO - 'HOME': '/home/cltbld', 14:30:38 INFO - 'LANG': 'en_US.UTF-8', 14:30:38 INFO - 'LANGUAGE': 'en_US:en', 14:30:38 INFO - 'LOGNAME': 'cltbld', 14:30:38 INFO - 'MAIL': '/var/mail/cltbld', 14:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:38 INFO - 'MOZ_NO_REMOTE': '1', 14:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:38 INFO - 'NO_EM_RESTART': '1', 14:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:38 INFO - 'PWD': '/builds/slave/test', 14:30:38 INFO - 'SHELL': '/bin/bash', 14:30:38 INFO - 'SHLVL': '1', 14:30:38 INFO - 'TERM': 'linux', 14:30:38 INFO - 'TMOUT': '86400', 14:30:38 INFO - 'USER': 'cltbld', 14:30:38 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871', 14:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:38 INFO - '_': '/tools/buildbot/bin/python'} 14:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:30:38 INFO - Running setup.py (path:/tmp/pip-RnPJjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:30:38 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)) 14:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:30:38 INFO - Running setup.py (path:/tmp/pip-_nYxh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:30:38 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)) 14:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:30:38 INFO - Running setup.py (path:/tmp/pip-z65xah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:30:38 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)) 14:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:30:38 INFO - Running setup.py (path:/tmp/pip-UFT_Kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:30:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:30:38 INFO - Running setup.py (path:/tmp/pip-AskA2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:30:38 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)) 14:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:30:38 INFO - Running setup.py (path:/tmp/pip-FSm57d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:30:38 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)) 14:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:30:38 INFO - Running setup.py (path:/tmp/pip-apVxmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:30:38 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)) 14:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:30:38 INFO - Running setup.py (path:/tmp/pip-tVq42w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:30:38 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)) 14:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:30:38 INFO - Running setup.py (path:/tmp/pip-LW2aLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:30:38 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)) 14:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:30:38 INFO - Running setup.py (path:/tmp/pip-MWwXsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:30:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:30:39 INFO - Running setup.py (path:/tmp/pip-BWlFYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:30:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:30:39 INFO - Running setup.py (path:/tmp/pip-fiSfWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:30:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:30:39 INFO - Running setup.py (path:/tmp/pip-YHTGAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:30:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:30:39 INFO - Running setup.py (path:/tmp/pip-miiQiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:30:39 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)) 14:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:30:39 INFO - Running setup.py (path:/tmp/pip-3KIgD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:30:39 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)) 14:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:30:39 INFO - Running setup.py (path:/tmp/pip-QgwlWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:30:39 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)) 14:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:30:39 INFO - Running setup.py (path:/tmp/pip-Tkki9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:30:39 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)) 14:30:39 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)) 14:30:39 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)) 14:30:39 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)) 14:30:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:30:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:30:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:30:39 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 14:30:39 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 14:30:39 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 14:30:39 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 14:30:39 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 14:30:39 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 14:30:40 INFO - Downloading blessings-1.6.tar.gz 14:30:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:30:40 INFO - Installing collected packages: blessings 14:30:40 INFO - Running setup.py install for blessings 14:30:40 INFO - Successfully installed blessings 14:30:40 INFO - Cleaning up... 14:30:40 INFO - Return code: 0 14:30:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:30:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:30:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:30:41 INFO - Reading from file tmpfile_stdout 14:30:41 INFO - Current package versions: 14:30:41 INFO - argparse == 1.2.1 14:30:41 INFO - blessings == 1.6 14:30:41 INFO - blobuploader == 1.2.4 14:30:41 INFO - docopt == 0.6.1 14:30:41 INFO - functools32 == 3.2.3-2 14:30:41 INFO - jsonschema == 2.5.1 14:30:41 INFO - manifestparser == 1.1 14:30:41 INFO - mozInstall == 1.12 14:30:41 INFO - mozcrash == 1.0 14:30:41 INFO - mozdebug == 0.1 14:30:41 INFO - mozdevice == 0.50 14:30:41 INFO - mozfile == 1.2 14:30:41 INFO - mozhttpd == 0.7 14:30:41 INFO - mozinfo == 0.9 14:30:41 INFO - mozleak == 0.1 14:30:41 INFO - mozlog == 3.4 14:30:41 INFO - moznetwork == 0.27 14:30:41 INFO - mozprocess == 0.25 14:30:41 INFO - mozprofile == 0.28 14:30:41 INFO - mozrunner == 6.13 14:30:41 INFO - mozscreenshot == 0.1 14:30:41 INFO - mozsystemmonitor == 0.3 14:30:41 INFO - moztest == 0.8 14:30:41 INFO - mozversion == 1.4 14:30:41 INFO - psutil == 3.1.1 14:30:41 INFO - requests == 1.2.3 14:30:41 INFO - wsgiref == 0.1.2 14:30:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe91770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8ea30>, '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 0xe8f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8fca0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871', '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 14:30:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:30:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:30:41 INFO - Using env: {'DISPLAY': ':0', 14:30:41 INFO - 'HOME': '/home/cltbld', 14:30:41 INFO - 'LANG': 'en_US.UTF-8', 14:30:41 INFO - 'LANGUAGE': 'en_US:en', 14:30:41 INFO - 'LOGNAME': 'cltbld', 14:30:41 INFO - 'MAIL': '/var/mail/cltbld', 14:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:41 INFO - 'MOZ_NO_REMOTE': '1', 14:30:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:41 INFO - 'NO_EM_RESTART': '1', 14:30:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:41 INFO - 'PWD': '/builds/slave/test', 14:30:41 INFO - 'SHELL': '/bin/bash', 14:30:41 INFO - 'SHLVL': '1', 14:30:41 INFO - 'TERM': 'linux', 14:30:41 INFO - 'TMOUT': '86400', 14:30:41 INFO - 'USER': 'cltbld', 14:30:41 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871', 14:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:41 INFO - '_': '/tools/buildbot/bin/python'} 14:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:41 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)) 14:30:41 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)) 14:30:41 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)) 14:30:41 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)) 14:30:41 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)) 14:30:41 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)) 14:30:41 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)) 14:30:41 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)) 14:30:41 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)) 14:30:41 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)) 14:30:41 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)) 14:30:41 INFO - Cleaning up... 14:30:41 INFO - Return code: 0 14:30:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:41 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 0xb1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe91770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8ea30>, '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 0xe8f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8fca0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871', '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 14:30:41 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 14:30:41 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 14:30:41 INFO - Using env: {'DISPLAY': ':0', 14:30:41 INFO - 'HOME': '/home/cltbld', 14:30:41 INFO - 'LANG': 'en_US.UTF-8', 14:30:41 INFO - 'LANGUAGE': 'en_US:en', 14:30:41 INFO - 'LOGNAME': 'cltbld', 14:30:41 INFO - 'MAIL': '/var/mail/cltbld', 14:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:41 INFO - 'MOZ_NO_REMOTE': '1', 14:30:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:41 INFO - 'NO_EM_RESTART': '1', 14:30:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:41 INFO - 'PWD': '/builds/slave/test', 14:30:41 INFO - 'SHELL': '/bin/bash', 14:30:41 INFO - 'SHLVL': '1', 14:30:41 INFO - 'TERM': 'linux', 14:30:41 INFO - 'TMOUT': '86400', 14:30:41 INFO - 'USER': 'cltbld', 14:30:41 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871', 14:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:41 INFO - '_': '/tools/buildbot/bin/python'} 14:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:30:41 INFO - Cleaning up... 14:30:41 INFO - Return code: 0 14:30:41 INFO - Running post-action listener: _resource_record_post_action 14:30:41 INFO - Running post-action listener: _start_resource_monitoring 14:30:41 INFO - Starting resource monitoring. 14:30:41 INFO - [mozharness: 2017-05-08 21:30:41.615898Z] Finished create-virtualenv step (success) 14:30:41 INFO - [mozharness: 2017-05-08 21:30:41.616359Z] Running install step. 14:30:41 INFO - Running pre-action listener: _resource_record_pre_action 14:30:41 INFO - Running main action method: install 14:30:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:30:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:30:41 INFO - Reading from file tmpfile_stdout 14:30:41 INFO - Detecting whether we're running mozinstall >=1.0... 14:30:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:30:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:30:41 INFO - Reading from file tmpfile_stdout 14:30:41 INFO - Output received: 14:30:41 INFO - Usage: mozinstall [options] installer 14:30:41 INFO - Options: 14:30:41 INFO - -h, --help show this help message and exit 14:30:41 INFO - -d DEST, --destination=DEST 14:30:41 INFO - Directory to install application into. [default: 14:30:41 INFO - "/builds/slave/test"] 14:30:41 INFO - --app=APP Application being installed. [default: firefox] 14:30:41 INFO - mkdir: /builds/slave/test/build/application 14:30:41 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'] 14:30:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:30:57 INFO - Reading from file tmpfile_stdout 14:30:57 INFO - Output received: 14:30:57 INFO - /builds/slave/test/build/application/firefox/firefox 14:30:57 INFO - Running post-action listener: _resource_record_post_action 14:30:57 INFO - [mozharness: 2017-05-08 21:30:57.312045Z] Finished install step (success) 14:30:57 INFO - [mozharness: 2017-05-08 21:30:57.312319Z] Running run-tests step. 14:30:57 INFO - Running pre-action listener: _resource_record_pre_action 14:30:57 INFO - Running main action method: run_tests 14:30:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:30:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:30:57 INFO - Python 2.7.3 14:30:57 INFO - Return code: 0 14:30:57 INFO - grabbing minidump binary from tooltool 14:30: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')]} 14:30:57 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 0xe8ea30>, '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 0xe8f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8fca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:30:57 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 14:30:57 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 14:30:57 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 14:30:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:30:57 INFO - Return code: 0 14:30:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:30:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:30:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:30:57 INFO - ENV: RUST_BACKTRACE is now 1 14:30:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:30:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:30:57 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/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--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 14:30:57 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/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-075 --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 14:30:57 INFO - Using env: {'DISPLAY': ':0', 14:30:57 INFO - 'HOME': '/home/cltbld', 14:30:57 INFO - 'LANG': 'en_US.UTF-8', 14:30:57 INFO - 'LANGUAGE': 'en_US:en', 14:30:57 INFO - 'LOGNAME': 'cltbld', 14:30:57 INFO - 'MAIL': '/var/mail/cltbld', 14:30:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:30:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:30:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:57 INFO - 'MOZ_NO_REMOTE': '1', 14:30:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:30:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:57 INFO - 'NO_EM_RESTART': '1', 14:30:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:57 INFO - 'PWD': '/builds/slave/test', 14:30:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:30:57 INFO - 'RUST_BACKTRACE': '1', 14:30:57 INFO - 'SHELL': '/bin/bash', 14:30:57 INFO - 'SHLVL': '1', 14:30:57 INFO - 'TERM': 'linux', 14:30:57 INFO - 'TMOUT': '86400', 14:30:57 INFO - 'USER': 'cltbld', 14:30:57 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871', 14:30:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:57 INFO - '_': '/tools/buildbot/bin/python'} 14:30:57 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/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--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 14:30:57 INFO - mozversion application_buildid: 20170508203447 14:30:57 INFO - mozversion application_changeset: bab7046ee2d82345d7d5b33b8ae4009c7e365176 14:30:57 INFO - mozversion application_display_name: Nightly 14:30:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:30:57 INFO - mozversion application_name: Firefox 14:30:57 INFO - mozversion application_remotingname: firefox 14:30:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:30:57 INFO - mozversion application_vendor: Mozilla 14:30:57 INFO - mozversion application_version: 55.0a1 14:30:57 INFO - mozversion platform_buildid: 20170508203447 14:30:57 INFO - mozversion platform_changeset: bab7046ee2d82345d7d5b33b8ae4009c7e365176 14:30:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:30:57 INFO - mozversion platform_version: 55.0a1 14:30:57 INFO - using testdate: 1494279057 14:30:57 INFO - actual date: 1494279057 14:30:57 INFO - starting webserver on 'localhost:55877' 14:30:57 INFO - SUITE-START | Running 2 tests 14:30:57 INFO - TEST-START | dromaeo_css 14:30:57 INFO - operating with platform_type : linux_ 14:30:57 INFO - Initialising browser for dromaeo_css test... 14:30:57 INFO - TEST-INFO | started process 22028 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpimiAYh/profile http://localhost:55877/getInfo.html) 14:31:03 INFO - PID 22028 | __metrics Screen width/height:1600/1200 14:31:03 INFO - PID 22028 | colorDepth:24 14:31:03 INFO - PID 22028 | Browser inner width/height: 1024/695 14:31:03 INFO - PID 22028 | __metrics 14:31:04 INFO - PID 22028 | 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" 14:31:04 INFO - PID 22028 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:31:05 INFO - TEST-INFO | 22028: exit 0 14:31:05 INFO - Browser initialized. 14:31:05 INFO - Running cycle 1/1 for dromaeo_css test... 14:31:05 INFO - TEST-INFO | started process 22128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpimiAYh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:31:17 INFO - PID 22128 | RSS: Main: 167370752 14:31:17 INFO - PID 22128 | 14:34:24 INFO - PID 22128 | Cycle 1(1): loaded http://localhost:55877/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55877/tests/dromaeo/cssquery-ext.html) 14:34:26 INFO - PID 22128 | RSS: Main: 305246208 14:34:26 INFO - PID 22128 | 14:37:28 INFO - PID 22128 | Cycle 1(1): loaded http://localhost:55877/tests/dromaeo/cssquery-ext.html (next: http://localhost:55877/tests/dromaeo/cssquery-jquery.html) 14:37:29 INFO - PID 22128 | RSS: Main: 256548864 14:37:29 INFO - PID 22128 | 14:40:31 INFO - PID 22128 | Cycle 1(1): loaded http://localhost:55877/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55877/tests/dromaeo/cssquery-mootools.html) 14:40:31 INFO - PID 22128 | RSS: Main: 201351168 14:40:31 INFO - PID 22128 | 14:43:33 INFO - PID 22128 | Cycle 1(1): loaded http://localhost:55877/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55877/tests/dromaeo/cssquery-prototype.html) 14:43:34 INFO - PID 22128 | RSS: Main: 240013312 14:43:34 INFO - PID 22128 | 14:46:37 INFO - PID 22128 | Cycle 1(1): loaded http://localhost:55877/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55877/tests/dromaeo/cssquery-yui.html) 14:46:38 INFO - PID 22128 | RSS: Main: 207343616 14:46:38 INFO - PID 22128 | 14:49:40 INFO - PID 22128 | Cycle 1(1): loaded http://localhost:55877/tests/dromaeo/cssquery-yui.html (next: http://localhost:55877/tests/dromaeo/cssquery-dojo.html) 14:49:40 INFO - PID 22128 | RSS: Main: 299683840 14:49:40 INFO - PID 22128 | 14:49:40 INFO - PID 22128 | __start_tp_report 14:49:40 INFO - PID 22128 | _x_x_mozilla_page_load 14:49:40 INFO - PID 22128 | _x_x_mozilla_page_load_details 14:49:40 INFO - PID 22128 | |i|pagename|runs| 14:49:40 INFO - PID 22128 | |0;dojo.html;2701.837889726616;2716.891324347026;2748.2030211238744;2750.3674154944374;2761.6685997680274;5068.087744206042;5144.897102057961;5190.351206099238;5194.194899790534;5224.817131400402;5150.150225212845;5180.352455943007;5183.326167598207;5223.399309079457;5243.213517972306;4304.354346847967;4522.140793249288;4566.429196350465;4675.953240467586;4677;4585.449746030481;4638.768061596924;4659.510751371108;4675.111728771522;4703.5061318561575;4523.231050721352;4579.748113853737;4583.335416364642;4590.242609969351;4592.793324300381;4557.361969324297;4602.677812553123;4610;4619.19164146273;4638.420197475316;4597.793099310539;4613.723176609415;4624.075184962987;4635.582797548237;4639.86080417588;5050.747462626854;5058.165402708549;5072.188449848043;5126.743662816844;5130.153524668425;5528.530074943635;5541.944580554183;5544.22380866679;5558.722063896829;5638.605297629168;5403.864903377408;5432.831941132676;5457.617966742329;5606.831795046155;5616.157576363578;5166.5866730661455;5173.1722924331925;5175.792968281302;5179.974100129475;5194.766235519411;5676.801311954062;5712.086066229466;5725.427457254241;5731.254936858182;5739.713014349266;5418.51233388989;5421;5421.457854214547;5423.159410291411;5471.753771080311;5544.556435485151;5563;5635.1828984796975;5640.520555752807;5647.548196144298;5453.536449401766;5455.072637651609;5459.372172200168;5459.426760190123;5460.126379779216;5409.972950135224;5452.291202143775;5454.618176727591;5464.207689884945;5469.753861076261;4520.50274469808;4561.840335588238;4589.678722489461;4637.652176086807;4639.744814035193;3945.033466800652;3959.742616729903;3993.0616305168264;3994;4002.679785617144;4760.95239047612;4761.952380476151;4767.61859051275;4781.043791241766;4809.663323567387;5516.14499752539;5565.499105080481;5589.329280486368;5635.605507614509;5642.633228840113;4740.549647783524;4768.380110585602;4769.713817170981;4770.594499467584;4808.0383923215495;4982.7508624569355;4986.975065124651;4988.850334489971;4989.675671081368;5024.748762561857;5107;5178.119719647593;5191.92212116811;5204.427512973645;5254.921176182437;5570.442955704397;5622.831315060391;5665.603407761417;5666.829995100154;5680.318361796611;5122.948770512247;5145.202493613496;5196.038732834438;5197.636165468381;5202.271681964604;5453.236546883519;5497.36780270274;5549.889002219852;5555.777768889199;5557.277553917965;5605.495505404533;5623.493885550321;5627.718614069198;5627.803026894039;5679.233303503974;5317.574594032545;5414.648047877033;5414.864628384322;5421.430749771217;5423.864403389947;5351.010063138332;5393.730313484389;5471.12462006093;5472.315960504937;5475.753591088331;5359.330083739533;5362.946370536245;5371.838844834661;5383.5962302826665;5386.7037312946595;5437.619366644455;5437.646552974203;5440.619156658996;5442.482964118402;5446.782128714807;5249.921251181159;5303.708296043755;5304.336957880265;5304.708241046779;5307.283516725347 14:49:40 INFO - PID 22128 | |1;ext.html;639.9200099987502;703.2405002597194;718.8957601147833;1076.0960792933934;1080.287010573022;25716.87141564294;30098.398032039375;32544.67455325443;32672.67327326726;32738.181545461375;34960.475592866125;35309.2938141237;35316;35376;35390.82304588473;6869.725210991567;7014.22843487216;7014.859702805941;7016.228214896358;7019.964900175492;5236.711980841072;5377.65045272058;6230.813075607739;6827.112475378194;6834.897476537831;6871.862562748742;6947.826304342381;6952.443804495653;6961.477889158334;6976.965115174417;6850.0752398426075;6851.417629501499;6909.965450172767;6913.585184888872;6934.618595977219;5117.411497677777;5295.655782374133;6676.332366763285;6838.760643377507;6845.212800527904;30633;30877;30961.380772384426;30970.690293097232;31016.379672406427;3027.2431892026993;3070.0329396240113;3071.7389021933163;3075.369549242422;3077.984610076958;23322.76677233223;23371.182008629617;23392.415189620224;23411.297661070024;23446.882765586233;3133.780635355526;3151.133438304462;3161.162291992624;3169.683031696835;3172.191091271711;141615;141889.29055354762;142163;142214;142357;41541.58458415438;41567.584324156975;41601;41700.79149604232;41720.582794172275;43515.78242108769;43712.562874371484;43743;43758;43835.12329753387;12264.448099835528;12348.530293941069;12350.62948111558;12351.19717218378;12362.320072396105;9859.950700246452;9866.408015519091;9868.407895526292;9869.753256168653;9871.160951319074;10575;10796.622118225825;11909.642710718692;11964.222325548986;12150.149489535825;5025.79896804131;5226.294450249244;5242.1088414969545;5243.2659427680155;5249.448807875118;876.609908590671;917.8990311065777;918.669279059538;927.0544045073987;948.7485816258697;20181.192752290037;21078.473038173863;21088;21090.261840835803;21254.893725531583;986.2800155886243;998.6404894238068;1002.5087707023652;1010.2221289606962;1020.7295066807153;10826.566937322576;10990.17573681961;11108.333499990027;11217.495212715447;11390.829137562943;150735;151783;152971.23514382358;153143;153162;41957.16085678269;42090;42290.57709422928;42290.57709422928;42314.78842605829;1227.3679055286534;1231.0643910627987;1244.9813252801216;1247.21425501935;1251.6495381293253;22517.549649007255;22726.659100113844;23624;23936.281911542683;23983.760162398154;36627.084322892144;37003.629963701096;37808.810955946145;37877.81061094787;37924.24151517009;139372;139412;139927;140087;140550;28105.156845293855;28265.71734282631;28294.292642684097;28304.15087547377;28338.574921375784;30232.54651180278;30804.22989425282;33421.49867752034;33517;35298.11754706153;26587.60118598184;26671;26791.598126028515;26799.464010720065;27445.588316175672;28266;28396;28750.568741468476;28810.27974300659;29810;31647;31716.365672685955;31744.36511269808;31938;32044.359112817147;26410.339741506617;26732.465350693266;27567.172984810488;28052;28152.155435336972;20206.79793202049;21869.671954921007;22027.779722202573;22052.669209961543;22084.558308834054 14:49:40 INFO - PID 22128 | |2;jquery.html;413.4914055711475;415.5553557693269;426.7013090836413;437.2151987183006;443.6428674916693;15173.468928587474;16993.2353044113;17650.64698706028;17847;17848.553786155353;17789.55526111848;17822.64354712905;17950.281988720435;18162.5459363516;18241;5295.179247216687;5406.107992181285;5456.045192091388;5508.724563771815;5574.60977731559;5426.647267927572;5524.889502209953;5525.005499010176;5527.44725527446;5527.640703354289;5323.1749078892835;5459.454054594548;5459.972700136514;5484.725763711818;5495.697736624484;5378.273933019051;5398.433164517728;5407.215953686733;5422.999999999961;5425;4731.384919960417;4864.756762161913;4897.436794768611;4898.706077635354;4913.631477639191;20957.68563471549;21343.573128537497;21448.463788405257;21546.676799848014;21645.025973831216;1670.3151707799743;1694.1867903406435;1696.8557672597844;1697.6095498035397;1700.948971530856;13952.720945581032;14397.208153551655;14411.92794036023;14585.19781412022;14714.117152970855;2017.838572914178;2025.8176764091156;2038.3375402994086;2090.560982193741;2116.9788302116935;68125.65937170283;72686.63656681735;90839;90888.54555727245;91396.54301728515;10257.17942564593;10261.486925653688;10347.793044139225;10397.948010259901;10420.68737937863;13977.301134943416;14343.85656143446;14434.927825361015;14453.421863125568;14504.709905801825;7493.812654683567;7599.354054905284;7775.3390961767755;7811.179826118289;7827.334676552557;7135.357817796424;7182.784516464514;7203;7410.740624078131;7433.145188303414;6718.932810671929;6774.220964589135;6810.250872404032;6827.180738311435;6908.1364829396325;1940.3596813051659;1946.3479734289172;1985.334912804198;2011.4669612552684;2040.9387118698194;883.2492381475694;906.7461110888962;926.393212445849;926.8980412154658;951.7953639967441;16626.50120496387;17668.38160664396;17772.644547108986;17898.55253618644;17997.550061248574;916.5829547555846;925.7916968681992;927.4898805656861;938.638624129715;946.6639343033262;9174.724758257264;9392.530373481299;9674.951625241829;9711.27165462593;9898.455584942752;311346;313105;318054;318740;319434;72675.63662181655;72783;74732;74900.62549687216;76425.61787191029;1098.3519723363413;1098.7967226063204;1127.3517727306667;1128.2891778179694;1129.7514546799691;14644.633884152981;14914.179720115499;14922.701545969237;14938.925305373403;15519.84480155184;37335;38145.2370952585;38665.80667096646;39020.60979390283;40049.79975100106;47934;48231.27653085136;48464.7576762114;48743.51256487532;49425.75287123541;7999.360131172979;8085.716999904975;8186.222308880647;8380.371472139735;8424.663013479392;13140.474381024653;13662.726745465234;13685.247311397969;13689.178649281075;13828.377723002288;11235.943820280847;11280.492377842853;11341.092712583139;11583.884161158281;11924.403779811148;10881.564737410416;11039.172062095215;11101.389423581457;11213.887861121284;11217.88782112201;11661.6501504955;11687.824682629598;11718.765624687629;11839;11981.460834262305;8152.9184708154535;8316;8458.788530286793;8518.23335899772;8551.914480855112;10846.186536009673;10913.781724365626;10978.066864316623;11019;11508.194426390073 14:49:40 INFO - PID 22128 | |3;mootools.html;1233.451114254157;1292.8448586169661;1308.947642094316;1311.593406044127;1316.2826259688482;9058.233644439337;9443.291753118527;9451.291153163515;9453.574589143487;9472.43165410076;9107.271418286538;9280.814383712339;9593.424394536332;9606.087421694945;9606.183474404666;2176.945576360588;2208.514126892081;2212.7787221277904;2215.9224427145055;2216.7339919209635;2067.586482703458;2184.0390228299575;2196.2642514757576;2197.154095673169;2203.6474164133742;1825.5892424204515;1894.9905250473728;2108.6942393352956;2191.539776646906;2193.594185075758;2195;2204.713387259662;2215.3464727905307;2218.0905828610194;2220.555888822234;2175.8041776240057;2202.9008694608783;2205.658122990939;2205.911763529457;2207.6578130389817;9019;9110;9159.76343193667;9161.083891610851;9199.126083022102;5199.428062913076;5389.110796718537;5393.7572809223675;5395.244665746799;5405.459454054602;3131.874725010997;3330.4504756715114;3422.9828850855833;3427.365937301607;3443.328550932569;1040.9323393979444;1069.3209811769505;1100.0759362135764;1110.0952723530297;1144.1933436926947;13495.257760823151;13624.523141690092;13627.04610677253;13632;13640.727185456235;4512.729236245836;4565.817367305337;4631.374764406829;4763.595094416944;4800.903981920342;8907.643694252158;8909.955450222707;8928.687495937611;8929.33030022751;8931.598078086501;5271.525562699376;5281.181416880389;5282.260483532308;5349;5443.122122867604;4689.43726752785;4789.353437285991;4810.807567697253;4855.8057677693205;4879.756012199376;3603.1892824114366;3636.5272514573467;3652.726045546595;3707.073231692077;3758;1089.700332408594;1099.4667586220676;1103.2332528892343;1108.5565773690428;1113.582406597526;654.6857508395901;669.5647828911247;669.7053296549502;692.3976140757574;694.5381321421198;4936.185529387682;4983.401991761012;5073.949260507421;5137.717425541631;5861.765529378862;837.8868852704928;845.1801752300258;850.3877208409934;868.6481974800216;870.8983136332545;3400.6939375456327;3478.2000139967445;3479.965200347964;3491.795330610986;3598.874039408608;11798.292102473879;12020.45907934145;12170.81743773844;12268.570600028956;12273.324967126893;11567.190296679151;12041.879581204252;12134.393280335948;12179;12201.45093470796;6930.722771089201;7048.541844780176;7103.751368702071;7105.182903966007;7106.2183159852375;5035.723035233097;5146.562542183807;5163.122269214167;5323.334583177103;5342.278792362981;10975.176861735561;11031.503582338653;11078.889211108108;11154.776904461703;11229.606963756229;10996.560137594726;11150.553977840795;11270.830937536108;11435.371054592077;11464.598739044093;7259.419246460165;7426.368758655359;7436.330730234305;7440.888386674096;7454.44091693136;8593;8630.741077767678;8689.869651955352;8712.607932642919;8714.651413943371;6997.1253593300835;7318.707251709872;7325.120985481776;7343.522671026366;7347.7795666130105;7422.294881986203;7555.73554925597;7556.735514256975;7567.091948966159;7612.961935190288;6881.13985751781;6994.405475534637;7007.089078419773;7010.68451919675;7011.509194356346;4982.75086245679;4998.950010499849;5062.519060689228;5127.820526281562;5183.637145399785;5048;5109.821156259513;5186.299849520266;5259.184826351921;5267.262583238273 14:49:40 INFO - PID 22128 | |4;prototype.html;333.4165210880958;361.4253337193861;383.58572741439247;385.10078965615287;390.42022596444275;5079.695218286901;5257.8948421031555;5378.838634840961;5406.83779486615;5427.782888684458;5226.529612334889;5290.1800220965815;5318.202269659553;5321.201819727034;5354.544863686581;4227.513835908871;4229.36559516072;4231.513375961773;4239.872803815891;4242.469691288589;4032.628906171901;4208.263553878074;4239.0885959518855;4246.893827654318;4259.872203833875;4058.9594104059024;4109.773962432065;4196.223698615766;4200.474940632421;4216.873493795191;4111.301078816608;4155.937660935088;4184.0795025094585;4197.727147735418;4206.789660516977;3770.3024940385844;3773.5471743390694;3779.338615742234;3810.1808111255937;3831.942520862189;4884.5848102911295;4897.445375800504;5142.202958541432;5164.2770012198325;5171.482851714798;5000.149974504343;5005.699658020494;5006.374203224597;5013.899722005576;5017;5548.91676624851;5648.898464799366;5664.122061080539;5669.433056694339;5716.399778023289;4292.163028209469;4314.245007123772;4315.352697095429;4328.588784065509;4333.58830911063;5975.163477113208;6026.728797204137;6031.909521357183;6053.182820319289;6066.150738896558;4247.405363249148;4394.099209662011;4458.197524445566;4461.594597701714;4469.240229161051;4220.978895105505;4533.342665313511;4533.705309154894;4544.477385100756;4547.3406356078185;4831.589314908272;4834.975825120922;4953.479884612136;4961.181405068195;4981.501849814989;5695.914561281584;5704.572157088235;5715.942840571624;5716;5717.285339332583;1497.8726808221206;1542.7272500187166;1567.8275389707123;1568.05916450129;1571.3321838218712;1105.8341248812742;1122.539758698946;1128.6614015795228;1131.3268605179906;1132.6262333429947;4858.368412106403;4898.289747986522;4953.479884612136;4956.876078098005;4961.3798275215595;5857.824265272048;5877.294724632986;5884.6469211847425;5884.823455296348;5886.205362276038;4857.465678775332;4917.827876024394;4947.208446648519;4950.554450099508;4958.231474121517;3076.338587203762;3097.1018404662846;3098.4507746126937;3099.9380012400075;3103.5810165627804;5383.192521121785;5409.809027343853;5418.160185171305;5431.511163995259;5439.836804895859;5786.537077033827;5929.436703513159;5948.4421698669985;5955.821325360246;5958.761649534057;5384.784608615611;5406.675599464044;5407.648502847381;5414.512693857571;5415.702136382458;5677.1768093627015;5753.90675771602;5759.7408116634015;5767.971160144172;5820.563457740771;5709.172170035405;5709.771609135588;5717.42825717425;5718.485336319751;5722.313322401338;5297.3248509502455;5400.324959380077;5416.729163541886;5437.782488700408;5446.754896029767;4389.4513185851765;4397.40635014269;4406.867793966187;4443.155800397914;4452.287633978548;5573.136163894603;5635.718214089197;5727.656340619576;5808.5062769665055;5816.098504731774;5617.382087970238;5626.24045753818;5628.437156284339;5628.831135065954;5644.153376993484;5462.399136095106;5549.556035517068;5557.305021968176;5597.468240517144;5618.4662457066515;5519.227308176939;5525.502704756591;5538.9169162461785;5546.667199968015;5558.416366281483;5636.1827535008015;5644.83065508019;5656.236408084856;5656.490915817596;5668.121441176624;5344.919826202532;5440.129579267298;5503.559715222693;5512.366077900932;5522.597670013557 14:49:40 INFO - PID 22128 | |5;yui.html;745.1393640345403;759.9848003039939;761.5240474703307;774.078846173054;777.8755399136139;12640.747185056294;13179.406926688298;13180.1432906861;13195.736085278313;13197.868021319784;13246.933765331183;15550.76673849893;15962.600934976632;16130;16133.193340332966;884.8230353929208;902.8329758994574;906.5603182456504;906.5693795447143;907.0702529906832;902.1384577728254;902.1835239108617;903.227740282056;903.6114470777596;904.0597778310582;964.7588102974256;965.006043774913;965.232640051161;966.8114717630065;968.4141094637748;944.2587568758526;944.3672739264675;949.5015117063527;950.7100334398006;951.5480146930153;679.7077256779583;684.8116767888871;701.3337329536961;702.153904545022;702.6802804723839;14227.07524010936;15062.397504099823;15132.697346053128;15180.316885740169;15183.772243416357;14738.926305368404;14781.113133212042;15174.165420901845;15193.164375959317;15216.847831521654;12069.698257543632;12313.26120432777;12321.137520373577;12329.321887296195;12337.93831030848;2878.510653188963;2941.617589713345;2963.4221326841275;2991.2820922978544;2993.206800197949;61990;62489.687551562405;62875.37124628741;63200;64560.67719661372;12423;12662.746745065047;12771.680707982376;12776.169548979287;13031.47874085026;21488.14047438116;21531.354059378245;21934;22085.116595336327;22089.226877059227;5932.169496270526;6184.103305020747;6192.721327540272;6196.411340922605;6197.349278325801;2978.255436140965;3017.5775391445213;3020.0788759428583;3020.622422197225;3047.49716296813;3349.246419555629;3411.8123503207066;3437.295354452381;3466.5493485846678;3590.281943611236;703.3388614702266;712.1952194020827;713.6431784107946;714.5748279773527;715.3883429667663;473.8957429365534;475.25859658931483;492.8964917367321;495.45252495992133;502.5652810319121;8569.742907712778;9074.228690561244;9339.953300233592;9510.239180865514;9607.90392096084;566.8186180422225;567.8523583868224;577.719805894141;589.2928485817037;596.2963702830615;4247.299195632686;4313.3098704207805;4313.9137217255475;4391;4462.062966776948;53021.51655735064;53207.73396132995;59844;60197.398026020055;60396;47328.290075648896;48483;48778;49374.25938610924;49407;41522.96192595149;41657;45249.77375113103;45474;46517.53482465132;9176.577630467289;10034.046765557261;10038.899611004088;10089.142422894136;10150;23995.400114997265;25038.499230015663;25817.225483235532;25911.22266332013;26407.603885941342;28936.276593085342;33250.50124248186;41317.38023929583;41863;43990.12019759651;12947.093703440669;13041.282729449971;13145.934270328587;13222.206667599974;13294.734105318033;14347.35436905321;14377.784333235219;14435.711285774436;14496.710065798414;14557.781633275297;12799.872001279868;12989.870101298866;13069.346532673519;13139.080264381402;13198.670033249246;12295.56965506203;12513.249205047727;12563.748725025265;12568.308743018855;12610.684732881751;12955.935220323838;12976.091673582758;13707.657308566966;13760.179163271305;14047.929760351133;10130.290879638354;10317;10606.575736970435;10701.250912436055;10738.838917416402;10133.493325333851;10243.795124097625;10383.896161038292;11005.504752286326;11288.153388495732 14:49:40 INFO - PID 22128 | __end_tp_report 14:49:40 INFO - PID 22128 | __start_cc_report 14:49:40 INFO - PID 22128 | _x_x_mozilla_cycle_collect,1474 14:49:40 INFO - PID 22128 | __end_cc_report 14:49:40 INFO - PID 22128 | __startTimestamp1494280180939__endTimestamp 14:49:40 INFO - PID 22128 | 14:49:40 INFO - PID 22128 | ------- Summary: start ------- 14:49:40 INFO - PID 22128 | Number of tests: 6 14:49:40 INFO - PID 22128 | 14:49:40 INFO - PID 22128 | [#0] dojo.html Cycles:165 Average:5087.58 Median:5224.82 stddev:591.27 (11.3%) stddev-sans-first:562.68 14:49:40 INFO - PID 22128 | Values: 2701.8 2716.9 2748.2 2750.4 2761.7 5068.1 5144.9 5190.4 5194.2 5224.8 5150.2 5180.4 5183.3 5223.4 5243.2 4304.4 4522.1 4566.4 4676.0 4677.0 4585.4 4638.8 4659.5 4675.1 4703.5 4523.2 4579.7 4583.3 4590.2 4592.8 4557.4 4602.7 4610.0 4619.2 4638.4 4597.8 4613.7 4624.1 4635.6 4639.9 5050.7 5058.2 5072.2 5126.7 5130.2 5528.5 5541.9 5544.2 5558.7 5638.6 5403.9 5432.8 5457.6 5606.8 5616.2 5166.6 5173.2 5175.8 5180.0 5194.8 5676.8 5712.1 5725.4 5731.3 5739.7 5418.5 5421.0 5421.5 5423.2 5471.8 5544.6 5563.0 5635.2 5640.5 5647.5 5453.5 5455.1 5459.4 5459.4 5460.1 5410.0 5452.3 5454.6 5464.2 5469.8 4520.5 4561.8 4589.7 4637.7 4639.7 3945.0 3959.7 3993.1 3994.0 4002.7 4761.0 4762.0 4767.6 4781.0 4809.7 5516.1 5565.5 5589.3 5635.6 5642.6 4740.5 4768.4 4769.7 4770.6 4808.0 4982.8 4987.0 4988.9 4989.7 5024.7 5107.0 5178.1 5191.9 5204.4 5254.9 5570.4 5622.8 5665.6 5666.8 5680.3 5122.9 5145.2 5196.0 5197.6 5202.3 5453.2 5497.4 5549.9 5555.8 5557.3 5605.5 5623.5 5627.7 5627.8 5679.2 5317.6 5414.6 5414.9 5421.4 5423.9 5351.0 5393.7 5471.1 5472.3 5475.8 5359.3 5362.9 5371.8 5383.6 5386.7 5437.6 5437.6 5440.6 5442.5 5446.8 5249.9 5303.7 5304.3 5304.7 5307.3 14:49:40 INFO - PID 22128 | 14:49:40 INFO - PID 22128 | [#1] ext.html Cycles:180 Average:29293.76 Median:30919.19 stddev:37371.98 (120.9%) stddev-sans-first:37414.87 14:49:40 INFO - PID 22128 | Values: 639.9 703.2 718.9 1076.1 1080.3 25716.9 30098.4 32544.7 32672.7 32738.2 34960.5 35309.3 35316.0 35376.0 35390.8 6869.7 7014.2 7014.9 7016.2 7020.0 5236.7 5377.7 6230.8 6827.1 6834.9 6871.9 6947.8 6952.4 6961.5 6977.0 6850.1 6851.4 6910.0 6913.6 6934.6 5117.4 5295.7 6676.3 6838.8 6845.2 30633.0 30877.0 30961.4 30970.7 31016.4 3027.2 3070.0 3071.7 3075.4 3078.0 23322.8 23371.2 23392.4 23411.3 23446.9 3133.8 3151.1 3161.2 3169.7 3172.2 141615.0 141889.3 142163.0 142214.0 142357.0 41541.6 41567.6 41601.0 41700.8 41720.6 43515.8 43712.6 43743.0 43758.0 43835.1 12264.4 12348.5 12350.6 12351.2 12362.3 9860.0 9866.4 9868.4 9869.8 9871.2 10575.0 10796.6 11909.6 11964.2 12150.1 5025.8 5226.3 5242.1 5243.3 5249.4 876.6 917.9 918.7 927.1 948.7 20181.2 21078.5 21088.0 21090.3 21254.9 986.3 998.6 1002.5 1010.2 1020.7 10826.6 10990.2 11108.3 11217.5 11390.8 150735.0 151783.0 152971.2 153143.0 153162.0 41957.2 42090.0 42290.6 42290.6 42314.8 1227.4 1231.1 1245.0 1247.2 1251.6 22517.5 22726.7 23624.0 23936.3 23983.8 36627.1 37003.6 37808.8 37877.8 37924.2 139372.0 139412.0 139927.0 140087.0 140550.0 28105.2 28265.7 28294.3 28304.2 28338.6 30232.5 30804.2 33421.5 33517.0 35298.1 26587.6 26671.0 26791.6 26799.5 27445.6 28266.0 28396.0 28750.6 28810.3 29810.0 31647.0 31716.4 31744.4 31938.0 32044.4 26410.3 26732.5 27567.2 28052.0 28152.2 20206.8 21869.7 22027.8 22052.7 22084.6 14:49:40 INFO - PID 22128 | 14:49:40 INFO - PID 22128 | [#2] jquery.html Cycles:180 Average:23092.92 Median:37740.12 stddev:52973.93 (140.4%) stddev-sans-first:53095.17 14:49:40 INFO - PID 22128 | Values: 413.5 415.6 426.7 437.2 443.6 15173.5 16993.2 17650.6 17847.0 17848.6 17789.6 17822.6 17950.3 18162.5 18241.0 5295.2 5406.1 5456.0 5508.7 5574.6 5426.6 5524.9 5525.0 5527.4 5527.6 5323.2 5459.5 5460.0 5484.7 5495.7 5378.3 5398.4 5407.2 5423.0 5425.0 4731.4 4864.8 4897.4 4898.7 4913.6 20957.7 21343.6 21448.5 21546.7 21645.0 1670.3 1694.2 1696.9 1697.6 1700.9 13952.7 14397.2 14411.9 14585.2 14714.1 2017.8 2025.8 2038.3 2090.6 2117.0 68125.7 72686.6 90839.0 90888.5 91396.5 10257.2 10261.5 10347.8 10397.9 10420.7 13977.3 14343.9 14434.9 14453.4 14504.7 7493.8 7599.4 7775.3 7811.2 7827.3 7135.4 7182.8 7203.0 7410.7 7433.1 6718.9 6774.2 6810.3 6827.2 6908.1 1940.4 1946.3 1985.3 2011.5 2040.9 883.2 906.7 926.4 926.9 951.8 16626.5 17668.4 17772.6 17898.6 17997.6 916.6 925.8 927.5 938.6 946.7 9174.7 9392.5 9675.0 9711.3 9898.5 311346.0 313105.0 318054.0 318740.0 319434.0 72675.6 72783.0 74732.0 74900.6 76425.6 1098.4 1098.8 1127.4 1128.3 1129.8 14644.6 14914.2 14922.7 14938.9 15519.8 37335.0 38145.2 38665.8 39020.6 40049.8 47934.0 48231.3 48464.8 48743.5 49425.8 7999.4 8085.7 8186.2 8380.4 8424.7 13140.5 13662.7 13685.2 13689.2 13828.4 11235.9 11280.5 11341.1 11583.9 11924.4 10881.6 11039.2 11101.4 11213.9 11217.9 11661.7 11687.8 11718.8 11839.0 11981.5 8152.9 8316.0 8458.8 8518.2 8551.9 10846.2 10913.8 10978.1 11019.0 11508.2 14:49:40 INFO - PID 22128 | 14:49:40 INFO - PID 22128 | [#3] mootools.html Cycles:180 Average:5806.34 Median:4959.47 stddev:3604.41 (72.7%) stddev-sans-first:3598.14 14:49:40 INFO - PID 22128 | Values: 1233.5 1292.8 1308.9 1311.6 1316.3 9058.2 9443.3 9451.3 9453.6 9472.4 9107.3 9280.8 9593.4 9606.1 9606.2 2176.9 2208.5 2212.8 2215.9 2216.7 2067.6 2184.0 2196.3 2197.2 2203.6 1825.6 1895.0 2108.7 2191.5 2193.6 2195.0 2204.7 2215.3 2218.1 2220.6 2175.8 2202.9 2205.7 2205.9 2207.7 9019.0 9110.0 9159.8 9161.1 9199.1 5199.4 5389.1 5393.8 5395.2 5405.5 3131.9 3330.5 3423.0 3427.4 3443.3 1040.9 1069.3 1100.1 1110.1 1144.2 13495.3 13624.5 13627.0 13632.0 13640.7 4512.7 4565.8 4631.4 4763.6 4800.9 8907.6 8910.0 8928.7 8929.3 8931.6 5271.5 5281.2 5282.3 5349.0 5443.1 4689.4 4789.4 4810.8 4855.8 4879.8 3603.2 3636.5 3652.7 3707.1 3758.0 1089.7 1099.5 1103.2 1108.6 1113.6 654.7 669.6 669.7 692.4 694.5 4936.2 4983.4 5073.9 5137.7 5861.8 837.9 845.2 850.4 868.6 870.9 3400.7 3478.2 3480.0 3491.8 3598.9 11798.3 12020.5 12170.8 12268.6 12273.3 11567.2 12041.9 12134.4 12179.0 12201.5 6930.7 7048.5 7103.8 7105.2 7106.2 5035.7 5146.6 5163.1 5323.3 5342.3 10975.2 11031.5 11078.9 11154.8 11229.6 10996.6 11150.6 11270.8 11435.4 11464.6 7259.4 7426.4 7436.3 7440.9 7454.4 8593.0 8630.7 8689.9 8712.6 8714.7 6997.1 7318.7 7325.1 7343.5 7347.8 7422.3 7555.7 7556.7 7567.1 7613.0 6881.1 6994.4 7007.1 7010.7 7011.5 4982.8 4999.0 5062.5 5127.8 5183.6 5048.0 5109.8 5186.3 5259.2 5267.3 14:49:40 INFO - PID 22128 | 14:49:40 INFO - PID 22128 | [#4] prototype.html Cycles:180 Average:4727.13 Median:5199.01 stddev:1320.96 (25.4%) stddev-sans-first:1282.84 14:49:40 INFO - PID 22128 | Values: 333.4 361.4 383.6 385.1 390.4 5079.7 5257.9 5378.8 5406.8 5427.8 5226.5 5290.2 5318.2 5321.2 5354.5 4227.5 4229.4 4231.5 4239.9 4242.5 4032.6 4208.3 4239.1 4246.9 4259.9 4059.0 4109.8 4196.2 4200.5 4216.9 4111.3 4155.9 4184.1 4197.7 4206.8 3770.3 3773.5 3779.3 3810.2 3831.9 4884.6 4897.4 5142.2 5164.3 5171.5 5000.1 5005.7 5006.4 5013.9 5017.0 5548.9 5648.9 5664.1 5669.4 5716.4 4292.2 4314.2 4315.4 4328.6 4333.6 5975.2 6026.7 6031.9 6053.2 6066.2 4247.4 4394.1 4458.2 4461.6 4469.2 4221.0 4533.3 4533.7 4544.5 4547.3 4831.6 4835.0 4953.5 4961.2 4981.5 5695.9 5704.6 5715.9 5716.0 5717.3 1497.9 1542.7 1567.8 1568.1 1571.3 1105.8 1122.5 1128.7 1131.3 1132.6 4858.4 4898.3 4953.5 4956.9 4961.4 5857.8 5877.3 5884.6 5884.8 5886.2 4857.5 4917.8 4947.2 4950.6 4958.2 3076.3 3097.1 3098.5 3099.9 3103.6 5383.2 5409.8 5418.2 5431.5 5439.8 5786.5 5929.4 5948.4 5955.8 5958.8 5384.8 5406.7 5407.6 5414.5 5415.7 5677.2 5753.9 5759.7 5768.0 5820.6 5709.2 5709.8 5717.4 5718.5 5722.3 5297.3 5400.3 5416.7 5437.8 5446.8 4389.5 4397.4 4406.9 4443.2 4452.3 5573.1 5635.7 5727.7 5808.5 5816.1 5617.4 5626.2 5628.4 5628.8 5644.2 5462.4 5549.6 5557.3 5597.5 5618.5 5519.2 5525.5 5538.9 5546.7 5558.4 5636.2 5644.8 5656.2 5656.5 5668.1 5344.9 5440.1 5503.6 5512.4 5522.6 14:49:40 INFO - PID 22128 | 14:49:40 INFO - PID 22128 | [#5] yui.html Cycles:180 Average:14317.19 Median:18299.87 stddev:16170.71 (88.4%) stddev-sans-first:16183.96 14:49:40 INFO - PID 22128 | Values: 745.1 760.0 761.5 774.1 777.9 12640.7 13179.4 13180.1 13195.7 13197.9 13246.9 15550.8 15962.6 16130.0 16133.2 884.8 902.8 906.6 906.6 907.1 902.1 902.2 903.2 903.6 904.1 964.8 965.0 965.2 966.8 968.4 944.3 944.4 949.5 950.7 951.5 679.7 684.8 701.3 702.2 702.7 14227.1 15062.4 15132.7 15180.3 15183.8 14738.9 14781.1 15174.2 15193.2 15216.8 12069.7 12313.3 12321.1 12329.3 12337.9 2878.5 2941.6 2963.4 2991.3 2993.2 61990.0 62489.7 62875.4 63200.0 64560.7 12423.0 12662.7 12771.7 12776.2 13031.5 21488.1 21531.4 21934.0 22085.1 22089.2 5932.2 6184.1 6192.7 6196.4 6197.3 2978.3 3017.6 3020.1 3020.6 3047.5 3349.2 3411.8 3437.3 3466.5 3590.3 703.3 712.2 713.6 714.6 715.4 473.9 475.3 492.9 495.5 502.6 8569.7 9074.2 9340.0 9510.2 9607.9 566.8 567.9 577.7 589.3 596.3 4247.3 4313.3 4313.9 4391.0 4462.1 53021.5 53207.7 59844.0 60197.4 60396.0 47328.3 48483.0 48778.0 49374.3 49407.0 41523.0 41657.0 45249.8 45474.0 46517.5 9176.6 10034.0 10038.9 10089.1 10150.0 23995.4 25038.5 25817.2 25911.2 26407.6 28936.3 33250.5 41317.4 41863.0 43990.1 12947.1 13041.3 13145.9 13222.2 13294.7 14347.4 14377.8 14435.7 14496.7 14557.8 12799.9 12989.9 13069.3 13139.1 13198.7 12295.6 12513.2 12563.7 12568.3 12610.7 12955.9 12976.1 13707.7 13760.2 14047.9 10130.3 10317.0 10606.6 10701.3 10738.8 10133.5 10243.8 10383.9 11005.5 11288.2 14:49:40 INFO - PID 22128 | -------- Summary: end -------- 14:49:40 INFO - PID 22128 | 14:49:41 INFO - TEST-INFO | 22128: exit 0 14:49:41 INFO - TEST-OK | dromaeo_css | took 1124244ms 14:49:41 INFO - TEST-START | kraken 14:49:41 INFO - operating with platform_type : linux_ 14:49:41 INFO - Initialising browser for kraken test... 14:49:41 INFO - TEST-INFO | started process 22462 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR_gjLq/profile http://localhost:55877/getInfo.html) 14:49:46 INFO - PID 22462 | __metrics Screen width/height:1600/1200 14:49:46 INFO - PID 22462 | colorDepth:24 14:49:46 INFO - PID 22462 | Browser inner width/height: 1024/695 14:49:46 INFO - PID 22462 | __metrics 14:49:47 INFO - PID 22462 | 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" 14:49:47 INFO - PID 22462 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:49:48 INFO - TEST-INFO | 22462: exit 0 14:49:48 INFO - Browser initialized. 14:49:48 INFO - Running cycle 1/1 for kraken test... 14:49:48 INFO - TEST-INFO | started process 22566 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR_gjLq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:50:00 INFO - PID 22566 | RSS: Main: 168374272 14:50:00 INFO - PID 22566 | 14:50:03 INFO - PID 22566 | Cycle 1(1): loaded http://localhost:55877/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55877/tests/kraken/driver.html?testName=audio-beat-detection) 14:50:04 INFO - PID 22566 | RSS: Main: 245043200 14:50:04 INFO - PID 22566 | 14:50:06 INFO - PID 22566 | Cycle 1(1): loaded http://localhost:55877/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55877/tests/kraken/driver.html?testName=audio-dft) 14:50:07 INFO - PID 22566 | RSS: Main: 204562432 14:50:07 INFO - PID 22566 | 14:50:10 INFO - PID 22566 | Cycle 1(1): loaded http://localhost:55877/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55877/tests/kraken/driver.html?testName=audio-fft) 14:50:11 INFO - PID 22566 | RSS: Main: 287072256 14:50:11 INFO - PID 22566 | 14:50:13 INFO - PID 22566 | Cycle 1(1): loaded http://localhost:55877/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55877/tests/kraken/driver.html?testName=audio-oscillator) 14:50:14 INFO - PID 22566 | RSS: Main: 199774208 14:50:14 INFO - PID 22566 | 14:50:16 INFO - PID 22566 | Cycle 1(1): loaded http://localhost:55877/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55877/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:50:16 INFO - PID 22566 | RSS: Main: 203300864 14:50:16 INFO - PID 22566 | 14:50:19 INFO - PID 22566 | Cycle 1(1): loaded http://localhost:55877/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55877/tests/kraken/driver.html?testName=imaging-darkroom) 14:50:20 INFO - PID 22566 | RSS: Main: 263716864 14:50:20 INFO - PID 22566 | 14:50:24 INFO - PID 22566 | Cycle 1(1): loaded http://localhost:55877/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55877/tests/kraken/driver.html?testName=imaging-desaturate) 14:50:24 INFO - PID 22566 | RSS: Main: 264876032 14:50:24 INFO - PID 22566 | 14:50:27 INFO - PID 22566 | Cycle 1(1): loaded http://localhost:55877/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55877/tests/kraken/driver.html?testName=json-parse-financial) 14:50:28 INFO - PID 22566 | RSS: Main: 261206016 14:50:28 INFO - PID 22566 | 14:50:29 INFO - PID 22566 | Cycle 1(1): loaded http://localhost:55877/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55877/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:50:30 INFO - PID 22566 | RSS: Main: 225730560 14:50:30 INFO - PID 22566 | 14:50:32 INFO - PID 22566 | Cycle 1(1): loaded http://localhost:55877/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55877/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:50:32 INFO - PID 22566 | RSS: Main: 231698432 14:50:32 INFO - PID 22566 | 14:50:35 INFO - PID 22566 | Cycle 1(1): loaded http://localhost:55877/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55877/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:50:35 INFO - PID 22566 | RSS: Main: 239837184 14:50:35 INFO - PID 22566 | 14:50:38 INFO - PID 22566 | Cycle 1(1): loaded http://localhost:55877/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55877/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:50:39 INFO - PID 22566 | RSS: Main: 249094144 14:50:39 INFO - PID 22566 | 14:50:42 INFO - PID 22566 | Cycle 1(1): loaded http://localhost:55877/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55877/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:50:42 INFO - PID 22566 | RSS: Main: 227385344 14:50:42 INFO - PID 22566 | 14:50:44 INFO - PID 22566 | Cycle 1(1): loaded http://localhost:55877/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55877/tests/kraken/driver.html?testName=ai-astar) 14:50:45 INFO - PID 22566 | RSS: Main: 294146048 14:50:45 INFO - PID 22566 | 14:50:45 INFO - PID 22566 | __start_tp_report 14:50:45 INFO - PID 22566 | _x_x_mozilla_page_load 14:50:45 INFO - PID 22566 | _x_x_mozilla_page_load_details 14:50:45 INFO - PID 22566 | |i|pagename|runs| 14:50:45 INFO - PID 22566 | |0;ai-astar;109;112;112;113;111;110;112;111;111;112 14:50:45 INFO - PID 22566 | |1;audio-beat-detection;153;121;120;163;121;133;121;122;145;121 14:50:45 INFO - PID 22566 | |2;audio-dft;161;161;162;161;170;163;160;162;162;162 14:50:45 INFO - PID 22566 | |3;audio-fft;74;73;75;104;75;74;74;74;91;74 14:50:45 INFO - PID 22566 | |4;audio-oscillator;83;83;105;84;83;84;109;83;83;108 14:50:45 INFO - PID 22566 | |5;imaging-gaussian-blur;113;113;113;113;112;113;112;113;114;113 14:50:45 INFO - PID 22566 | |6;imaging-darkroom;149;148;148;148;148;149;149;148;148;149 14:50:45 INFO - PID 22566 | |7;imaging-desaturate;93;93;93;93;94;94;94;93;94;94 14:50:45 INFO - PID 22566 | |8;json-parse-financial;53;53;54;54;54;54;55;54;54;53 14:50:45 INFO - PID 22566 | |9;json-stringify-tinderbox;55;56;55;55;54;55;56;55;55;55 14:50:45 INFO - PID 22566 | |10;stanford-crypto-aes;81;82;82;81;80;86;82;88;79;80 14:50:45 INFO - PID 22566 | |11;stanford-crypto-ccm;132;133;129;130;126;138;128;127;171;127 14:50:45 INFO - PID 22566 | |12;stanford-crypto-pbkdf2;199;183;182;196;188;186;187;182;187;188 14:50:45 INFO - PID 22566 | |13;stanford-crypto-sha256-iterative;69;70;69;69;69;70;70;69;73;69 14:50:45 INFO - PID 22566 | __end_tp_report 14:50:45 INFO - PID 22566 | __start_cc_report 14:50:45 INFO - PID 22566 | _x_x_mozilla_cycle_collect,1929 14:50:45 INFO - PID 22566 | __end_cc_report 14:50:45 INFO - PID 22566 | __startTimestamp1494280245041__endTimestamp 14:50:45 INFO - PID 22566 | 14:50:45 INFO - PID 22566 | ------- Summary: start ------- 14:50:45 INFO - PID 22566 | Number of tests: 14 14:50:45 INFO - PID 22566 | 14:50:45 INFO - PID 22566 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:1.16 (1.0%) stddev-sans-first:0.88 14:50:45 INFO - PID 22566 | Values: 109.0 112.0 112.0 113.0 111.0 110.0 112.0 111.0 111.0 112.0 14:50:45 INFO - PID 22566 | 14:50:45 INFO - PID 22566 | [#1] audio-beat-detection Cycles:10 Average:132.00 Median:127.50 stddev:15.99 (12.5%) stddev-sans-first:15.04 14:50:45 INFO - PID 22566 | Values: 153.0 121.0 120.0 163.0 121.0 133.0 121.0 122.0 145.0 121.0 14:50:45 INFO - PID 22566 | 14:50:45 INFO - PID 22566 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.00 stddev:2.80 (1.7%) stddev-sans-first:2.92 14:50:45 INFO - PID 22566 | Values: 161.0 161.0 162.0 161.0 170.0 163.0 160.0 162.0 162.0 162.0 14:50:45 INFO - PID 22566 | 14:50:45 INFO - PID 22566 | [#3] audio-fft Cycles:10 Average:78.80 Median:74.00 stddev:10.34 (14.0%) stddev-sans-first:10.82 14:50:45 INFO - PID 22566 | Values: 74.0 73.0 75.0 104.0 75.0 74.0 74.0 74.0 91.0 74.0 14:50:45 INFO - PID 22566 | 14:50:45 INFO - PID 22566 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:83.00 stddev:11.66 (14.1%) stddev-sans-first:12.05 14:50:45 INFO - PID 22566 | Values: 83.0 83.0 105.0 84.0 83.0 84.0 109.0 83.0 83.0 108.0 14:50:45 INFO - PID 22566 | 14:50:45 INFO - PID 22566 | [#5] imaging-gaussian-blur Cycles:10 Average:112.90 Median:113.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 14:50:45 INFO - PID 22566 | Values: 113.0 113.0 113.0 113.0 112.0 113.0 112.0 113.0 114.0 113.0 14:50:45 INFO - PID 22566 | 14:50:45 INFO - PID 22566 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:0.52 (0.3%) stddev-sans-first:0.50 14:50:45 INFO - PID 22566 | Values: 149.0 148.0 148.0 148.0 148.0 149.0 149.0 148.0 148.0 149.0 14:50:45 INFO - PID 22566 | 14:50:45 INFO - PID 22566 | [#7] imaging-desaturate Cycles:10 Average:93.50 Median:94.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 14:50:45 INFO - PID 22566 | Values: 93.0 93.0 93.0 93.0 94.0 94.0 94.0 93.0 94.0 94.0 14:50:45 INFO - PID 22566 | 14:50:45 INFO - PID 22566 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:0.63 (1.2%) stddev-sans-first:0.60 14:50:45 INFO - PID 22566 | Values: 53.0 53.0 54.0 54.0 54.0 54.0 55.0 54.0 54.0 53.0 14:50:45 INFO - PID 22566 | 14:50:45 INFO - PID 22566 | [#9] json-stringify-tinderbox Cycles:10 Average:55.10 Median:55.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 14:50:45 INFO - PID 22566 | Values: 55.0 56.0 55.0 55.0 54.0 55.0 56.0 55.0 55.0 55.0 14:50:45 INFO - PID 22566 | 14:50:45 INFO - PID 22566 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.00 stddev:2.81 (3.4%) stddev-sans-first:2.95 14:50:45 INFO - PID 22566 | Values: 81.0 82.0 82.0 81.0 80.0 86.0 82.0 88.0 79.0 80.0 14:50:45 INFO - PID 22566 | 14:50:45 INFO - PID 22566 | [#11] stanford-crypto-ccm Cycles:10 Average:134.10 Median:131.00 stddev:13.45 (10.3%) stddev-sans-first:14.25 14:50:45 INFO - PID 22566 | Values: 132.0 133.0 129.0 130.0 126.0 138.0 128.0 127.0 171.0 127.0 14:50:45 INFO - PID 22566 | 14:50:45 INFO - PID 22566 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.80 Median:187.50 stddev:5.65 (3.0%) stddev-sans-first:4.30 14:50:45 INFO - PID 22566 | Values: 199.0 183.0 182.0 196.0 188.0 186.0 187.0 182.0 187.0 188.0 14:50:45 INFO - PID 22566 | 14:50:45 INFO - PID 22566 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:69.50 stddev:1.25 (1.8%) stddev-sans-first:1.30 14:50:45 INFO - PID 22566 | Values: 69.0 70.0 69.0 69.0 69.0 70.0 70.0 69.0 73.0 69.0 14:50:45 INFO - PID 22566 | -------- Summary: end -------- 14:50:45 INFO - PID 22566 | 14:50:46 INFO - TEST-INFO | 22566: exit 0 14:50:46 INFO - TEST-OK | kraken | took 64631ms 14:50:46 INFO - SUITE-END | took 1188s 14:50:46 INFO - Completed test suite (00:19:49) 14:50:46 INFO - javascript benchmark 14:50:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6579.675609820356, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2701.837889726616, 2716.891324347026, 2748.2030211238744, 2750.3674154944374, 2761.6685997680274, 5068.087744206042, 5144.897102057961, 5190.351206099238, 5194.194899790534, 5224.817131400402, 5150.150225212845, 5180.352455943007, 5183.326167598207, 5223.399309079457, 5243.213517972306, 4304.354346847967, 4522.140793249288, 4566.429196350465, 4675.953240467586, 4677.0, 4585.449746030481, 4638.768061596924, 4659.510751371108, 4675.111728771522, 4703.5061318561575, 4523.231050721352, 4579.748113853737, 4583.335416364642, 4590.242609969351, 4592.793324300381, 4557.361969324297, 4602.677812553123, 4610.0, 4619.19164146273, 4638.420197475316, 4597.793099310539, 4613.723176609415, 4624.075184962987, 4635.582797548237, 4639.86080417588, 5050.747462626854, 5058.165402708549, 5072.188449848043, 5126.743662816844, 5130.153524668425, 5528.530074943635, 5541.944580554183, 5544.22380866679, 5558.722063896829, 5638.605297629168, 5403.864903377408, 5432.831941132676, 5457.617966742329, 5606.831795046155, 5616.157576363578, 5166.5866730661455, 5173.1722924331925, 5175.792968281302, 5179.974100129475, 5194.766235519411, 5676.801311954062, 5712.086066229466, 5725.427457254241, 5731.254936858182, 5739.713014349266, 5418.51233388989, 5421.0, 5421.457854214547, 5423.159410291411, 5471.753771080311, 5544.556435485151, 5563.0, 5635.1828984796975, 5640.520555752807, 5647.548196144298, 5453.536449401766, 5455.072637651609, 5459.372172200168, 5459.426760190123, 5460.126379779216, 5409.972950135224, 5452.291202143775, 5454.618176727591, 5464.207689884945, 5469.753861076261, 4520.50274469808, 4561.840335588238, 4589.678722489461, 4637.652176086807, 4639.744814035193, 3945.033466800652, 3959.742616729903, 3993.0616305168264, 3994.0, 4002.679785617144, 4760.95239047612, 4761.952380476151, 4767.61859051275, 4781.043791241766, 4809.663323567387, 5516.14499752539, 5565.499105080481, 5589.329280486368, 5635.605507614509, 5642.633228840113, 4740.549647783524, 4768.380110585602, 4769.713817170981, 4770.594499467584, 4808.0383923215495, 4982.7508624569355, 4986.975065124651, 4988.850334489971, 4989.675671081368, 5024.748762561857, 5107.0, 5178.119719647593, 5191.92212116811, 5204.427512973645, 5254.921176182437, 5570.442955704397, 5622.831315060391, 5665.603407761417, 5666.829995100154, 5680.318361796611, 5122.948770512247, 5145.202493613496, 5196.038732834438, 5197.636165468381, 5202.271681964604, 5453.236546883519, 5497.36780270274, 5549.889002219852, 5555.777768889199, 5557.277553917965, 5605.495505404533, 5623.493885550321, 5627.718614069198, 5627.803026894039, 5679.233303503974, 5317.574594032545, 5414.648047877033, 5414.864628384322, 5421.430749771217, 5423.864403389947, 5351.010063138332, 5393.730313484389, 5471.12462006093, 5472.315960504937, 5475.753591088331, 5359.330083739533, 5362.946370536245, 5371.838844834661, 5383.5962302826665, 5386.7037312946595, 5437.619366644455, 5437.646552974203, 5440.619156658996, 5442.482964118402, 5446.782128714807, 5249.921251181159, 5303.708296043755, 5304.336957880265, 5304.708241046779, 5307.283516725347], "value": 5045.429921721153, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.9200099987502, 703.2405002597194, 718.8957601147833, 1076.0960792933934, 1080.287010573022, 25716.87141564294, 30098.398032039375, 32544.67455325443, 32672.67327326726, 32738.181545461375, 34960.475592866125, 35309.2938141237, 35316.0, 35376.0, 35390.82304588473, 6869.725210991567, 7014.22843487216, 7014.859702805941, 7016.228214896358, 7019.964900175492, 5236.711980841072, 5377.65045272058, 6230.813075607739, 6827.112475378194, 6834.897476537831, 6871.862562748742, 6947.826304342381, 6952.443804495653, 6961.477889158334, 6976.965115174417, 6850.0752398426075, 6851.417629501499, 6909.965450172767, 6913.585184888872, 6934.618595977219, 5117.411497677777, 5295.655782374133, 6676.332366763285, 6838.760643377507, 6845.212800527904, 30633.0, 30877.0, 30961.380772384426, 30970.690293097232, 31016.379672406427, 3027.2431892026993, 3070.0329396240113, 3071.7389021933163, 3075.369549242422, 3077.984610076958, 23322.76677233223, 23371.182008629617, 23392.415189620224, 23411.297661070024, 23446.882765586233, 3133.780635355526, 3151.133438304462, 3161.162291992624, 3169.683031696835, 3172.191091271711, 141615.0, 141889.29055354762, 142163.0, 142214.0, 142357.0, 41541.58458415438, 41567.584324156975, 41601.0, 41700.79149604232, 41720.582794172275, 43515.78242108769, 43712.562874371484, 43743.0, 43758.0, 43835.12329753387, 12264.448099835528, 12348.530293941069, 12350.62948111558, 12351.19717218378, 12362.320072396105, 9859.950700246452, 9866.408015519091, 9868.407895526292, 9869.753256168653, 9871.160951319074, 10575.0, 10796.622118225825, 11909.642710718692, 11964.222325548986, 12150.149489535825, 5025.79896804131, 5226.294450249244, 5242.1088414969545, 5243.2659427680155, 5249.448807875118, 876.609908590671, 917.8990311065777, 918.669279059538, 927.0544045073987, 948.7485816258697, 20181.192752290037, 21078.473038173863, 21088.0, 21090.261840835803, 21254.893725531583, 986.2800155886243, 998.6404894238068, 1002.5087707023652, 1010.2221289606962, 1020.7295066807153, 10826.566937322576, 10990.17573681961, 11108.333499990027, 11217.495212715447, 11390.829137562943, 150735.0, 151783.0, 152971.23514382358, 153143.0, 153162.0, 41957.16085678269, 42090.0, 42290.57709422928, 42290.57709422928, 42314.78842605829, 1227.3679055286534, 1231.0643910627987, 1244.9813252801216, 1247.21425501935, 1251.6495381293253, 22517.549649007255, 22726.659100113844, 23624.0, 23936.281911542683, 23983.760162398154, 36627.084322892144, 37003.629963701096, 37808.810955946145, 37877.81061094787, 37924.24151517009, 139372.0, 139412.0, 139927.0, 140087.0, 140550.0, 28105.156845293855, 28265.71734282631, 28294.292642684097, 28304.15087547377, 28338.574921375784, 30232.54651180278, 30804.22989425282, 33421.49867752034, 33517.0, 35298.11754706153, 26587.60118598184, 26671.0, 26791.598126028515, 26799.464010720065, 27445.588316175672, 28266.0, 28396.0, 28750.568741468476, 28810.27974300659, 29810.0, 31647.0, 31716.365672685955, 31744.36511269808, 31938.0, 32044.359112817147, 26410.339741506617, 26732.465350693266, 27567.172984810488, 28052.0, 28152.155435336972, 20206.79793202049, 21869.671954921007, 22027.779722202573, 22052.669209961543, 22084.558308834054], "value": 14334.212260214275, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.4914055711475, 415.5553557693269, 426.7013090836413, 437.2151987183006, 443.6428674916693, 15173.468928587474, 16993.2353044113, 17650.64698706028, 17847.0, 17848.553786155353, 17789.55526111848, 17822.64354712905, 17950.281988720435, 18162.5459363516, 18241.0, 5295.179247216687, 5406.107992181285, 5456.045192091388, 5508.724563771815, 5574.60977731559, 5426.647267927572, 5524.889502209953, 5525.005499010176, 5527.44725527446, 5527.640703354289, 5323.1749078892835, 5459.454054594548, 5459.972700136514, 5484.725763711818, 5495.697736624484, 5378.273933019051, 5398.433164517728, 5407.215953686733, 5422.999999999961, 5425.0, 4731.384919960417, 4864.756762161913, 4897.436794768611, 4898.706077635354, 4913.631477639191, 20957.68563471549, 21343.573128537497, 21448.463788405257, 21546.676799848014, 21645.025973831216, 1670.3151707799743, 1694.1867903406435, 1696.8557672597844, 1697.6095498035397, 1700.948971530856, 13952.720945581032, 14397.208153551655, 14411.92794036023, 14585.19781412022, 14714.117152970855, 2017.838572914178, 2025.8176764091156, 2038.3375402994086, 2090.560982193741, 2116.9788302116935, 68125.65937170283, 72686.63656681735, 90839.0, 90888.54555727245, 91396.54301728515, 10257.17942564593, 10261.486925653688, 10347.793044139225, 10397.948010259901, 10420.68737937863, 13977.301134943416, 14343.85656143446, 14434.927825361015, 14453.421863125568, 14504.709905801825, 7493.812654683567, 7599.354054905284, 7775.3390961767755, 7811.179826118289, 7827.334676552557, 7135.357817796424, 7182.784516464514, 7203.0, 7410.740624078131, 7433.145188303414, 6718.932810671929, 6774.220964589135, 6810.250872404032, 6827.180738311435, 6908.1364829396325, 1940.3596813051659, 1946.3479734289172, 1985.334912804198, 2011.4669612552684, 2040.9387118698194, 883.2492381475694, 906.7461110888962, 926.393212445849, 926.8980412154658, 951.7953639967441, 16626.50120496387, 17668.38160664396, 17772.644547108986, 17898.55253618644, 17997.550061248574, 916.5829547555846, 925.7916968681992, 927.4898805656861, 938.638624129715, 946.6639343033262, 9174.724758257264, 9392.530373481299, 9674.951625241829, 9711.27165462593, 9898.455584942752, 311346.0, 313105.0, 318054.0, 318740.0, 319434.0, 72675.63662181655, 72783.0, 74732.0, 74900.62549687216, 76425.61787191029, 1098.3519723363413, 1098.7967226063204, 1127.3517727306667, 1128.2891778179694, 1129.7514546799691, 14644.633884152981, 14914.179720115499, 14922.701545969237, 14938.925305373403, 15519.84480155184, 37335.0, 38145.2370952585, 38665.80667096646, 39020.60979390283, 40049.79975100106, 47934.0, 48231.27653085136, 48464.7576762114, 48743.51256487532, 49425.75287123541, 7999.360131172979, 8085.716999904975, 8186.222308880647, 8380.371472139735, 8424.663013479392, 13140.474381024653, 13662.726745465234, 13685.247311397969, 13689.178649281075, 13828.377723002288, 11235.943820280847, 11280.492377842853, 11341.092712583139, 11583.884161158281, 11924.403779811148, 10881.564737410416, 11039.172062095215, 11101.389423581457, 11213.887861121284, 11217.88782112201, 11661.6501504955, 11687.824682629598, 11718.765624687629, 11839.0, 11981.460834262305, 8152.9184708154535, 8316.0, 8458.788530286793, 8518.23335899772, 8551.914480855112, 10846.186536009673, 10913.781724365626, 10978.066864316623, 11019.0, 11508.194426390073], "value": 8782.84278537207, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1233.451114254157, 1292.8448586169661, 1308.947642094316, 1311.593406044127, 1316.2826259688482, 9058.233644439337, 9443.291753118527, 9451.291153163515, 9453.574589143487, 9472.43165410076, 9107.271418286538, 9280.814383712339, 9593.424394536332, 9606.087421694945, 9606.183474404666, 2176.945576360588, 2208.514126892081, 2212.7787221277904, 2215.9224427145055, 2216.7339919209635, 2067.586482703458, 2184.0390228299575, 2196.2642514757576, 2197.154095673169, 2203.6474164133742, 1825.5892424204515, 1894.9905250473728, 2108.6942393352956, 2191.539776646906, 2193.594185075758, 2195.0, 2204.713387259662, 2215.3464727905307, 2218.0905828610194, 2220.555888822234, 2175.8041776240057, 2202.9008694608783, 2205.658122990939, 2205.911763529457, 2207.6578130389817, 9019.0, 9110.0, 9159.76343193667, 9161.083891610851, 9199.126083022102, 5199.428062913076, 5389.110796718537, 5393.7572809223675, 5395.244665746799, 5405.459454054602, 3131.874725010997, 3330.4504756715114, 3422.9828850855833, 3427.365937301607, 3443.328550932569, 1040.9323393979444, 1069.3209811769505, 1100.0759362135764, 1110.0952723530297, 1144.1933436926947, 13495.257760823151, 13624.523141690092, 13627.04610677253, 13632.0, 13640.727185456235, 4512.729236245836, 4565.817367305337, 4631.374764406829, 4763.595094416944, 4800.903981920342, 8907.643694252158, 8909.955450222707, 8928.687495937611, 8929.33030022751, 8931.598078086501, 5271.525562699376, 5281.181416880389, 5282.260483532308, 5349.0, 5443.122122867604, 4689.43726752785, 4789.353437285991, 4810.807567697253, 4855.8057677693205, 4879.756012199376, 3603.1892824114366, 3636.5272514573467, 3652.726045546595, 3707.073231692077, 3758.0, 1089.700332408594, 1099.4667586220676, 1103.2332528892343, 1108.5565773690428, 1113.582406597526, 654.6857508395901, 669.5647828911247, 669.7053296549502, 692.3976140757574, 694.5381321421198, 4936.185529387682, 4983.401991761012, 5073.949260507421, 5137.717425541631, 5861.765529378862, 837.8868852704928, 845.1801752300258, 850.3877208409934, 868.6481974800216, 870.8983136332545, 3400.6939375456327, 3478.2000139967445, 3479.965200347964, 3491.795330610986, 3598.874039408608, 11798.292102473879, 12020.45907934145, 12170.81743773844, 12268.570600028956, 12273.324967126893, 11567.190296679151, 12041.879581204252, 12134.393280335948, 12179.0, 12201.45093470796, 6930.722771089201, 7048.541844780176, 7103.751368702071, 7105.182903966007, 7106.2183159852375, 5035.723035233097, 5146.562542183807, 5163.122269214167, 5323.334583177103, 5342.278792362981, 10975.176861735561, 11031.503582338653, 11078.889211108108, 11154.776904461703, 11229.606963756229, 10996.560137594726, 11150.553977840795, 11270.830937536108, 11435.371054592077, 11464.598739044093, 7259.419246460165, 7426.368758655359, 7436.330730234305, 7440.888386674096, 7454.44091693136, 8593.0, 8630.741077767678, 8689.869651955352, 8712.607932642919, 8714.651413943371, 6997.1253593300835, 7318.707251709872, 7325.120985481776, 7343.522671026366, 7347.7795666130105, 7422.294881986203, 7555.73554925597, 7556.735514256975, 7567.091948966159, 7612.961935190288, 6881.13985751781, 6994.405475534637, 7007.089078419773, 7010.68451919675, 7011.509194356346, 4982.75086245679, 4998.950010499849, 5062.519060689228, 5127.820526281562, 5183.637145399785, 5048.0, 5109.821156259513, 5186.299849520266, 5259.184826351921, 5267.262583238273], "value": 4470.291081542929, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.4165210880958, 361.4253337193861, 383.58572741439247, 385.10078965615287, 390.42022596444275, 5079.695218286901, 5257.8948421031555, 5378.838634840961, 5406.83779486615, 5427.782888684458, 5226.529612334889, 5290.1800220965815, 5318.202269659553, 5321.201819727034, 5354.544863686581, 4227.513835908871, 4229.36559516072, 4231.513375961773, 4239.872803815891, 4242.469691288589, 4032.628906171901, 4208.263553878074, 4239.0885959518855, 4246.893827654318, 4259.872203833875, 4058.9594104059024, 4109.773962432065, 4196.223698615766, 4200.474940632421, 4216.873493795191, 4111.301078816608, 4155.937660935088, 4184.0795025094585, 4197.727147735418, 4206.789660516977, 3770.3024940385844, 3773.5471743390694, 3779.338615742234, 3810.1808111255937, 3831.942520862189, 4884.5848102911295, 4897.445375800504, 5142.202958541432, 5164.2770012198325, 5171.482851714798, 5000.149974504343, 5005.699658020494, 5006.374203224597, 5013.899722005576, 5017.0, 5548.91676624851, 5648.898464799366, 5664.122061080539, 5669.433056694339, 5716.399778023289, 4292.163028209469, 4314.245007123772, 4315.352697095429, 4328.588784065509, 4333.58830911063, 5975.163477113208, 6026.728797204137, 6031.909521357183, 6053.182820319289, 6066.150738896558, 4247.405363249148, 4394.099209662011, 4458.197524445566, 4461.594597701714, 4469.240229161051, 4220.978895105505, 4533.342665313511, 4533.705309154894, 4544.477385100756, 4547.3406356078185, 4831.589314908272, 4834.975825120922, 4953.479884612136, 4961.181405068195, 4981.501849814989, 5695.914561281584, 5704.572157088235, 5715.942840571624, 5716.0, 5717.285339332583, 1497.8726808221206, 1542.7272500187166, 1567.8275389707123, 1568.05916450129, 1571.3321838218712, 1105.8341248812742, 1122.539758698946, 1128.6614015795228, 1131.3268605179906, 1132.6262333429947, 4858.368412106403, 4898.289747986522, 4953.479884612136, 4956.876078098005, 4961.3798275215595, 5857.824265272048, 5877.294724632986, 5884.6469211847425, 5884.823455296348, 5886.205362276038, 4857.465678775332, 4917.827876024394, 4947.208446648519, 4950.554450099508, 4958.231474121517, 3076.338587203762, 3097.1018404662846, 3098.4507746126937, 3099.9380012400075, 3103.5810165627804, 5383.192521121785, 5409.809027343853, 5418.160185171305, 5431.511163995259, 5439.836804895859, 5786.537077033827, 5929.436703513159, 5948.4421698669985, 5955.821325360246, 5958.761649534057, 5384.784608615611, 5406.675599464044, 5407.648502847381, 5414.512693857571, 5415.702136382458, 5677.1768093627015, 5753.90675771602, 5759.7408116634015, 5767.971160144172, 5820.563457740771, 5709.172170035405, 5709.771609135588, 5717.42825717425, 5718.485336319751, 5722.313322401338, 5297.3248509502455, 5400.324959380077, 5416.729163541886, 5437.782488700408, 5446.754896029767, 4389.4513185851765, 4397.40635014269, 4406.867793966187, 4443.155800397914, 4452.287633978548, 5573.136163894603, 5635.718214089197, 5727.656340619576, 5808.5062769665055, 5816.098504731774, 5617.382087970238, 5626.24045753818, 5628.437156284339, 5628.831135065954, 5644.153376993484, 5462.399136095106, 5549.556035517068, 5557.305021968176, 5597.468240517144, 5618.4662457066515, 5519.227308176939, 5525.502704756591, 5538.9169162461785, 5546.667199968015, 5558.416366281483, 5636.1827535008015, 5644.83065508019, 5656.236408084856, 5656.490915817596, 5668.121441176624, 5344.919826202532, 5440.129579267298, 5503.559715222693, 5512.366077900932, 5522.597670013557], "value": 4327.801860845177, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.1393640345403, 759.9848003039939, 761.5240474703307, 774.078846173054, 777.8755399136139, 12640.747185056294, 13179.406926688298, 13180.1432906861, 13195.736085278313, 13197.868021319784, 13246.933765331183, 15550.76673849893, 15962.600934976632, 16130.0, 16133.193340332966, 884.8230353929208, 902.8329758994574, 906.5603182456504, 906.5693795447143, 907.0702529906832, 902.1384577728254, 902.1835239108617, 903.227740282056, 903.6114470777596, 904.0597778310582, 964.7588102974256, 965.006043774913, 965.232640051161, 966.8114717630065, 968.4141094637748, 944.2587568758526, 944.3672739264675, 949.5015117063527, 950.7100334398006, 951.5480146930153, 679.7077256779583, 684.8116767888871, 701.3337329536961, 702.153904545022, 702.6802804723839, 14227.07524010936, 15062.397504099823, 15132.697346053128, 15180.316885740169, 15183.772243416357, 14738.926305368404, 14781.113133212042, 15174.165420901845, 15193.164375959317, 15216.847831521654, 12069.698257543632, 12313.26120432777, 12321.137520373577, 12329.321887296195, 12337.93831030848, 2878.510653188963, 2941.617589713345, 2963.4221326841275, 2991.2820922978544, 2993.206800197949, 61990.0, 62489.687551562405, 62875.37124628741, 63200.0, 64560.67719661372, 12423.0, 12662.746745065047, 12771.680707982376, 12776.169548979287, 13031.47874085026, 21488.14047438116, 21531.354059378245, 21934.0, 22085.116595336327, 22089.226877059227, 5932.169496270526, 6184.103305020747, 6192.721327540272, 6196.411340922605, 6197.349278325801, 2978.255436140965, 3017.5775391445213, 3020.0788759428583, 3020.622422197225, 3047.49716296813, 3349.246419555629, 3411.8123503207066, 3437.295354452381, 3466.5493485846678, 3590.281943611236, 703.3388614702266, 712.1952194020827, 713.6431784107946, 714.5748279773527, 715.3883429667663, 473.8957429365534, 475.25859658931483, 492.8964917367321, 495.45252495992133, 502.5652810319121, 8569.742907712778, 9074.228690561244, 9339.953300233592, 9510.239180865514, 9607.90392096084, 566.8186180422225, 567.8523583868224, 577.719805894141, 589.2928485817037, 596.2963702830615, 4247.299195632686, 4313.3098704207805, 4313.9137217255475, 4391.0, 4462.062966776948, 53021.51655735064, 53207.73396132995, 59844.0, 60197.398026020055, 60396.0, 47328.290075648896, 48483.0, 48778.0, 49374.25938610924, 49407.0, 41522.96192595149, 41657.0, 45249.77375113103, 45474.0, 46517.53482465132, 9176.577630467289, 10034.046765557261, 10038.899611004088, 10089.142422894136, 10150.0, 23995.400114997265, 25038.499230015663, 25817.225483235532, 25911.22266332013, 26407.603885941342, 28936.276593085342, 33250.50124248186, 41317.38023929583, 41863.0, 43990.12019759651, 12947.093703440669, 13041.282729449971, 13145.934270328587, 13222.206667599974, 13294.734105318033, 14347.35436905321, 14377.784333235219, 14435.711285774436, 14496.710065798414, 14557.781633275297, 12799.872001279868, 12989.870101298866, 13069.346532673519, 13139.080264381402, 13198.670033249246, 12295.56965506203, 12513.249205047727, 12563.748725025265, 12568.308743018855, 12610.684732881751, 12955.935220323838, 12976.091673582758, 13707.657308566966, 13760.179163271305, 14047.929760351133, 10130.290879638354, 10317.0, 10606.575736970435, 10701.250912436055, 10738.838917416402, 10133.493325333851, 10243.795124097625, 10383.896161038292, 11005.504752286326, 11288.153388495732], "value": 6602.121957595648, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1512.3999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 112.0, 113.0, 111.0, 110.0, 112.0, 111.0, 111.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 121.0, 120.0, 163.0, 121.0, 133.0, 121.0, 122.0, 145.0, 121.0], "value": 132.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 170.0, 163.0, 160.0, 162.0, 162.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 75.0, 104.0, 75.0, 74.0, 74.0, 74.0, 91.0, 74.0], "value": 78.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 105.0, 84.0, 83.0, 84.0, 109.0, 83.0, 83.0, 108.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 112.0, 113.0, 112.0, 113.0, 114.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 148.0, 148.0, 149.0, 149.0, 148.0, 148.0, 149.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 93.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0], "value": 93.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 54.0, 54.0, 54.0, 55.0, 54.0, 54.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 55.0, 54.0, 55.0, 56.0, 55.0, 55.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 82.0, 81.0, 80.0, 86.0, 82.0, 88.0, 79.0, 80.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 133.0, 129.0, 130.0, 126.0, 138.0, 128.0, 127.0, 171.0, 127.0], "value": 134.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 183.0, 182.0, 196.0, 188.0, 186.0, 187.0, 182.0, 187.0, 188.0], "value": 187.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 69.0, 69.0, 70.0, 70.0, 69.0, 73.0, 69.0], "value": 69.7, "unit": "score"}]}]} 14:50:46 INFO - Return code: 0 14:50:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:50:46 INFO - # TBPL SUCCESS # 14:50:46 INFO - Running post-action listener: _resource_record_post_action 14:50:46 INFO - [mozharness: 2017-05-08 21:50:46.850728Z] Finished run-tests step (success) 14:50:46 INFO - Running post-run listener: _resource_record_post_run 14:50:46 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 366784512; Read time: 12; Write time: 350040 14:50:46 INFO - TinderboxPrint: CPU usage
13.0% 14:50:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:50:46 INFO - TinderboxPrint: I/O write bytes / time
366,784,512 / 350,040 14:50:46 INFO - TinderboxPrint: CPU idle
8,371.8 (87.0%) 14:50:46 INFO - TinderboxPrint: CPU user
1,200.9 (12.5%) 14:50:46 INFO - TinderboxPrint: Swap in / out
0 / 0 14:50:46 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 37879808; Read time: 0; Write time: 14984 14:50:46 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 328331264; Read time: 12; Write time: 335008 14:50:47 INFO - Running post-run listener: _upload_blobber_files 14:50:47 INFO - Blob upload gear active. 14:50:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:50:47 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 14:50:47 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'] 14:50:47 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 14:50:47 INFO - (blobuploader) - INFO - Open directory for files ... 14:50:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:50:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:50:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:50:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:50:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:50:48 INFO - (blobuploader) - INFO - Done attempting. 14:50:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:50:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:50:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:50:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:50:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:50:52 INFO - (blobuploader) - INFO - Done attempting. 14:50:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:50:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:50:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:50:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:50:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:50:53 INFO - (blobuploader) - INFO - Done attempting. 14:50:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:50:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:50:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:50:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:50:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:50:53 INFO - (blobuploader) - INFO - Done attempting. 14:50:53 INFO - (blobuploader) - INFO - Iteration through files over. 14:50:53 INFO - Return code: 0 14:50:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:50:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:50:53 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb9f01899fefe89f3e01c4c5653d5df5a65bfd2243922e4825d832fb00291056cb41e1b704710b0d2620c91fa52ad61ea88f01165375f8c2916bc5da9ac908ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84f5176dee3372391e960ca59a304e07f9fa011fe3a37b06063cd60486bad9bf84b4230163aa668256be2e17c05ebc36ad09d652f618ed0b925020c71c573170", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eab0ba66d34ec0c10f89685666bd5687361525d8db48ef5d7b36abaaeedcfa3360624a947f16e048332e1d9d26ea4d1aa064f9931f6895272f06213604eda6b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d04fc1271cf2d74578a7734af568a727d34ee122d40ae40fab877916e71d5c1f0d85dfed4b515b36ed258e14e1c7a9384d09a5a1db22a0bbc2df203300f13d5f"} 14:50:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:50:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:50:53 INFO - Contents: 14:50:53 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb9f01899fefe89f3e01c4c5653d5df5a65bfd2243922e4825d832fb00291056cb41e1b704710b0d2620c91fa52ad61ea88f01165375f8c2916bc5da9ac908ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84f5176dee3372391e960ca59a304e07f9fa011fe3a37b06063cd60486bad9bf84b4230163aa668256be2e17c05ebc36ad09d652f618ed0b925020c71c573170", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eab0ba66d34ec0c10f89685666bd5687361525d8db48ef5d7b36abaaeedcfa3360624a947f16e048332e1d9d26ea4d1aa064f9931f6895272f06213604eda6b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d04fc1271cf2d74578a7734af568a727d34ee122d40ae40fab877916e71d5c1f0d85dfed4b515b36ed258e14e1c7a9384d09a5a1db22a0bbc2df203300f13d5f"} 14:50:53 INFO - Running post-run listener: copy_logs_to_upload_dir 14:50:53 INFO - Copying logs to upload dir... 14:50:53 INFO - mkdir: /builds/slave/test/build/upload/logs 14:50:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.710867 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-05-08 14:50:53.698262) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 14:50:53.706029) ========= 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=fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb9f01899fefe89f3e01c4c5653d5df5a65bfd2243922e4825d832fb00291056cb41e1b704710b0d2620c91fa52ad61ea88f01165375f8c2916bc5da9ac908ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84f5176dee3372391e960ca59a304e07f9fa011fe3a37b06063cd60486bad9bf84b4230163aa668256be2e17c05ebc36ad09d652f618ed0b925020c71c573170", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eab0ba66d34ec0c10f89685666bd5687361525d8db48ef5d7b36abaaeedcfa3360624a947f16e048332e1d9d26ea4d1aa064f9931f6895272f06213604eda6b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d04fc1271cf2d74578a7734af568a727d34ee122d40ae40fab877916e71d5c1f0d85dfed4b515b36ed258e14e1c7a9384d09a5a1db22a0bbc2df203300f13d5f"} build_url:https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011345 build_url: 'https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb9f01899fefe89f3e01c4c5653d5df5a65bfd2243922e4825d832fb00291056cb41e1b704710b0d2620c91fa52ad61ea88f01165375f8c2916bc5da9ac908ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84f5176dee3372391e960ca59a304e07f9fa011fe3a37b06063cd60486bad9bf84b4230163aa668256be2e17c05ebc36ad09d652f618ed0b925020c71c573170", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eab0ba66d34ec0c10f89685666bd5687361525d8db48ef5d7b36abaaeedcfa3360624a947f16e048332e1d9d26ea4d1aa064f9931f6895272f06213604eda6b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d04fc1271cf2d74578a7734af568a727d34ee122d40ae40fab877916e71d5c1f0d85dfed4b515b36ed258e14e1c7a9384d09a5a1db22a0bbc2df203300f13d5f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 14:50:53.734760) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 14:50:53.735101) ========= 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=fcadb68e09dcf59683000ff6000001dc-1494278992.748761-1190042871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004412 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 14:50:53.815421) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 14:50:53.818749) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 14:50:53.819042) ========= ========= Total master_lag: 0.16 =========