builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-055 starttime: 1491331605.62 results: success (0) revision: 9cb970f15203dedce360ac31fa58625132c34533 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 11:46:45.619547) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 11:46:45.624070) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 11:46:45.624443) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 11:46:45.640102) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 11:46:45.640462) ========= 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=bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-04 11:46:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2017-04-04 11:46:46 (42.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119016 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 11:46:45.774118) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 11:46:45.774536) ========= 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=bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016878 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 11:46:45.824874) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 11:46:45.825254) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9cb970f15203dedce360ac31fa58625132c34533 --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 9cb970f15203dedce360ac31fa58625132c34533 --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=bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-04 11:46:46,185 truncating revision to first 12 chars 2017-04-04 11:46:46,185 Setting DEBUG logging. 2017-04-04 11:46:46,185 attempt 1/10 2017-04-04 11:46:46,185 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9cb970f15203?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-04 11:46:46,508 unpacking tar archive at: mozilla-central-9cb970f15203/testing/mozharness/ program finished with exit code 0 elapsedTime=0.637579 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 11:46:46.475914) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 11:46:46.476277) ========= script_repo_revision: 9cb970f15203dedce360ac31fa58625132c34533 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 11:46:46.476741) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 11:46:46.477056) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 11:46:46.486064) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-04-04 11:46:46.486449) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:46:46 INFO - MultiFileLogger online at 20170404 11:46:46 in /builds/slave/test 11:46:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:46:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:46:46 INFO - {'append_to_log': False, 11:46:46 INFO - 'base_work_dir': '/builds/slave/test', 11:46:46 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:46:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:46:46 INFO - 'branch': 'Firefox-Non-PGO', 11:46:46 INFO - 'buildbot_json_path': 'buildprops.json', 11:46:46 INFO - 'config_files': ('talos/linux_config.py',), 11:46:46 INFO - 'default_actions': ('clobber', 11:46:46 INFO - 'read-buildbot-config', 11:46:46 INFO - 'download-and-extract', 11:46:46 INFO - 'populate-webroot', 11:46:46 INFO - 'create-virtualenv', 11:46:46 INFO - 'install', 11:46:46 INFO - 'run-tests'), 11:46:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:46:46 INFO - 'download_minidump_stackwalk': True, 11:46:46 INFO - 'download_symbols': 'ondemand', 11:46:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:46:46 INFO - 'tooltool.py': '/tools/tooltool.py', 11:46:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:46:46 INFO - '/tools/misc-python/virtualenv.py')}, 11:46:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:46:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:46:46 INFO - 'gecko_profile': False, 11:46:46 INFO - 'gecko_profile_interval': 0, 11:46:46 INFO - 'installer_path': 'installer.exe', 11:46:46 INFO - 'log_level': 'info', 11:46:46 INFO - 'log_name': 'talos', 11:46:46 INFO - 'log_to_console': True, 11:46:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:46:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:46:46 INFO - 'opt_config_files': (), 11:46:46 INFO - 'pip_index': False, 11:46:46 INFO - 'suite': 'dromaeojs', 11:46:46 INFO - 'system_bits': '32', 11:46:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:46:46 INFO - 'title': 'talos-linux64-ix-055', 11:46:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:46:46 INFO - 'use_talos_json': True, 11:46:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:46:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:46:46 INFO - 'work_dir': 'build'} 11:46:46 INFO - [mozharness: 2017-04-04 18:46:46.943831Z] Running clobber step. 11:46:46 INFO - Running pre-action listener: _resource_record_pre_action 11:46:46 INFO - Running main action method: clobber 11:46:46 INFO - rmtree: /builds/slave/test/build 11:46:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:46:47 INFO - Running post-action listener: _resource_record_post_action 11:46:47 INFO - [mozharness: 2017-04-04 18:46:47.888546Z] Finished clobber step (success) 11:46:47 INFO - [mozharness: 2017-04-04 18:46:47.888646Z] Running read-buildbot-config step. 11:46:47 INFO - Running pre-action listener: _resource_record_pre_action 11:46:47 INFO - Running main action method: read_buildbot_config 11:46:47 INFO - Using buildbot properties: 11:46:47 INFO - { 11:46:47 INFO - "project": "", 11:46:47 INFO - "product": "firefox", 11:46:47 INFO - "who": "kwierso@gmail.com", 11:46:47 INFO - "installer_path": "public/build/target.tar.bz2", 11:46:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 11:46:47 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 11:46:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 11:46:47 INFO - "stage_platform": "linux64", 11:46:47 INFO - "basedir": "/builds/slave/test", 11:46:47 INFO - "buildnumber": 916, 11:46:47 INFO - "platform": "ubuntu64_hw", 11:46:47 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:46:47 INFO - "slavebuilddir": "test", 11:46:47 INFO - "taskId": "Wddk85dZTXe5eqRMfO5jFA", 11:46:47 INFO - "branch": "mozilla-central", 11:46:47 INFO - "script_repo_revision": "production", 11:46:47 INFO - "revision": "9cb970f15203dedce360ac31fa58625132c34533", 11:46:47 INFO - "slavename": "talos-linux64-ix-055", 11:46:47 INFO - "repo_path": "mozilla-central" 11:46:47 INFO - } 11:46:47 INFO - Finding installer, test and symbols from parent task. 11:46:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wddk85dZTXe5eqRMfO5jFA'}, attempt #1 11:46:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wddk85dZTXe5eqRMfO5jFA'}, attempt #1 11:46:48 INFO - Task dependencies: SNg9V_WgQVCpeEg5um3wdw 11:46:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SNg9V_WgQVCpeEg5um3wdw'}, attempt #1 11:46:49 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SNg9V_WgQVCpeEg5um3wdw/artifacts/public/build/target.tar.bz2 11:46:49 INFO - Set test_url: https://queue.taskcluster.net/v1/task/SNg9V_WgQVCpeEg5um3wdw/artifacts/public/build/test_packages.json 11:46:49 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SNg9V_WgQVCpeEg5um3wdw/artifacts/public/build/target.crashreporter-symbols.zip 11:46:49 INFO - Running post-action listener: _resource_record_post_action 11:46:49 INFO - [mozharness: 2017-04-04 18:46:49.292935Z] Finished read-buildbot-config step (success) 11:46:49 INFO - [mozharness: 2017-04-04 18:46:49.293153Z] Running download-and-extract step. 11:46:49 INFO - Running pre-action listener: _resource_record_pre_action 11:46:49 INFO - Running main action method: download_and_extract 11:46:49 INFO - mkdir: /builds/slave/test/build/tests 11:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:49 INFO - trying https://queue.taskcluster.net/v1/task/SNg9V_WgQVCpeEg5um3wdw/artifacts/public/build/target.test_packages.json 11:46:49 INFO - Downloading https://queue.taskcluster.net/v1/task/SNg9V_WgQVCpeEg5um3wdw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:46:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SNg9V_WgQVCpeEg5um3wdw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:46:49 INFO - Downloaded 986 bytes. 11:46:49 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:46:49 INFO - Using the following test package requirements: 11:46:49 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:46:49 INFO - u'common': [u'target.common.tests.zip'], 11:46:49 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:46:49 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:46:49 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:46:49 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:46:49 INFO - u'mozbase': [u'target.common.tests.zip'], 11:46:49 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:46:49 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:46:49 INFO - u'web-platform': [u'target.common.tests.zip', 11:46:49 INFO - u'target.web-platform.tests.zip'], 11:46:49 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:46:49 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:46:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SNg9V_WgQVCpeEg5um3wdw/artifacts/public/build/target.common.tests.zip 11:46:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SNg9V_WgQVCpeEg5um3wdw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:46:49 INFO - Fetch https://queue.taskcluster.net/v1/task/SNg9V_WgQVCpeEg5um3wdw/artifacts/public/build/target.common.tests.zip into memory 11:46:50 INFO - Expected file size: 58237904 11:46:50 INFO - Obtained file size: 58237904 11:47:00 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:47:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SNg9V_WgQVCpeEg5um3wdw/artifacts/public/build/target.common.tests.zip 11:47:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SNg9V_WgQVCpeEg5um3wdw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:47:00 INFO - Fetch https://queue.taskcluster.net/v1/task/SNg9V_WgQVCpeEg5um3wdw/artifacts/public/build/target.common.tests.zip into memory 11:47:01 INFO - Expected file size: 58237904 11:47:01 INFO - Obtained file size: 58237904 11:47:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SNg9V_WgQVCpeEg5um3wdw/artifacts/public/build/target.talos.tests.zip 11:47:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SNg9V_WgQVCpeEg5um3wdw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:47:12 INFO - Fetch https://queue.taskcluster.net/v1/task/SNg9V_WgQVCpeEg5um3wdw/artifacts/public/build/target.talos.tests.zip into memory 11:47:13 INFO - Expected file size: 14404152 11:47:13 INFO - Obtained file size: 14404152 11:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:13 INFO - trying https://queue.taskcluster.net/v1/task/SNg9V_WgQVCpeEg5um3wdw/artifacts/public/build/target.tar.bz2 11:47:13 INFO - Downloading https://queue.taskcluster.net/v1/task/SNg9V_WgQVCpeEg5um3wdw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:47:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SNg9V_WgQVCpeEg5um3wdw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:47:16 INFO - Downloaded 57620857 bytes. 11:47:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SNg9V_WgQVCpeEg5um3wdw/artifacts/public/build/target.tar.bz2 11:47:16 INFO - mkdir: /builds/slave/test/properties 11:47:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:47:16 INFO - Writing to file /builds/slave/test/properties/build_url 11:47:16 INFO - Contents: 11:47:16 INFO - build_url:https://queue.taskcluster.net/v1/task/SNg9V_WgQVCpeEg5um3wdw/artifacts/public/build/target.tar.bz2 11:47:16 INFO - Running post-action listener: _resource_record_post_action 11:47:16 INFO - Running post-action listener: set_extra_try_arguments 11:47:16 INFO - [mozharness: 2017-04-04 18:47:16.114634Z] Finished download-and-extract step (success) 11:47:16 INFO - [mozharness: 2017-04-04 18:47:16.114732Z] Running populate-webroot step. 11:47:16 INFO - Running pre-action listener: _resource_record_pre_action 11:47:16 INFO - Running main action method: populate_webroot 11:47:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:47:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:47:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:47:16 INFO - '--tppagecycles', 11:47:16 INFO - '7'], 11:47:16 INFO - 'tests': ['tsvgm']}}, 11:47:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:47:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:47:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:47:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:47:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:47:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:47:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:47:16 INFO - 'talos_options': ['--disable-e10s'], 11:47:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:47:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:47:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:47:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:47:16 INFO - 'talos_options': ['--disable-e10s'], 11:47:16 INFO - 'tests': ['damp', 'tps']}, 11:47:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:47:16 INFO - 'tests': ['damp', 'tps']}, 11:47:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:47:16 INFO - 'tests': ['dromaeo_dom']}, 11:47:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:47:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:47:16 INFO - 'tests': ['basic_compositor_video']}, 11:47:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:47:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:47:16 INFO - 'tests': ['a11yr', 11:47:16 INFO - 'ts_paint', 11:47:16 INFO - 'tpaint', 11:47:16 INFO - 'sessionrestore', 11:47:16 INFO - 'sessionrestore_no_auto_restore', 11:47:16 INFO - 'tabpaint']}, 11:47:16 INFO - 'other-e10s': {'tests': ['a11yr', 11:47:16 INFO - 'ts_paint', 11:47:16 INFO - 'tpaint', 11:47:16 INFO - 'sessionrestore', 11:47:16 INFO - 'sessionrestore_no_auto_restore', 11:47:16 INFO - 'tabpaint']}, 11:47:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:47:16 INFO - 'ts_paint', 11:47:16 INFO - 'tpaint', 11:47:16 INFO - 'sessionrestore', 11:47:16 INFO - 'sessionrestore_no_auto_restore', 11:47:16 INFO - 'tabpaint']}, 11:47:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:47:16 INFO - 'ts_paint', 11:47:16 INFO - 'tpaint', 11:47:16 INFO - 'sessionrestore', 11:47:16 INFO - 'sessionrestore_no_auto_restore', 11:47:16 INFO - 'tabpaint']}, 11:47:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:47:16 INFO - 'tests': ['a11yr', 11:47:16 INFO - 'ts_paint', 11:47:16 INFO - 'tpaint', 11:47:16 INFO - 'sessionrestore', 11:47:16 INFO - 'sessionrestore_no_auto_restore', 11:47:16 INFO - 'tabpaint']}, 11:47:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:47:16 INFO - 'tests': ['a11yr', 11:47:16 INFO - 'ts_paint', 11:47:16 INFO - 'tpaint', 11:47:16 INFO - 'sessionrestore', 11:47:16 INFO - 'sessionrestore_no_auto_restore', 11:47:16 INFO - 'tabpaint']}, 11:47:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:47:16 INFO - 'tests': ['tsvgx', 11:47:16 INFO - 'tsvgr_opacity', 11:47:16 INFO - 'tart', 11:47:16 INFO - 'tscrollx', 11:47:16 INFO - 'cart', 11:47:16 INFO - 'tsvg_static']}, 11:47:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:47:16 INFO - 'tsvgr_opacity', 11:47:16 INFO - 'tart', 11:47:16 INFO - 'tscrollx', 11:47:16 INFO - 'cart', 11:47:16 INFO - 'tsvg_static']}, 11:47:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:47:16 INFO - 'talos_options': ['--disable-e10s'], 11:47:16 INFO - 'tests': ['tp5o']}, 11:47:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:47:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:47:16 INFO - 'talos_options': ['--disable-e10s', 11:47:16 INFO - '--xperf_path', 11:47:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:47:16 INFO - 'tests': ['tp5n']}, 11:47:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:47:16 INFO - 'talos_options': ['--xperf_path', 11:47:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:47:16 INFO - 'tests': ['tp5n']}}, 11:47:16 INFO - 'talos.zip': {'path': '', 11:47:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:47:16 INFO - Running post-action listener: _resource_record_post_action 11:47:16 INFO - [mozharness: 2017-04-04 18:47:16.128143Z] Finished populate-webroot step (success) 11:47:16 INFO - [mozharness: 2017-04-04 18:47:16.128250Z] Running create-virtualenv step. 11:47:16 INFO - Running pre-action listener: _resource_record_pre_action 11:47:16 INFO - Running main action method: create_virtualenv 11:47:16 INFO - Creating virtualenv /builds/slave/test/build/venv 11:47:16 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 11:47:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:47:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:47:16 INFO - Using real prefix '/usr' 11:47:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:47:16 INFO - Installing distribute.............................................................................................................................................................................................done. 11:47:18 INFO - Installing pip.................done. 11:47:18 INFO - Return code: 0 11:47:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:47:18 INFO - Reading from file tmpfile_stdout 11:47:18 INFO - Output received: 11:47:18 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) 11:47:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:47:18 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')]} 11:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:18 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')]} 11:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:18 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 0x2a701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d0db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0b290>, '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 0x2d0bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0c040>, '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': 'bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970', '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 11:47:18 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 11:47:18 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 11:47:18 INFO - Using env: {'DISPLAY': ':0', 11:47:18 INFO - 'HOME': '/home/cltbld', 11:47:18 INFO - 'LANG': 'en_US.UTF-8', 11:47:18 INFO - 'LANGUAGE': 'en_US:en', 11:47:18 INFO - 'LOGNAME': 'cltbld', 11:47:18 INFO - 'MAIL': '/var/mail/cltbld', 11:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:18 INFO - 'MOZ_NO_REMOTE': '1', 11:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:18 INFO - 'NO_EM_RESTART': '1', 11:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:18 INFO - 'PWD': '/builds/slave/test', 11:47:18 INFO - 'SHELL': '/bin/bash', 11:47:18 INFO - 'SHLVL': '1', 11:47:18 INFO - 'TERM': 'linux', 11:47:18 INFO - 'TMOUT': '86400', 11:47:18 INFO - 'USER': 'cltbld', 11:47:18 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970', 11:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:18 INFO - '_': '/tools/buildbot/bin/python'} 11:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:19 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 11:47:19 INFO - Cleaning up... 11:47:19 INFO - Return code: 0 11:47:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:47:19 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')]} 11:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:19 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')]} 11:47:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:19 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 0x2a701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d0db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0b290>, '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 0x2d0bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0c040>, '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': 'bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970', '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 11:47:19 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 11:47:19 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 11:47:19 INFO - Using env: {'DISPLAY': ':0', 11:47:19 INFO - 'HOME': '/home/cltbld', 11:47:19 INFO - 'LANG': 'en_US.UTF-8', 11:47:19 INFO - 'LANGUAGE': 'en_US:en', 11:47:19 INFO - 'LOGNAME': 'cltbld', 11:47:19 INFO - 'MAIL': '/var/mail/cltbld', 11:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:19 INFO - 'MOZ_NO_REMOTE': '1', 11:47:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:19 INFO - 'NO_EM_RESTART': '1', 11:47:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:19 INFO - 'PWD': '/builds/slave/test', 11:47:19 INFO - 'SHELL': '/bin/bash', 11:47:19 INFO - 'SHLVL': '1', 11:47:19 INFO - 'TERM': 'linux', 11:47:19 INFO - 'TMOUT': '86400', 11:47:19 INFO - 'USER': 'cltbld', 11:47:19 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970', 11:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:19 INFO - '_': '/tools/buildbot/bin/python'} 11:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:19 INFO - Downloading/unpacking psutil>=3.1.1 11:47:19 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 11:47:19 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 11:47:19 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 11:47:19 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 11:47:19 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 11:47:19 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 11:47:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:47:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:47:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:47:21 INFO - Installing collected packages: psutil 11:47:21 INFO - Running setup.py install for psutil 11:47:21 INFO - building 'psutil._psutil_linux' extension 11:47:21 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 11:47:21 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 11:47:21 INFO - building 'psutil._psutil_posix' extension 11:47:21 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 11:47:21 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 11:47:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:47:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:47:21 INFO - Successfully installed psutil 11:47:21 INFO - Cleaning up... 11:47:22 INFO - Return code: 0 11:47:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:47: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')]} 11:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47: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')]} 11:47:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:22 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 0x2a701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d0db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0b290>, '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 0x2d0bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0c040>, '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': 'bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970', '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 11:47:22 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 11:47:22 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 11:47:22 INFO - Using env: {'DISPLAY': ':0', 11:47:22 INFO - 'HOME': '/home/cltbld', 11:47:22 INFO - 'LANG': 'en_US.UTF-8', 11:47:22 INFO - 'LANGUAGE': 'en_US:en', 11:47:22 INFO - 'LOGNAME': 'cltbld', 11:47:22 INFO - 'MAIL': '/var/mail/cltbld', 11:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:22 INFO - 'MOZ_NO_REMOTE': '1', 11:47:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:22 INFO - 'NO_EM_RESTART': '1', 11:47:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:22 INFO - 'PWD': '/builds/slave/test', 11:47:22 INFO - 'SHELL': '/bin/bash', 11:47:22 INFO - 'SHLVL': '1', 11:47:22 INFO - 'TERM': 'linux', 11:47:22 INFO - 'TMOUT': '86400', 11:47:22 INFO - 'USER': 'cltbld', 11:47:22 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970', 11:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:22 INFO - '_': '/tools/buildbot/bin/python'} 11:47:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:47:22 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 11:47:22 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 11:47:22 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 11:47:22 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 11:47:22 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 11:47:22 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 11:47:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:47:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:47:24 INFO - Installing collected packages: mozsystemmonitor 11:47:24 INFO - Running setup.py install for mozsystemmonitor 11:47:24 INFO - Successfully installed mozsystemmonitor 11:47:24 INFO - Cleaning up... 11:47:24 INFO - Return code: 0 11:47:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:47:24 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')]} 11:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:24 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')]} 11:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:24 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 0x2a701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d0db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0b290>, '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 0x2d0bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0c040>, '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': 'bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970', '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 11:47:24 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 11:47:24 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 11:47:24 INFO - Using env: {'DISPLAY': ':0', 11:47:24 INFO - 'HOME': '/home/cltbld', 11:47:24 INFO - 'LANG': 'en_US.UTF-8', 11:47:24 INFO - 'LANGUAGE': 'en_US:en', 11:47:24 INFO - 'LOGNAME': 'cltbld', 11:47:24 INFO - 'MAIL': '/var/mail/cltbld', 11:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:24 INFO - 'MOZ_NO_REMOTE': '1', 11:47:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:24 INFO - 'NO_EM_RESTART': '1', 11:47:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:24 INFO - 'PWD': '/builds/slave/test', 11:47:24 INFO - 'SHELL': '/bin/bash', 11:47:24 INFO - 'SHLVL': '1', 11:47:24 INFO - 'TERM': 'linux', 11:47:24 INFO - 'TMOUT': '86400', 11:47:24 INFO - 'USER': 'cltbld', 11:47:24 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970', 11:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:24 INFO - '_': '/tools/buildbot/bin/python'} 11:47:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:24 INFO - Downloading/unpacking jsonschema==2.5.1 11:47:24 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 11:47:24 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 11:47:24 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 11:47:24 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 11:47:24 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 11:47:24 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 11:47:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:47:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:47:26 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 11:47:26 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 11:47:26 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 11:47:26 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 11:47:26 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 11:47:26 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 11:47:27 INFO - Downloading functools32-3.2.3-2.tar.gz 11:47:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:47:27 INFO - warning: no files found matching '*.txt' 11:47:27 INFO - no previously-included directories found matching 'build' 11:47:27 INFO - no previously-included directories found matching 'dist' 11:47:27 INFO - no previously-included directories found matching '.git*' 11:47:27 INFO - Installing collected packages: jsonschema, functools32 11:47:27 INFO - Running setup.py install for functools32 11:47:27 INFO - warning: no files found matching '*.txt' 11:47:27 INFO - no previously-included directories found matching 'build' 11:47:27 INFO - no previously-included directories found matching 'dist' 11:47:27 INFO - no previously-included directories found matching '.git*' 11:47:27 INFO - Successfully installed jsonschema functools32 11:47:27 INFO - Cleaning up... 11:47:27 INFO - Return code: 0 11:47:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2a701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d0db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0b290>, '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 0x2d0bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0c040>, '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': 'bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970', '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 11:47:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:47:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:47:27 INFO - Using env: {'DISPLAY': ':0', 11:47:27 INFO - 'HOME': '/home/cltbld', 11:47:27 INFO - 'LANG': 'en_US.UTF-8', 11:47:27 INFO - 'LANGUAGE': 'en_US:en', 11:47:27 INFO - 'LOGNAME': 'cltbld', 11:47:27 INFO - 'MAIL': '/var/mail/cltbld', 11:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:27 INFO - 'MOZ_NO_REMOTE': '1', 11:47:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:27 INFO - 'NO_EM_RESTART': '1', 11:47:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:27 INFO - 'PWD': '/builds/slave/test', 11:47:27 INFO - 'SHELL': '/bin/bash', 11:47:27 INFO - 'SHLVL': '1', 11:47:27 INFO - 'TERM': 'linux', 11:47:27 INFO - 'TMOUT': '86400', 11:47:27 INFO - 'USER': 'cltbld', 11:47:27 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970', 11:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:27 INFO - '_': '/tools/buildbot/bin/python'} 11:47:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:47:27 INFO - Cleaning up... 11:47:27 INFO - Return code: 0 11:47:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2a701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d0db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0b290>, '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 0x2d0bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0c040>, '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': 'bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970', '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 11:47:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:47:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:47:27 INFO - Using env: {'DISPLAY': ':0', 11:47:27 INFO - 'HOME': '/home/cltbld', 11:47:27 INFO - 'LANG': 'en_US.UTF-8', 11:47:27 INFO - 'LANGUAGE': 'en_US:en', 11:47:27 INFO - 'LOGNAME': 'cltbld', 11:47:27 INFO - 'MAIL': '/var/mail/cltbld', 11:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:27 INFO - 'MOZ_NO_REMOTE': '1', 11:47:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:27 INFO - 'NO_EM_RESTART': '1', 11:47:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:27 INFO - 'PWD': '/builds/slave/test', 11:47:27 INFO - 'SHELL': '/bin/bash', 11:47:27 INFO - 'SHLVL': '1', 11:47:27 INFO - 'TERM': 'linux', 11:47:27 INFO - 'TMOUT': '86400', 11:47:27 INFO - 'USER': 'cltbld', 11:47:27 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970', 11:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:27 INFO - '_': '/tools/buildbot/bin/python'} 11:47:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:27 INFO - Downloading/unpacking blobuploader==1.2.4 11:47: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 11:47: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 11:47: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 11:47: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 11:47: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 11:47: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 11:47:29 INFO - Downloading blobuploader-1.2.4.tar.gz 11:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:47:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:47: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 11:47: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 11:47: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 11:47: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 11:47: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 11:47: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 11:47:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:47:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:47: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 11:47: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 11:47: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 11:47: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 11:47: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 11:47: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 11:47:30 INFO - Downloading docopt-0.6.1.tar.gz 11:47:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:47:30 INFO - Installing collected packages: blobuploader, requests, docopt 11:47:30 INFO - Running setup.py install for blobuploader 11:47:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:47:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:47:30 INFO - Running setup.py install for requests 11:47:31 INFO - Running setup.py install for docopt 11:47:31 INFO - Successfully installed blobuploader requests docopt 11:47:31 INFO - Cleaning up... 11:47:31 INFO - Return code: 0 11:47:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:31 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 0x2a701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d0db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0b290>, '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 0x2d0bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0c040>, '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': 'bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970', '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 11:47:31 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 11:47:31 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 11:47:31 INFO - Using env: {'DISPLAY': ':0', 11:47:31 INFO - 'HOME': '/home/cltbld', 11:47:31 INFO - 'LANG': 'en_US.UTF-8', 11:47:31 INFO - 'LANGUAGE': 'en_US:en', 11:47:31 INFO - 'LOGNAME': 'cltbld', 11:47:31 INFO - 'MAIL': '/var/mail/cltbld', 11:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:31 INFO - 'MOZ_NO_REMOTE': '1', 11:47:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:31 INFO - 'NO_EM_RESTART': '1', 11:47:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:31 INFO - 'PWD': '/builds/slave/test', 11:47:31 INFO - 'SHELL': '/bin/bash', 11:47:31 INFO - 'SHLVL': '1', 11:47:31 INFO - 'TERM': 'linux', 11:47:31 INFO - 'TMOUT': '86400', 11:47:31 INFO - 'USER': 'cltbld', 11:47:31 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970', 11:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:31 INFO - '_': '/tools/buildbot/bin/python'} 11:47:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:47:31 INFO - Running setup.py (path:/tmp/pip-oatZAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:47:31 INFO - Running setup.py (path:/tmp/pip-wBGTGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:47:31 INFO - Running setup.py (path:/tmp/pip-3UZ8p0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:47:31 INFO - Running setup.py (path:/tmp/pip-YoOCEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:47:31 INFO - Running setup.py (path:/tmp/pip-zjytfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:47:31 INFO - Running setup.py (path:/tmp/pip-7ppDGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:47:31 INFO - Running setup.py (path:/tmp/pip-3P0kH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:47:31 INFO - Running setup.py (path:/tmp/pip-f9yoOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:47:32 INFO - Running setup.py (path:/tmp/pip-mJxa9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:47:32 INFO - Running setup.py (path:/tmp/pip-LLE7SC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:47:32 INFO - Running setup.py (path:/tmp/pip-pl65qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:47:32 INFO - Running setup.py (path:/tmp/pip-Bf5o_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:47:32 INFO - Running setup.py (path:/tmp/pip-a4uQXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:47:32 INFO - Running setup.py (path:/tmp/pip-GGpe9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:32 INFO - Running setup.py (path:/tmp/pip-6qt6jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:47:32 INFO - Running setup.py (path:/tmp/pip-PhiuyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:47:32 INFO - Running setup.py (path:/tmp/pip-ftqXrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:47:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:47:32 INFO - Running setup.py install for manifestparser 11:47:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:47:32 INFO - Running setup.py install for mozcrash 11:47:32 INFO - Running setup.py install for mozdebug 11:47:32 INFO - Running setup.py install for mozdevice 11:47:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:47:33 INFO - Running setup.py install for mozfile 11:47:33 INFO - Running setup.py install for mozhttpd 11:47:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:47:33 INFO - Running setup.py install for mozinfo 11:47:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:47:33 INFO - Running setup.py install for mozInstall 11:47:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:47:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:47:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:47:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:47:33 INFO - Running setup.py install for mozleak 11:47:33 INFO - Running setup.py install for mozlog 11:47:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:47:33 INFO - Running setup.py install for moznetwork 11:47:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:47:33 INFO - Running setup.py install for mozprocess 11:47:33 INFO - Running setup.py install for mozprofile 11:47:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:47:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:47:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:47:34 INFO - Running setup.py install for mozrunner 11:47:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:47:34 INFO - Running setup.py install for mozscreenshot 11:47:34 INFO - Running setup.py install for moztest 11:47:34 INFO - Running setup.py install for mozversion 11:47:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:47:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:47:34 INFO - Cleaning up... 11:47:34 INFO - Return code: 0 11:47:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:47: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')]} 11:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47: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')]} 11:47:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:34 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 0x2a701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d0db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0b290>, '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 0x2d0bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0c040>, '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': 'bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970', '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 11:47:34 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 11:47:34 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 11:47:34 INFO - Using env: {'DISPLAY': ':0', 11:47:34 INFO - 'HOME': '/home/cltbld', 11:47:34 INFO - 'LANG': 'en_US.UTF-8', 11:47:34 INFO - 'LANGUAGE': 'en_US:en', 11:47:34 INFO - 'LOGNAME': 'cltbld', 11:47:34 INFO - 'MAIL': '/var/mail/cltbld', 11:47:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:34 INFO - 'MOZ_NO_REMOTE': '1', 11:47:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:34 INFO - 'NO_EM_RESTART': '1', 11:47:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:34 INFO - 'PWD': '/builds/slave/test', 11:47:34 INFO - 'SHELL': '/bin/bash', 11:47:34 INFO - 'SHLVL': '1', 11:47:34 INFO - 'TERM': 'linux', 11:47:34 INFO - 'TMOUT': '86400', 11:47:34 INFO - 'USER': 'cltbld', 11:47:34 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970', 11:47:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:34 INFO - '_': '/tools/buildbot/bin/python'} 11:47:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:47:34 INFO - Running setup.py (path:/tmp/pip-IfkOs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:47:34 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)) 11:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:47:34 INFO - Running setup.py (path:/tmp/pip-nOVYm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:47:34 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)) 11:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:47:34 INFO - Running setup.py (path:/tmp/pip-a9sooD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:47:34 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)) 11:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:47:34 INFO - Running setup.py (path:/tmp/pip-xOnV2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:47:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:47:34 INFO - Running setup.py (path:/tmp/pip-QIBuWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:47:35 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)) 11:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:47:35 INFO - Running setup.py (path:/tmp/pip-gMVyuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:47:35 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)) 11:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:47:35 INFO - Running setup.py (path:/tmp/pip-gNDWHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:47:35 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)) 11:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:47:35 INFO - Running setup.py (path:/tmp/pip-tUIlNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:47:35 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)) 11:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:47:35 INFO - Running setup.py (path:/tmp/pip-30rCPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:47:35 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)) 11:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:47:35 INFO - Running setup.py (path:/tmp/pip-VarW1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:47:35 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)) 11:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:47:35 INFO - Running setup.py (path:/tmp/pip-3tn77M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:47:35 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)) 11:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:47:35 INFO - Running setup.py (path:/tmp/pip-Qvy8sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:47:35 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)) 11:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:47:35 INFO - Running setup.py (path:/tmp/pip-MaznYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:47:35 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)) 11:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:47:35 INFO - Running setup.py (path:/tmp/pip-Geih2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:47:35 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)) 11:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:35 INFO - Running setup.py (path:/tmp/pip-ZUbjpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:35 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)) 11:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:47:35 INFO - Running setup.py (path:/tmp/pip-Mzl6v2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:47:35 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)) 11:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:47:35 INFO - Running setup.py (path:/tmp/pip-DSSNCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:47:35 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)) 11:47:35 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)) 11:47:35 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)) 11:47:35 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)) 11:47:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:47:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:47:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:47:35 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 11:47:35 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 11:47:35 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 11:47:35 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 11:47:35 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 11:47:35 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 11:47:37 INFO - Downloading blessings-1.6.tar.gz 11:47:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:47:38 INFO - Installing collected packages: blessings 11:47:38 INFO - Running setup.py install for blessings 11:47:38 INFO - Successfully installed blessings 11:47:38 INFO - Cleaning up... 11:47:38 INFO - Return code: 0 11:47:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:47:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:47:38 INFO - Reading from file tmpfile_stdout 11:47:38 INFO - Current package versions: 11:47:38 INFO - argparse == 1.2.1 11:47:38 INFO - blessings == 1.6 11:47:38 INFO - blobuploader == 1.2.4 11:47:38 INFO - docopt == 0.6.1 11:47:38 INFO - functools32 == 3.2.3-2 11:47:38 INFO - jsonschema == 2.5.1 11:47:38 INFO - manifestparser == 1.1 11:47:38 INFO - mozInstall == 1.12 11:47:38 INFO - mozcrash == 1.0 11:47:38 INFO - mozdebug == 0.1 11:47:38 INFO - mozdevice == 0.49 11:47:38 INFO - mozfile == 1.2 11:47:38 INFO - mozhttpd == 0.7 11:47:38 INFO - mozinfo == 0.9 11:47:38 INFO - mozleak == 0.1 11:47:38 INFO - mozlog == 3.4 11:47:38 INFO - moznetwork == 0.27 11:47:38 INFO - mozprocess == 0.25 11:47:38 INFO - mozprofile == 0.28 11:47:38 INFO - mozrunner == 6.13 11:47:38 INFO - mozscreenshot == 0.1 11:47:38 INFO - mozsystemmonitor == 0.3 11:47:38 INFO - moztest == 0.8 11:47:38 INFO - mozversion == 1.4 11:47:38 INFO - psutil == 3.1.1 11:47:38 INFO - requests == 1.2.3 11:47:38 INFO - wsgiref == 0.1.2 11:47:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:47: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')]} 11:47:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47: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')]} 11:47:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:38 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 0x2a701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d0db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0b290>, '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 0x2d0bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0c040>, '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': 'bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970', '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 11:47:38 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 11:47:38 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 11:47:38 INFO - Using env: {'DISPLAY': ':0', 11:47:38 INFO - 'HOME': '/home/cltbld', 11:47:38 INFO - 'LANG': 'en_US.UTF-8', 11:47:38 INFO - 'LANGUAGE': 'en_US:en', 11:47:38 INFO - 'LOGNAME': 'cltbld', 11:47:38 INFO - 'MAIL': '/var/mail/cltbld', 11:47:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:38 INFO - 'MOZ_NO_REMOTE': '1', 11:47:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:38 INFO - 'NO_EM_RESTART': '1', 11:47:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:38 INFO - 'PWD': '/builds/slave/test', 11:47:38 INFO - 'SHELL': '/bin/bash', 11:47:38 INFO - 'SHLVL': '1', 11:47:38 INFO - 'TERM': 'linux', 11:47:38 INFO - 'TMOUT': '86400', 11:47:38 INFO - 'USER': 'cltbld', 11:47:38 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970', 11:47:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:38 INFO - '_': '/tools/buildbot/bin/python'} 11:47:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:38 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)) 11:47:38 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)) 11:47:38 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)) 11:47:38 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)) 11:47:38 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)) 11:47:38 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)) 11:47:38 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)) 11:47:38 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)) 11:47:38 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)) 11:47:38 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)) 11:47:38 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)) 11:47:38 INFO - Cleaning up... 11:47:38 INFO - Return code: 0 11:47:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:47: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')]} 11:47:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47: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')]} 11:47:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:38 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 0x2a701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d0db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0b290>, '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 0x2d0bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0c040>, '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': 'bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970', '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 11:47:38 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 11:47:38 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 11:47:38 INFO - Using env: {'DISPLAY': ':0', 11:47:38 INFO - 'HOME': '/home/cltbld', 11:47:38 INFO - 'LANG': 'en_US.UTF-8', 11:47:38 INFO - 'LANGUAGE': 'en_US:en', 11:47:38 INFO - 'LOGNAME': 'cltbld', 11:47:38 INFO - 'MAIL': '/var/mail/cltbld', 11:47:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:38 INFO - 'MOZ_NO_REMOTE': '1', 11:47:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:38 INFO - 'NO_EM_RESTART': '1', 11:47:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:38 INFO - 'PWD': '/builds/slave/test', 11:47:38 INFO - 'SHELL': '/bin/bash', 11:47:38 INFO - 'SHLVL': '1', 11:47:38 INFO - 'TERM': 'linux', 11:47:38 INFO - 'TMOUT': '86400', 11:47:38 INFO - 'USER': 'cltbld', 11:47:38 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970', 11:47:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:38 INFO - '_': '/tools/buildbot/bin/python'} 11:47:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:47:38 INFO - Cleaning up... 11:47:38 INFO - Return code: 0 11:47:38 INFO - Running post-action listener: _resource_record_post_action 11:47:38 INFO - Running post-action listener: _start_resource_monitoring 11:47:38 INFO - Starting resource monitoring. 11:47:38 INFO - [mozharness: 2017-04-04 18:47:38.966522Z] Finished create-virtualenv step (success) 11:47:38 INFO - [mozharness: 2017-04-04 18:47:38.967032Z] Running install step. 11:47:38 INFO - Running pre-action listener: _resource_record_pre_action 11:47:38 INFO - Running main action method: install 11:47:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:47:39 INFO - Reading from file tmpfile_stdout 11:47:39 INFO - Detecting whether we're running mozinstall >=1.0... 11:47:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:47:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:47:39 INFO - Reading from file tmpfile_stdout 11:47:39 INFO - Output received: 11:47:39 INFO - Usage: mozinstall [options] installer 11:47:39 INFO - Options: 11:47:39 INFO - -h, --help show this help message and exit 11:47:39 INFO - -d DEST, --destination=DEST 11:47:39 INFO - Directory to install application into. [default: 11:47:39 INFO - "/builds/slave/test"] 11:47:39 INFO - --app=APP Application being installed. [default: firefox] 11:47:39 INFO - mkdir: /builds/slave/test/build/application 11:47:39 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'] 11:47:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:47:54 INFO - Reading from file tmpfile_stdout 11:47:54 INFO - Output received: 11:47:54 INFO - /builds/slave/test/build/application/firefox/firefox 11:47:54 INFO - Running post-action listener: _resource_record_post_action 11:47:54 INFO - [mozharness: 2017-04-04 18:47:54.002812Z] Finished install step (success) 11:47:54 INFO - [mozharness: 2017-04-04 18:47:54.003089Z] Running run-tests step. 11:47:54 INFO - Running pre-action listener: _resource_record_pre_action 11:47:54 INFO - Running main action method: run_tests 11:47:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:47:54 INFO - Python 2.7.3 11:47:54 INFO - Return code: 0 11:47:54 INFO - grabbing minidump binary from tooltool 11:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:54 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 0x2d0b290>, '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 0x2d0bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0c040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:47:54 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 11:47:54 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 11:47:54 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 11:47:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:47:54 INFO - Return code: 0 11:47:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:47:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:47:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:47:54 INFO - ENV: RUST_BACKTRACE is now 1 11:47:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:47:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:47:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SNg9V_WgQVCpeEg5um3wdw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 11:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SNg9V_WgQVCpeEg5um3wdw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 11:47:54 INFO - Using env: {'DISPLAY': ':0', 11:47:54 INFO - 'HOME': '/home/cltbld', 11:47:54 INFO - 'LANG': 'en_US.UTF-8', 11:47:54 INFO - 'LANGUAGE': 'en_US:en', 11:47:54 INFO - 'LOGNAME': 'cltbld', 11:47:54 INFO - 'MAIL': '/var/mail/cltbld', 11:47:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:47:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:54 INFO - 'MOZ_NO_REMOTE': '1', 11:47:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:54 INFO - 'NO_EM_RESTART': '1', 11:47:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:54 INFO - 'PWD': '/builds/slave/test', 11:47:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:47:54 INFO - 'RUST_BACKTRACE': '1', 11:47:54 INFO - 'SHELL': '/bin/bash', 11:47:54 INFO - 'SHLVL': '1', 11:47:54 INFO - 'TERM': 'linux', 11:47:54 INFO - 'TMOUT': '86400', 11:47:54 INFO - 'USER': 'cltbld', 11:47:54 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970', 11:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:54 INFO - '_': '/tools/buildbot/bin/python'} 11:47:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SNg9V_WgQVCpeEg5um3wdw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 11:47:54 INFO - mozversion application_buildid: 20170404181812 11:47:54 INFO - mozversion application_changeset: 9cb970f15203dedce360ac31fa58625132c34533 11:47:54 INFO - mozversion application_display_name: Nightly 11:47:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:47:54 INFO - mozversion application_name: Firefox 11:47:54 INFO - mozversion application_remotingname: firefox 11:47:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:47:54 INFO - mozversion application_vendor: Mozilla 11:47:54 INFO - mozversion application_version: 55.0a1 11:47:54 INFO - mozversion platform_buildid: 20170404181812 11:47:54 INFO - mozversion platform_changeset: 9cb970f15203dedce360ac31fa58625132c34533 11:47:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:47:54 INFO - mozversion platform_version: 55.0a1 11:47:54 INFO - using testdate: 1491331674 11:47:54 INFO - actual date: 1491331674 11:47:54 INFO - starting webserver on 'localhost:57761' 11:47:54 INFO - SUITE-START | Running 2 tests 11:47:54 INFO - TEST-START | dromaeo_css 11:47:54 INFO - operating with platform_type : linux_ 11:47:54 INFO - Initialising browser for dromaeo_css test... 11:47:54 INFO - TEST-INFO | started process 8835 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWzPJCz/profile http://localhost:57761/getInfo.html) 11:47:58 INFO - PID 8835 | __metrics Screen width/height:1600/1200 11:47:58 INFO - PID 8835 | colorDepth:24 11:47:58 INFO - PID 8835 | Browser inner width/height: 1024/697 11:47:58 INFO - PID 8835 | __metrics 11:47:59 INFO - PID 8835 | 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" 11:47:59 INFO - PID 8835 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:48:00 INFO - TEST-INFO | 8835: exit 0 11:48:00 INFO - Browser initialized. 11:48:00 INFO - Running cycle 1/1 for dromaeo_css test... 11:48:00 INFO - TEST-INFO | started process 8929 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWzPJCz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:48:12 INFO - PID 8929 | RSS: Main: 154378240 11:48:12 INFO - PID 8929 | 11:51:20 INFO - PID 8929 | Cycle 1(1): loaded http://localhost:57761/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57761/tests/dromaeo/cssquery-ext.html) 11:51:22 INFO - PID 8929 | RSS: Main: 247513088 11:51:22 INFO - PID 8929 | 11:53:02 INFO - PID 8929 | ************************* 11:53:02 INFO - PID 8929 | A coding exception was thrown and uncaught in a Task. 11:53:02 INFO - PID 8929 | 11:53:02 ERROR - PID 8929 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:53:02 INFO - PID 8929 | Full stack: 11:53:02 INFO - PID 8929 | ************************* 11:53:02 INFO - PID 8929 | ************************* 11:53:02 INFO - PID 8929 | A coding exception was thrown and uncaught in a Task. 11:53:02 INFO - PID 8929 | 11:53:02 ERROR - PID 8929 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:53:02 INFO - PID 8929 | Full stack: 11:53:02 INFO - PID 8929 | ************************* 11:53:02 INFO - PID 8929 | ************************* 11:53:02 INFO - PID 8929 | A coding exception was thrown and uncaught in a Task. 11:53:02 INFO - PID 8929 | 11:53:02 ERROR - PID 8929 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:53:02 INFO - PID 8929 | Full stack: 11:53:02 INFO - PID 8929 | ************************* 11:53:02 INFO - PID 8929 | ************************* 11:53:02 INFO - PID 8929 | A coding exception was thrown and uncaught in a Task. 11:53:02 INFO - PID 8929 | 11:53:02 ERROR - PID 8929 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:53:02 INFO - PID 8929 | Full stack: 11:53:02 INFO - PID 8929 | ************************* 11:54:24 INFO - PID 8929 | Cycle 1(1): loaded http://localhost:57761/tests/dromaeo/cssquery-ext.html (next: http://localhost:57761/tests/dromaeo/cssquery-jquery.html) 11:54:24 INFO - PID 8929 | RSS: Main: 239370240 11:54:24 INFO - PID 8929 | 11:57:27 INFO - PID 8929 | Cycle 1(1): loaded http://localhost:57761/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57761/tests/dromaeo/cssquery-mootools.html) 11:57:27 INFO - PID 8929 | RSS: Main: 178716672 11:57:27 INFO - PID 8929 | 12:00:29 INFO - PID 8929 | Cycle 1(1): loaded http://localhost:57761/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57761/tests/dromaeo/cssquery-prototype.html) 12:00:30 INFO - PID 8929 | RSS: Main: 217378816 12:00:30 INFO - PID 8929 | 12:03:34 INFO - PID 8929 | Cycle 1(1): loaded http://localhost:57761/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57761/tests/dromaeo/cssquery-yui.html) 12:03:34 INFO - PID 8929 | RSS: Main: 183394304 12:03:34 INFO - PID 8929 | 12:06:37 INFO - PID 8929 | Cycle 1(1): loaded http://localhost:57761/tests/dromaeo/cssquery-yui.html (next: http://localhost:57761/tests/dromaeo/cssquery-dojo.html) 12:06:37 INFO - PID 8929 | RSS: Main: 265826304 12:06:37 INFO - PID 8929 | 12:06:37 INFO - PID 8929 | __start_tp_report 12:06:37 INFO - PID 8929 | _x_x_mozilla_page_load 12:06:37 INFO - PID 8929 | _x_x_mozilla_page_load_details 12:06:37 INFO - PID 8929 | |i|pagename|runs| 12:06:37 INFO - PID 8929 | |0;dojo.html;2686.9462610747782;2703.3782230087068;2732.508148533264;2740.712225216352;2746.684131324897;5169.405518365389;5237.659552129109;5258.579313654908;5266.52601265886;5350.678959262442;5254.238135470364;5292.788288468466;5303.602229832759;5343.893122137555;5344.518993290603;4651.488336283006;4658.580727734503;4728.148933192024;4803.9279410808695;4834.1540230459705;4685.906281874343;4694.765261736899;4704.835330763424;4746.050789842028;4805.20714082176;4596.264597664391;4616.976915115437;4629.537046295377;4630.143423466636;4633.7683115844075;4655.557722016403;4670.206064968964;4671.5094915034115;4676.906461870778;4680.953190468086;4617.907641847144;4633.096546173498;4637.721736695809;4638.165130276582;4645.837395691135;5257.842264732064;5311.867203319909;5324.494173053554;5335.653182543122;5356.812511562077;5688.687122208277;5689.431056894319;5690.772369105231;5701.8026214495;5705.372409035044;5637.098064309732;5682.659040457585;5740.684262365568;5745.023346031185;5747.425257474261;5266.947330526684;5281.603879709037;5292.682439053592;5293.735313234323;5294.391145018295;5763.106718458645;5842;5848.327442344185;5938.8812223755285;5957.106434034929;5493.587980901449;5569.554435645138;5576.414476479992;5577.860553486195;5583.0787919992745;5678.290213723285;5681.801136960186;5685.232493613309;5687.232223649754;5687.630304030307;5629.774809007594;5633.521150702236;5643.633163844337;5643.746031428595;5644.463775941279;5615.382307946123;5616.466435688603;5616.466435688603;5621.662700237999;5641.943580564224;4740.099381117646;4748.382710247714;4750.691205071659;4752.097101550694;4790.928136077961;4038.273110840077;4106.055607210358;4106.835726570964;4107.712460127762;4146.626803587692;4763.952360476351;4811.927821082687;4831.879203019953;4852.951470485321;4853.778429202471;5717.828465146053;5723.828285151452;5729.512991395778;5730.255066841284;5778.017736984722;4860;4860.052289803454;4874.610031197496;4874.683145595525;4916.680415772963;4977.8257760978195;5032.874178145429;5053.974730126326;5075.264086707407;5081.8475445736685;5367.060764366299;5372.785088596413;5391.16436952273;5420.701861397661;5441.918371224356;5738.1679656450415;5754.741036653277;5765.4811067004175;5768.7404066817935;5774.0761478163295;5244.134717771525;5325.893482130413;5362.302900622894;5362.302900622894;5406.702631355313;5593.216949627137;5614.017546929353;5655.745491452977;5667.093265077568;5670.886582268414;5635.0702134147405;5677.205191273142;5679.460451257124;5691.459311365414;5741.3971532988435;5374.919376209438;5458.8908221834545;5480.616356855141;5484.670919744828;5488;5446.291982042309;5473.261109750133;5475.616706830484;5536.252605898152;5549.056660367666;5466.070767969375;5475.288212532345;5475.808346707846;5478.233047373451;5495.505404513613;5460.290162278879;5488.9725551371985;5546.528545073714;5548.167774833807;5572;5360.946390536044;5381.27352807366;5407.83776486706;5454.400015998158;5487.957288115245 12:06:37 INFO - PID 8929 | |1;ext.html;696.2063247897398;726.5822152262449;744.2334395572562;1063.9734006649833;1082.0261764412023;28241.293967650792;33692.83153584232;33969.49045764309;34054.65945340546;34055.14862128445;37228.62771372285;37523.624763752356;37584.62415375846;37636.247275054484;37721.62278377215;5696.231008813798;5825.563082768788;7233.674484648177;7367.889481657766;7538.585377804218;7436;7483.663235154431;7519.624018799065;7552.433567482433;7552.8867066994035;7432.888506672404;7498.212687667771;7498.887516687254;7499.73750918718;7515.436342274324;7472.738454154079;7509.136449308345;7512.361449276818;7512.436567257478;7514.6618402172035;7418;7468.2531746825425;7477.476576639638;7477.551346919148;7480.588567628778;35136.82431587826;35383.4692479613;35399.64600353989;35412.29175416503;35457.64542354595;2968.807027543203;2984.970185286073;2988.148377712363;2989.491786396296;3003.459377312083;26021.479570408486;26069.217923462325;26072.73927260722;26131;26133.477330453476;3165.3669266146862;3212.1166679163184;3212.646608873022;3212.887548935776;3221.548983142362;165550;166319;166971;167537.16231418887;168537;40531;40678.38982415266;40682.79658601688;40683.38974915379;40729.89051642218;42972;43131;43153.568464315584;43232;43234;12744.936275318563;12867.806982895265;12867.806982895265;13050.412731426919;13070.542531011559;9630.711078667511;9702.611895524242;9785.07041831025;9785.608575656894;10488.265821392582;11563.479643416067;12938.547150849676;13034.739305213843;13226.140300880412;13239.735205296032;5305.681659100389;5323.148296272578;5323.840284791462;5386.569074474032;5452.591055670761;821.5317269156524;858.3819649852096;865.0873328638347;897.0939351255149;902.5532361481108;19680.901595492218;21075.051622677016;21390.679139812913;21537.461563460725;21816.236431724814;953.8664586957832;965.358036905464;970.8058388322364;971.1696499492832;998.0817647764075;11257.380844053492;11308.208425410143;11370;11396.487158077907;11439.885601143882;232268;234231;234520;234587;234651;42075;42281.57718422776;42334;42338;42356.57643423526;1162.3375021584254;1216.1669256559107;1226.6810629236463;1227.0551675210038;1260.5714057220405;19536.31622893192;19971.60056798885;20552.177912883915;20702;20848.167696125234;30376;30426.543601845548;30566.694333056384;30575.694243057285;30603;219031;219148;219417;219603;219900;29432.26419339534;29629.5555566671;29672.109836704934;30741;31151.704210283853;36631.633683662825;37178.628213717515;37632.623673762915;37682;37862.24275514529;27320.08238517086;28136.859315703292;28214.85892570524;28283.43433131285;29092.563611546266;27605.585916211676;28196;28253.71746282511;28530.85734571314;28653.856730716212;29878.70121298846;30149.849250753607;30461.23846903845;30649.54025689661;30912.227194320323;26881.193564193105;26952.595711063957;27287.863560682068;27294.863525682245;28100.297492562848;21252.893735531223;22071;22266.666000010337;22417.32748017562;22488 12:06:37 INFO - PID 8929 | |2;jquery.html;376.9151940813319;417.3968615350817;426.4988638349938;433.3910855248376;445.75260730294696;12617.747645047106;14177.362018709156;18198.363057292998;18654.53363665909;18955.241790328386;18345.7248141278;18365.81634183661;18825.435236942878;18868.528286792804;18901.905490472527;4022.658074063708;5659.462351076641;5818.6217895836635;5845.503132233765;5848.649081055129;5745.368009518949;5863.648181109126;5870.911936320958;5877.823665290027;5880.353161152269;5586.91619625706;5704.686242256675;5779.2775903012125;5780.537556995451;5789.189513468118;5740.138979153139;5762.394948530427;5767.106098554731;5769.769209231626;5770.682612456313;4997.400311962551;5145;5157.226416037587;5173.948260517384;5228.451012643655;21977.23079692203;22086.779132208634;22190.445238869157;22628.434289142737;22897.313080607608;1644.597073716935;1649.9505014849574;1672.6069373697171;1677.773500577431;1723.4743403262;14637.853621463755;14723.705525889529;14792;14996.775048374284;15246.847531524765;2029.512916899948;2095.298075144828;2112.1656945506593;2121.5650791587686;2132.616129096762;71049;88490;93192.28288746813;93201;95295.52352238263;17389;17925.46223613294;17976.640467190584;17983.73024404635;18499.90750046241;34575.88817006481;34594.82702586521;34802.82598587042;35048.49515048526;35091.64908350884;9236.261099112055;9285.675001374919;9315.72052838416;9356.532173391302;9592.808143837085;7502;7599.278068583476;7799.610019499002;7800.687972481037;7802.219778022266;9254.16712495865;9370.672026479177;9590.376625519459;9661.178799802095;9752.609895604097;3679.050103445178;3680.5583330000572;3718.6467285607823;3752.568454627698;3887.747296425723;826.4421515477029;845.4969293270494;862.1421685423044;863.2877875752404;870.8475319344016;16404.343826247055;16684.49946501607;17180.969141851278;17495.912520437316;17554.122293885255;853.3343991686495;857.9227869491651;865.182402629509;865.4980111535294;873.7160422862595;9381.859272110923;9497.715068547956;9499.097585729345;9555.61777528891;9674.274429417681;425551;427536;433550;437211;446005;65307.99999999905;87942;89989;92508.53745731228;93424;1045.0855501436242;1058.5554067291755;1079.0180935348951;1079.8596182496383;1088.1131877519954;17008.319667213174;17539.82460175382;17801.732974005143;17834.732479012564;18169.545761356072;41710.58289417189;41944;42238.366424504275;43137.0196513646;44621.77689111534;53551.91256830595;55420.16869747038;55574.44425555854;56673.71663141658;57709.98015069452;8285.130061343712;8394.412391132562;8396.244338009608;8440.746777596682;8734.257588104829;12416.379181041093;12610.747785044432;12822.166559173624;13022.4139913706;13099.345032748133;10499.212559057949;10756.193285503776;10817;10972.451377430936;11636;10318.948405257926;10498.422586757802;10516.106130978953;10524.210684198562;10557.736056598647;10729.907668004664;10809.56761729522;11032.503537341;11047.779044418905;11201.383923884265;8258.132896045829;8361.122082181284;8468.49189048659;8559.358048146289;8581.2705919995;10299.639512617023;10439.53022114022;10675.786484270116;10696.732581685208;11078.501467434146 12:06:37 INFO - PID 8929 | |3;mootools.html;1221.3526830779688;1261.9053570982178;1276.4702648400912;1288.1948782011243;1293.915895466794;9317.953410232947;9763.853542196874;9772.560234789435;9777.902220977789;9782.510874456275;9555.522223888813;9770.120689137977;9990.050945160216;9999.550020249088;10004.349717268391;2069.2757534862826;2108.5572029873747;2110.3352443980175;2114.6510825713817;2118.745750509941;1739.782527184102;1824.3249997500943;2062.9587408251828;2073.1292857000094;2112.41908475169;2004.5690176612025;2077;2083.5832833433296;2085.979140208601;2086.54096098858;1981.980180198194;2068.0383621615947;2069.813716765498;2076.2317942361346;2076.595063962528;1749.4664127441126;1832.2670931627322;2092.790720927895;2093.1418118571464;2096.937091887246;9654.71035868925;9959.452230127341;9968.40189588627;9990.500474976223;10025.749356266078;5309.761060752276;5488.25908502355;5494.1758736189495;5498.890022199534;5499.862503437406;3065.509518477033;3240.659730728287;3290.3805813604845;3301.8679252829857;3302.240484688511;1108.2740804772886;1136.323887287063;1146.656003199037;1191.9582814601447;1199.412287978893;13820.654483637889;14060.507882224074;14079.507217247346;14096.224707641075;14115.576532704137;4340.47914250292;4484.484284307281;4663.976680116578;4765.356676848651;4791.5687588117235;10719.303245289031;10725;10727.463626818628;10729.409882456384;10731.141508679288;5261.789528418821;5358.91961620576;5360.812371566976;5362.731863406814;5362.758675859595;4823.517648235148;4876.195427754381;4911.8280860169725;4957.454679985199;5018;3628.8911332660064;3674.9081272967856;3678.33789917812;3762.774233545996;3766.9058273542832;1044.5560636729513;1046.5029111172285;1050.9264351495474;1057.7249915021996;1070.261519551507;660.3495556876472;687.1101923009714;691.3915754136328;693.8751024815582;704.5702121705858;5663.858403539944;5791.362950075489;5799.2750906136735;5852.4440178183;6065.5450841187085;814.1166833985075;815.9184081591912;828.556722153645;830.1739768929954;857.9656813727506;3551.236484155919;3602.963970360315;3638.1086633774894;3741.7567858089683;3858.401947698111;12138;12699.936500317439;12729.363531823372;12754.61736147917;12804.80792788109;12389.132760706845;12609.87390126087;12659.556915507914;12692.238465692088;12694.80957785634;9237.12247336502;9272.119148680864;9350.812983740423;9354.251659867194;9355.06449355059;5522.861928451821;5573.108302671553;5645.633033852787;5654.886902262014;5691.4877661010705;11221.438928053727;11492.253003554742;11513.13651476126;11640.904637165053;11647.41762911868;11816.172867899164;11838.704032399259;11906.10704197206;11981.700457488632;12096.818547721616;7405;7434.628268586441;7538.3215510604305;7557.622118894144;7636.236376362319;8940.105989401009;9185;9202.815943681222;9218.492982886006;9218.539073046186;7503.699852005859;7575.393968482618;7662.501937374052;7747.573883436465;7853.450258481851;7738.651760670671;7818.765437036898;7862.17447168062;7864.21357864209;7905.56519391439;7007.6846541904715;7087.929120708727;7127.429805615435;7145.285471452813;7152.642367881481;5040.924386134137;5139.897202056013;5180.145276029563;5194.3766747990485;5274.446183150714;5178.766955487087;5190.870228244324;5198.116320225647;5226.268322434938;5409.702466364388 12:06:37 INFO - PID 8929 | |4;prototype.html;352.0547330417827;367.5919729100698;390.0871959614502;394.4438341937868;397.9880603581893;5072.44203137655;5107.948920510794;5154.793808247675;5237.135872581029;5257.973710131453;5048.823291184809;5095.592352611791;5177.223416487529;5204.973975130129;5214.947850521494;4127.525334586516;4143.564925682806;4145.834166633331;4146.295129827921;4146.917061658757;3964.1278918637854;4091.9590804091877;4139.254934111858;4144.626983571478;4161.313383291753;4022.1955608878193;4088.652464540503;4095.4675892133982;4100.63094321511;4108.52751933527;4089.9386509202086;4092.069056786565;4093.97953010236;4095.488063992001;4101.5488296287385;3561;3675.650813172744;3710.628937106295;3723.925521489555;3732.085639018431;4916.237983112587;5145.048166089286;5163.889763700822;5165.405978312505;5182.818601348935;4921.064997650471;4921.458639549646;4929.580985616227;4935.728534930578;4938.753062346868;5501.826778422501;5575.052241118979;5624.746886390081;5637.3235211774845;5637.985162670718;4243.321068629005;4245.087306229176;4251.149770046003;4252.957470425287;4253.9365158710325;5826.70866456684;5833.183354330397;5841.503472204868;5843.211166492511;5868.882622347529;4268.658507319407;4330.58859408362;4373.693841431069;4380.189664911938;4388.736675799399;4164.83340666376;4452.532484089189;4457.509673935864;4460.598546130864;4471.23988921884;4681.461631912373;4754.120487709784;4826.155422801066;4834.105690447279;4840.830570930071;5548.805791797267;5567.805126820623;5572.136318870582;5578.860528486739;5596.1605759136455;1497.2139626695855;1525.8931874768882;1544.0735558664712;1546.072356586062;1547.7772559677953;1065.9680209593726;1084.9620263290747;1086.8532748079067;1090.7109615951779;1109.339942734088;4836.685615434985;4859.319695242669;4864.927026094611;4870.902581948412;4897.41231052276;5699.74351154199;5763.135529670583;5766.452187042224;5775.16260142277;5782.335031471351;4658.697184682985;4860;4861.1006963711825;4875.122477953932;4877.561019508261;2988.925276868096;3034.5903303054247;3054.3738533601004;3056.7554595632296;3057.1287183152695;5372.018529716045;5377.7311134443125;5383.327084114486;5425.403205647375;5428.67427954324;5723;5845.590808643439;5870.412958704181;5888.823335299948;5897.144913987448;5353.652012619245;5378.542823860016;5384.300040994645;5392.245085688085;5413.675179489322;5582.358028826737;5725.456081672234;5728.856778580569;5746.396628353963;5748.45389687979;5622.325320961347;5633.324001119892;5657.575681823797;5664.291963504562;5680.829575112753;5358.946410535845;5364.497940576644;5376.327959005124;5382.434844341287;5386.111291636836;3855.4000089963474;4007.29872272357;4016.0160760613835;4028.831638824708;4038.0712436139265;5465.836024919259;5590.916136257878;5633.352164501135;5735.971320143372;5749.482546570829;5541.251930989265;5544.916826247691;5554.583406244628;5563.721813909369;5579.302587176603;5294.782200093923;5532.889342213052;5550.611457197957;5571.690652696694;5578.2748242728185;5458.645188062763;5499.972500137474;5502.614816962934;5508.9724551376985;5511.944880551304;5557.472040156179;5570.777168913198;5573.637713548606;5583.888322233452;5655.915161272502;5190.091733946469;5375.919361209507;5407.134858422633;5483.341998960151;5486.393962867606 12:06:37 INFO - PID 8929 | |5;yui.html;739.474972769334;745.9738909138181;759.5974133709133;776.2237762237762;777.3975169243837;12186;12436.378181090944;12483.126181167321;12490.50037998479;13580.320983950813;13580.728385432285;13615.523456679019;13723.931380343109;13732.313384330793;13745.24401157936;865.1002956924806;890.3011136258007;894.4275663575316;895.400081945095;898.2320116300567;883.4699180491718;920.1028996728203;926.8146370725882;927.2581934452411;935.2377812083131;946.9384490008161;947.6114792934898;949.3544389814923;951.1249650321721;963.2390411574847;951.5385038256475;952.0431965874321;953.6423841059602;955.0497255231055;965.826151292767;696.853660731242;697.3897839390534;697.7418355208605;701.4353445476389;707.9469039822034;13983.440662373492;14093.64765880851;14150.080244784056;14210.14739115646;14488.34802433893;13570.321483925763;14178.787318190236;14257.215853128073;14330.92834535831;14382.928085359506;12334.383280835922;12421.565245216465;12468.43892024852;12484.438200281009;12614.621561353175;2915.28575499002;2954.6602140753876;2956.586077949089;2957.8964736234343;2958.541426078961;68655.65672171657;69583.65208173977;69589.65205173942;69744.6512767438;71326;10551.103156231653;10587.417692027013;10651.520681569347;10965.56137754497;11226.494807733508;21366.145354185657;21864.781352186274;21868.562628747335;21944;22059.11763529473;6498.837529061811;6599.670016499252;6651.833704157435;6681.298463661343;6902.309769023058;3264.396086723964;3315.237495376077;3322.850471728778;3326.9833650831592;3378.7634865559176;3445.9827700861333;3491.284286721216;3492.5285086512995;3495.5106285120105;3511.367953768295;728.2208037400037;739.663453128825;743.4684200796456;744.553268039183;746.958917259556;591.7573794744134;598.5630489742513;601.2424345324922;601.6089541797867;628.0704557255197;8297.784846187666;9000;9071.682491112912;9119;9314.813703725888;586.4194447496948;605.9484943779828;610.9327973922865;621.1304174156127;621.7171187109855;3971.702122340836;4081.9387709184384;4137.275976704125;4175.55729898013;4282;63387.683061584394;63884;64788.67605661941;66031;66151.66924165444;53225.7338713304;53504.73247633737;55941.720291398284;57546.424535754944;58479.4152058474;39700.60299397027;46640.7667961658;46781.766091169324;47245.76377118092;48155.5184448158;8807.779805504913;9322.580483878377;9346.392484488486;9436.716898493056;9470.242380609672;26431.867840660674;26581.468370632865;26581.734182657925;26593.601095983187;27638.585421218297;30926.690733092382;31191.220219493785;31231.531527027568;31427.214319642193;32138.83930580332;11286.379249141048;11317.320960742381;11360.375179365214;11443.48504317291;11471.13966452536;12663.936680316909;12750.553730619384;13246.80129798073;13267.087685692506;13718.38267277955;10963.397013164353;11068.944655276671;11433.714157146138;11434.94282528582;11598.594049208237;10912.563497460013;11000.724981875517;11017.394043327695;11380.374079425712;11716.824247636463;11118.813806999218;11150.832737508781;11218.887811122111;11550.422478876191;11984.520619175484;9358.485283309483;9362.625494980124;9467.810643786948;9507.382020168667;9881.258905581966;8900.243479304072;9534.52327383642;9562.426254424758;9708.320417570701;9745.756356091155 12:06:37 INFO - PID 8929 | __end_tp_report 12:06:37 INFO - PID 8929 | __start_cc_report 12:06:37 INFO - PID 8929 | _x_x_mozilla_cycle_collect,1026 12:06:37 INFO - PID 8929 | __end_cc_report 12:06:37 INFO - PID 8929 | __startTimestamp1491332797712__endTimestamp 12:06:37 INFO - PID 8929 | 12:06:37 INFO - PID 8929 | ------- Summary: start ------- 12:06:37 INFO - PID 8929 | Number of tests: 6 12:06:37 INFO - PID 8929 | 12:06:37 INFO - PID 8929 | [#0] dojo.html Cycles:165 Average:5199.88 Median:5374.92 stddev:615.55 (11.5%) stddev-sans-first:585.02 12:06:37 INFO - PID 8929 | Values: 2686.9 2703.4 2732.5 2740.7 2746.7 5169.4 5237.7 5258.6 5266.5 5350.7 5254.2 5292.8 5303.6 5343.9 5344.5 4651.5 4658.6 4728.1 4803.9 4834.2 4685.9 4694.8 4704.8 4746.1 4805.2 4596.3 4617.0 4629.5 4630.1 4633.8 4655.6 4670.2 4671.5 4676.9 4681.0 4617.9 4633.1 4637.7 4638.2 4645.8 5257.8 5311.9 5324.5 5335.7 5356.8 5688.7 5689.4 5690.8 5701.8 5705.4 5637.1 5682.7 5740.7 5745.0 5747.4 5266.9 5281.6 5292.7 5293.7 5294.4 5763.1 5842.0 5848.3 5938.9 5957.1 5493.6 5569.6 5576.4 5577.9 5583.1 5678.3 5681.8 5685.2 5687.2 5687.6 5629.8 5633.5 5643.6 5643.7 5644.5 5615.4 5616.5 5616.5 5621.7 5641.9 4740.1 4748.4 4750.7 4752.1 4790.9 4038.3 4106.1 4106.8 4107.7 4146.6 4764.0 4811.9 4831.9 4853.0 4853.8 5717.8 5723.8 5729.5 5730.3 5778.0 4860.0 4860.1 4874.6 4874.7 4916.7 4977.8 5032.9 5054.0 5075.3 5081.8 5367.1 5372.8 5391.2 5420.7 5441.9 5738.2 5754.7 5765.5 5768.7 5774.1 5244.1 5325.9 5362.3 5362.3 5406.7 5593.2 5614.0 5655.7 5667.1 5670.9 5635.1 5677.2 5679.5 5691.5 5741.4 5374.9 5458.9 5480.6 5484.7 5488.0 5446.3 5473.3 5475.6 5536.3 5549.1 5466.1 5475.3 5475.8 5478.2 5495.5 5460.3 5489.0 5546.5 5548.2 5572.0 5360.9 5381.3 5407.8 5454.4 5488.0 12:06:37 INFO - PID 8929 | 12:06:37 INFO - PID 8929 | [#1] ext.html Cycles:180 Average:34810.32 Median:30695.27 stddev:54321.71 (177.0%) stddev-sans-first:54413.70 12:06:37 INFO - PID 8929 | Values: 696.2 726.6 744.2 1064.0 1082.0 28241.3 33692.8 33969.5 34054.7 34055.1 37228.6 37523.6 37584.6 37636.2 37721.6 5696.2 5825.6 7233.7 7367.9 7538.6 7436.0 7483.7 7519.6 7552.4 7552.9 7432.9 7498.2 7498.9 7499.7 7515.4 7472.7 7509.1 7512.4 7512.4 7514.7 7418.0 7468.3 7477.5 7477.6 7480.6 35136.8 35383.5 35399.6 35412.3 35457.6 2968.8 2985.0 2988.1 2989.5 3003.5 26021.5 26069.2 26072.7 26131.0 26133.5 3165.4 3212.1 3212.6 3212.9 3221.5 165550.0 166319.0 166971.0 167537.2 168537.0 40531.0 40678.4 40682.8 40683.4 40729.9 42972.0 43131.0 43153.6 43232.0 43234.0 12744.9 12867.8 12867.8 13050.4 13070.5 9630.7 9702.6 9785.1 9785.6 10488.3 11563.5 12938.5 13034.7 13226.1 13239.7 5305.7 5323.1 5323.8 5386.6 5452.6 821.5 858.4 865.1 897.1 902.6 19680.9 21075.1 21390.7 21537.5 21816.2 953.9 965.4 970.8 971.2 998.1 11257.4 11308.2 11370.0 11396.5 11439.9 232268.0 234231.0 234520.0 234587.0 234651.0 42075.0 42281.6 42334.0 42338.0 42356.6 1162.3 1216.2 1226.7 1227.1 1260.6 19536.3 19971.6 20552.2 20702.0 20848.2 30376.0 30426.5 30566.7 30575.7 30603.0 219031.0 219148.0 219417.0 219603.0 219900.0 29432.3 29629.6 29672.1 30741.0 31151.7 36631.6 37178.6 37632.6 37682.0 37862.2 27320.1 28136.9 28214.9 28283.4 29092.6 27605.6 28196.0 28253.7 28530.9 28653.9 29878.7 30149.8 30461.2 30649.5 30912.2 26881.2 26952.6 27287.9 27294.9 28100.3 21252.9 22071.0 22266.7 22417.3 22488.0 12:06:37 INFO - PID 8929 | 12:06:37 INFO - PID 8929 | [#2] jquery.html Cycles:180 Average:28165.38 Median:233894.68 stddev:71862.02 (30.7%) stddev-sans-first:72033.32 12:06:37 INFO - PID 8929 | Values: 376.9 417.4 426.5 433.4 445.8 12617.7 14177.4 18198.4 18654.5 18955.2 18345.7 18365.8 18825.4 18868.5 18901.9 4022.7 5659.5 5818.6 5845.5 5848.6 5745.4 5863.6 5870.9 5877.8 5880.4 5586.9 5704.7 5779.3 5780.5 5789.2 5740.1 5762.4 5767.1 5769.8 5770.7 4997.4 5145.0 5157.2 5173.9 5228.5 21977.2 22086.8 22190.4 22628.4 22897.3 1644.6 1650.0 1672.6 1677.8 1723.5 14637.9 14723.7 14792.0 14996.8 15246.8 2029.5 2095.3 2112.2 2121.6 2132.6 71049.0 88490.0 93192.3 93201.0 95295.5 17389.0 17925.5 17976.6 17983.7 18499.9 34575.9 34594.8 34802.8 35048.5 35091.6 9236.3 9285.7 9315.7 9356.5 9592.8 7502.0 7599.3 7799.6 7800.7 7802.2 9254.2 9370.7 9590.4 9661.2 9752.6 3679.1 3680.6 3718.6 3752.6 3887.7 826.4 845.5 862.1 863.3 870.8 16404.3 16684.5 17181.0 17495.9 17554.1 853.3 857.9 865.2 865.5 873.7 9381.9 9497.7 9499.1 9555.6 9674.3 425551.0 427536.0 433550.0 437211.0 446005.0 65308.0 87942.0 89989.0 92508.5 93424.0 1045.1 1058.6 1079.0 1079.9 1088.1 17008.3 17539.8 17801.7 17834.7 18169.5 41710.6 41944.0 42238.4 43137.0 44621.8 53551.9 55420.2 55574.4 56673.7 57710.0 8285.1 8394.4 8396.2 8440.7 8734.3 12416.4 12610.7 12822.2 13022.4 13099.3 10499.2 10756.2 10817.0 10972.5 11636.0 10318.9 10498.4 10516.1 10524.2 10557.7 10729.9 10809.6 11032.5 11047.8 11201.4 8258.1 8361.1 8468.5 8559.4 8581.3 10299.6 10439.5 10675.8 10696.7 11078.5 12:06:37 INFO - PID 8929 | 12:06:37 INFO - PID 8929 | [#3] mootools.html Cycles:180 Average:6095.79 Median:4778.46 stddev:3890.87 (81.4%) stddev-sans-first:3884.54 12:06:37 INFO - PID 8929 | Values: 1221.4 1261.9 1276.5 1288.2 1293.9 9318.0 9763.9 9772.6 9777.9 9782.5 9555.5 9770.1 9990.1 9999.6 10004.3 2069.3 2108.6 2110.3 2114.7 2118.7 1739.8 1824.3 2063.0 2073.1 2112.4 2004.6 2077.0 2083.6 2086.0 2086.5 1982.0 2068.0 2069.8 2076.2 2076.6 1749.5 1832.3 2092.8 2093.1 2096.9 9654.7 9959.5 9968.4 9990.5 10025.7 5309.8 5488.3 5494.2 5498.9 5499.9 3065.5 3240.7 3290.4 3301.9 3302.2 1108.3 1136.3 1146.7 1192.0 1199.4 13820.7 14060.5 14079.5 14096.2 14115.6 4340.5 4484.5 4664.0 4765.4 4791.6 10719.3 10725.0 10727.5 10729.4 10731.1 5261.8 5358.9 5360.8 5362.7 5362.8 4823.5 4876.2 4911.8 4957.5 5018.0 3628.9 3674.9 3678.3 3762.8 3766.9 1044.6 1046.5 1050.9 1057.7 1070.3 660.3 687.1 691.4 693.9 704.6 5663.9 5791.4 5799.3 5852.4 6065.5 814.1 815.9 828.6 830.2 858.0 3551.2 3603.0 3638.1 3741.8 3858.4 12138.0 12699.9 12729.4 12754.6 12804.8 12389.1 12609.9 12659.6 12692.2 12694.8 9237.1 9272.1 9350.8 9354.3 9355.1 5522.9 5573.1 5645.6 5654.9 5691.5 11221.4 11492.3 11513.1 11640.9 11647.4 11816.2 11838.7 11906.1 11981.7 12096.8 7405.0 7434.6 7538.3 7557.6 7636.2 8940.1 9185.0 9202.8 9218.5 9218.5 7503.7 7575.4 7662.5 7747.6 7853.5 7738.7 7818.8 7862.2 7864.2 7905.6 7007.7 7087.9 7127.4 7145.3 7152.6 5040.9 5139.9 5180.1 5194.4 5274.4 5178.8 5190.9 5198.1 5226.3 5409.7 12:06:37 INFO - PID 8929 | 12:06:37 INFO - PID 8929 | [#4] prototype.html Cycles:180 Average:4646.19 Median:5149.92 stddev:1309.24 (25.4%) stddev-sans-first:1272.62 12:06:37 INFO - PID 8929 | Values: 352.1 367.6 390.1 394.4 398.0 5072.4 5107.9 5154.8 5237.1 5258.0 5048.8 5095.6 5177.2 5205.0 5214.9 4127.5 4143.6 4145.8 4146.3 4146.9 3964.1 4092.0 4139.3 4144.6 4161.3 4022.2 4088.7 4095.5 4100.6 4108.5 4089.9 4092.1 4094.0 4095.5 4101.5 3561.0 3675.7 3710.6 3723.9 3732.1 4916.2 5145.0 5163.9 5165.4 5182.8 4921.1 4921.5 4929.6 4935.7 4938.8 5501.8 5575.1 5624.7 5637.3 5638.0 4243.3 4245.1 4251.1 4253.0 4253.9 5826.7 5833.2 5841.5 5843.2 5868.9 4268.7 4330.6 4373.7 4380.2 4388.7 4164.8 4452.5 4457.5 4460.6 4471.2 4681.5 4754.1 4826.2 4834.1 4840.8 5548.8 5567.8 5572.1 5578.9 5596.2 1497.2 1525.9 1544.1 1546.1 1547.8 1066.0 1085.0 1086.9 1090.7 1109.3 4836.7 4859.3 4864.9 4870.9 4897.4 5699.7 5763.1 5766.5 5775.2 5782.3 4658.7 4860.0 4861.1 4875.1 4877.6 2988.9 3034.6 3054.4 3056.8 3057.1 5372.0 5377.7 5383.3 5425.4 5428.7 5723.0 5845.6 5870.4 5888.8 5897.1 5353.7 5378.5 5384.3 5392.2 5413.7 5582.4 5725.5 5728.9 5746.4 5748.5 5622.3 5633.3 5657.6 5664.3 5680.8 5358.9 5364.5 5376.3 5382.4 5386.1 3855.4 4007.3 4016.0 4028.8 4038.1 5465.8 5590.9 5633.4 5736.0 5749.5 5541.3 5544.9 5554.6 5563.7 5579.3 5294.8 5532.9 5550.6 5571.7 5578.3 5458.6 5500.0 5502.6 5509.0 5511.9 5557.5 5570.8 5573.6 5583.9 5655.9 5190.1 5375.9 5407.1 5483.3 5486.4 12:06:37 INFO - PID 8929 | 12:06:37 INFO - PID 8929 | [#5] yui.html Cycles:180 Average:14369.12 Median:25461.38 stddev:17674.44 (69.4%) stddev-sans-first:17694.39 12:06:37 INFO - PID 8929 | Values: 739.5 746.0 759.6 776.2 777.4 12186.0 12436.4 12483.1 12490.5 13580.3 13580.7 13615.5 13723.9 13732.3 13745.2 865.1 890.3 894.4 895.4 898.2 883.5 920.1 926.8 927.3 935.2 946.9 947.6 949.4 951.1 963.2 951.5 952.0 953.6 955.0 965.8 696.9 697.4 697.7 701.4 707.9 13983.4 14093.6 14150.1 14210.1 14488.3 13570.3 14178.8 14257.2 14330.9 14382.9 12334.4 12421.6 12468.4 12484.4 12614.6 2915.3 2954.7 2956.6 2957.9 2958.5 68655.7 69583.7 69589.7 69744.7 71326.0 10551.1 10587.4 10651.5 10965.6 11226.5 21366.1 21864.8 21868.6 21944.0 22059.1 6498.8 6599.7 6651.8 6681.3 6902.3 3264.4 3315.2 3322.9 3327.0 3378.8 3446.0 3491.3 3492.5 3495.5 3511.4 728.2 739.7 743.5 744.6 747.0 591.8 598.6 601.2 601.6 628.1 8297.8 9000.0 9071.7 9119.0 9314.8 586.4 605.9 610.9 621.1 621.7 3971.7 4081.9 4137.3 4175.6 4282.0 63387.7 63884.0 64788.7 66031.0 66151.7 53225.7 53504.7 55941.7 57546.4 58479.4 39700.6 46640.8 46781.8 47245.8 48155.5 8807.8 9322.6 9346.4 9436.7 9470.2 26431.9 26581.5 26581.7 26593.6 27638.6 30926.7 31191.2 31231.5 31427.2 32138.8 11286.4 11317.3 11360.4 11443.5 11471.1 12663.9 12750.6 13246.8 13267.1 13718.4 10963.4 11068.9 11433.7 11434.9 11598.6 10912.6 11000.7 11017.4 11380.4 11716.8 11118.8 11150.8 11218.9 11550.4 11984.5 9358.5 9362.6 9467.8 9507.4 9881.3 8900.2 9534.5 9562.4 9708.3 9745.8 12:06:37 INFO - PID 8929 | -------- Summary: end -------- 12:06:37 INFO - PID 8929 | 12:06:38 INFO - TEST-INFO | 8929: exit 0 12:06:38 INFO - TEST-OK | dromaeo_css | took 1124305ms 12:06:38 INFO - TEST-START | kraken 12:06:38 INFO - operating with platform_type : linux_ 12:06:38 INFO - Initialising browser for kraken test... 12:06:38 INFO - TEST-INFO | started process 9252 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWJOrv0/profile http://localhost:57761/getInfo.html) 12:06:42 INFO - PID 9252 | __metrics Screen width/height:1600/1200 12:06:42 INFO - PID 9252 | colorDepth:24 12:06:42 INFO - PID 9252 | Browser inner width/height: 1024/697 12:06:42 INFO - PID 9252 | __metrics 12:06:43 INFO - PID 9252 | 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" 12:06:43 INFO - PID 9252 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:06:44 INFO - TEST-INFO | 9252: exit 0 12:06:44 INFO - Browser initialized. 12:06:44 INFO - Running cycle 1/1 for kraken test... 12:06:44 INFO - TEST-INFO | started process 9344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWJOrv0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:06:57 INFO - PID 9344 | RSS: Main: 154038272 12:06:57 INFO - PID 9344 | 12:06:59 INFO - PID 9344 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57761/tests/kraken/driver.html?testName=audio-beat-detection) 12:07:00 INFO - PID 9344 | RSS: Main: 209379328 12:07:00 INFO - PID 9344 | 12:07:03 INFO - PID 9344 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57761/tests/kraken/driver.html?testName=audio-dft) 12:07:04 INFO - PID 9344 | RSS: Main: 188805120 12:07:04 INFO - PID 9344 | 12:07:07 INFO - PID 9344 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57761/tests/kraken/driver.html?testName=audio-fft) 12:07:07 INFO - PID 9344 | RSS: Main: 271601664 12:07:07 INFO - PID 9344 | 12:07:10 INFO - PID 9344 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57761/tests/kraken/driver.html?testName=audio-oscillator) 12:07:10 INFO - PID 9344 | RSS: Main: 181587968 12:07:10 INFO - PID 9344 | 12:07:12 INFO - PID 9344 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57761/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:07:13 INFO - PID 9344 | RSS: Main: 186081280 12:07:13 INFO - PID 9344 | 12:07:16 INFO - PID 9344 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57761/tests/kraken/driver.html?testName=imaging-darkroom) 12:07:17 INFO - PID 9344 | RSS: Main: 224866304 12:07:17 INFO - PID 9344 | 12:07:21 INFO - PID 9344 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57761/tests/kraken/driver.html?testName=imaging-desaturate) 12:07:21 INFO - PID 9344 | RSS: Main: 219447296 12:07:21 INFO - PID 9344 | 12:07:24 INFO - PID 9344 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57761/tests/kraken/driver.html?testName=json-parse-financial) 12:07:25 INFO - PID 9344 | RSS: Main: 220794880 12:07:25 INFO - PID 9344 | 12:07:26 INFO - PID 9344 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57761/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:07:27 INFO - PID 9344 | RSS: Main: 185044992 12:07:27 INFO - PID 9344 | 12:07:29 INFO - PID 9344 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57761/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:07:29 INFO - PID 9344 | RSS: Main: 192167936 12:07:29 INFO - PID 9344 | 12:07:32 INFO - PID 9344 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57761/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:07:32 INFO - PID 9344 | RSS: Main: 201445376 12:07:32 INFO - PID 9344 | 12:07:35 INFO - PID 9344 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57761/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:07:36 INFO - PID 9344 | RSS: Main: 210079744 12:07:36 INFO - PID 9344 | 12:07:39 INFO - PID 9344 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57761/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:07:40 INFO - PID 9344 | RSS: Main: 207577088 12:07:40 INFO - PID 9344 | 12:07:42 INFO - PID 9344 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57761/tests/kraken/driver.html?testName=ai-astar) 12:07:42 INFO - PID 9344 | RSS: Main: 275722240 12:07:42 INFO - PID 9344 | 12:07:42 INFO - PID 9344 | __start_tp_report 12:07:42 INFO - PID 9344 | _x_x_mozilla_page_load 12:07:42 INFO - PID 9344 | _x_x_mozilla_page_load_details 12:07:42 INFO - PID 9344 | |i|pagename|runs| 12:07:42 INFO - PID 9344 | |0;ai-astar;113;115;113;113;114;112;112;112;112;111 12:07:42 INFO - PID 9344 | |1;audio-beat-detection;159;126;123;167;125;123;125;123;147;125 12:07:42 INFO - PID 9344 | |2;audio-dft;165;165;165;166;166;166;166;166;167;167 12:07:42 INFO - PID 9344 | |3;audio-fft;75;75;77;116;76;77;82;79;97;80 12:07:42 INFO - PID 9344 | |4;audio-oscillator;86;84;112;85;84;84;113;83;83;106 12:07:42 INFO - PID 9344 | |5;imaging-gaussian-blur;114;124;122;119;114;115;114;114;115;114 12:07:42 INFO - PID 9344 | |6;imaging-darkroom;150;153;150;150;151;150;152;151;150;151 12:07:42 INFO - PID 9344 | |7;imaging-desaturate;94;95;95;95;95;94;95;94;95;94 12:07:42 INFO - PID 9344 | |8;json-parse-financial;54;54;53;54;55;54;54;54;54;55 12:07:42 INFO - PID 9344 | |9;json-stringify-tinderbox;58;56;56;57;56;56;57;56;56;56 12:07:42 INFO - PID 9344 | |10;stanford-crypto-aes;83;83;84;82;83;96;82;94;82;83 12:07:42 INFO - PID 9344 | |11;stanford-crypto-ccm;135;136;153;134;141;134;142;152;196;137 12:07:42 INFO - PID 9344 | |12;stanford-crypto-pbkdf2;197;201;196;197;202;193;198;196;196;196 12:07:42 INFO - PID 9344 | |13;stanford-crypto-sha256-iterative;79;72;72;72;71;71;71;69;74;70 12:07:42 INFO - PID 9344 | __end_tp_report 12:07:42 INFO - PID 9344 | __start_cc_report 12:07:42 INFO - PID 9344 | _x_x_mozilla_cycle_collect,2006 12:07:42 INFO - PID 9344 | __end_cc_report 12:07:42 INFO - PID 9344 | __startTimestamp1491332862290__endTimestamp 12:07:42 INFO - PID 9344 | 12:07:42 INFO - PID 9344 | ------- Summary: start ------- 12:07:42 INFO - PID 9344 | Number of tests: 14 12:07:42 INFO - PID 9344 | 12:07:42 INFO - PID 9344 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:1.16 (1.0%) stddev-sans-first:1.22 12:07:42 INFO - PID 9344 | Values: 113.0 115.0 113.0 113.0 114.0 112.0 112.0 112.0 112.0 111.0 12:07:42 INFO - PID 9344 | 12:07:42 INFO - PID 9344 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:125.50 stddev:16.84 (13.4%) stddev-sans-first:15.31 12:07:42 INFO - PID 9344 | Values: 159.0 126.0 123.0 167.0 125.0 123.0 125.0 123.0 147.0 125.0 12:07:42 INFO - PID 9344 | 12:07:42 INFO - PID 9344 | [#2] audio-dft Cycles:10 Average:165.90 Median:166.00 stddev:0.74 (0.4%) stddev-sans-first:0.71 12:07:42 INFO - PID 9344 | Values: 165.0 165.0 165.0 166.0 166.0 166.0 166.0 166.0 167.0 167.0 12:07:42 INFO - PID 9344 | 12:07:42 INFO - PID 9344 | [#3] audio-fft Cycles:10 Average:83.40 Median:78.00 stddev:13.16 (16.9%) stddev-sans-first:13.60 12:07:42 INFO - PID 9344 | Values: 75.0 75.0 77.0 116.0 76.0 77.0 82.0 79.0 97.0 80.0 12:07:42 INFO - PID 9344 | 12:07:42 INFO - PID 9344 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:84.00 stddev:12.81 (15.2%) stddev-sans-first:13.40 12:07:42 INFO - PID 9344 | Values: 86.0 84.0 112.0 85.0 84.0 84.0 113.0 83.0 83.0 106.0 12:07:42 INFO - PID 9344 | 12:07:42 INFO - PID 9344 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:115.00 stddev:3.78 (3.3%) stddev-sans-first:3.90 12:07:42 INFO - PID 9344 | Values: 114.0 124.0 122.0 119.0 114.0 115.0 114.0 114.0 115.0 114.0 12:07:42 INFO - PID 9344 | 12:07:42 INFO - PID 9344 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:1.03 (0.7%) stddev-sans-first:1.05 12:07:42 INFO - PID 9344 | Values: 150.0 153.0 150.0 150.0 151.0 150.0 152.0 151.0 150.0 151.0 12:07:42 INFO - PID 9344 | 12:07:42 INFO - PID 9344 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 12:07:42 INFO - PID 9344 | Values: 94.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 12:07:42 INFO - PID 9344 | 12:07:42 INFO - PID 9344 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:0.57 (1.1%) stddev-sans-first:0.60 12:07:42 INFO - PID 9344 | Values: 54.0 54.0 53.0 54.0 55.0 54.0 54.0 54.0 54.0 55.0 12:07:42 INFO - PID 9344 | 12:07:42 INFO - PID 9344 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:56.00 stddev:0.70 (1.2%) stddev-sans-first:0.44 12:07:42 INFO - PID 9344 | Values: 58.0 56.0 56.0 57.0 56.0 56.0 57.0 56.0 56.0 56.0 12:07:42 INFO - PID 9344 | 12:07:42 INFO - PID 9344 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:83.00 stddev:5.22 (6.3%) stddev-sans-first:5.48 12:07:42 INFO - PID 9344 | Values: 83.0 83.0 84.0 82.0 83.0 96.0 82.0 94.0 82.0 83.0 12:07:42 INFO - PID 9344 | 12:07:42 INFO - PID 9344 | [#11] stanford-crypto-ccm Cycles:10 Average:146.00 Median:141.50 stddev:18.90 (13.4%) stddev-sans-first:19.63 12:07:42 INFO - PID 9344 | Values: 135.0 136.0 153.0 134.0 141.0 134.0 142.0 152.0 196.0 137.0 12:07:42 INFO - PID 9344 | 12:07:42 INFO - PID 9344 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.20 Median:197.00 stddev:2.62 (1.3%) stddev-sans-first:2.77 12:07:42 INFO - PID 9344 | Values: 197.0 201.0 196.0 197.0 202.0 193.0 198.0 196.0 196.0 196.0 12:07:42 INFO - PID 9344 | 12:07:42 INFO - PID 9344 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:72.00 stddev:2.77 (3.8%) stddev-sans-first:1.41 12:07:42 INFO - PID 9344 | Values: 79.0 72.0 72.0 72.0 71.0 71.0 71.0 69.0 74.0 70.0 12:07:42 INFO - PID 9344 | -------- Summary: end -------- 12:07:42 INFO - PID 9344 | 12:07:43 INFO - TEST-INFO | 9344: exit 0 12:07:43 INFO - TEST-OK | kraken | took 65035ms 12:07:43 INFO - SUITE-END | took 1189s 12:07:43 INFO - Completed test suite (00:19:49) 12:07:43 INFO - javascript benchmark 12:07:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6756.766338147864, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2686.9462610747782, 2703.3782230087068, 2732.508148533264, 2740.712225216352, 2746.684131324897, 5169.405518365389, 5237.659552129109, 5258.579313654908, 5266.52601265886, 5350.678959262442, 5254.238135470364, 5292.788288468466, 5303.602229832759, 5343.893122137555, 5344.518993290603, 4651.488336283006, 4658.580727734503, 4728.148933192024, 4803.9279410808695, 4834.1540230459705, 4685.906281874343, 4694.765261736899, 4704.835330763424, 4746.050789842028, 4805.20714082176, 4596.264597664391, 4616.976915115437, 4629.537046295377, 4630.143423466636, 4633.7683115844075, 4655.557722016403, 4670.206064968964, 4671.5094915034115, 4676.906461870778, 4680.953190468086, 4617.907641847144, 4633.096546173498, 4637.721736695809, 4638.165130276582, 4645.837395691135, 5257.842264732064, 5311.867203319909, 5324.494173053554, 5335.653182543122, 5356.812511562077, 5688.687122208277, 5689.431056894319, 5690.772369105231, 5701.8026214495, 5705.372409035044, 5637.098064309732, 5682.659040457585, 5740.684262365568, 5745.023346031185, 5747.425257474261, 5266.947330526684, 5281.603879709037, 5292.682439053592, 5293.735313234323, 5294.391145018295, 5763.106718458645, 5842.0, 5848.327442344185, 5938.8812223755285, 5957.106434034929, 5493.587980901449, 5569.554435645138, 5576.414476479992, 5577.860553486195, 5583.0787919992745, 5678.290213723285, 5681.801136960186, 5685.232493613309, 5687.232223649754, 5687.630304030307, 5629.774809007594, 5633.521150702236, 5643.633163844337, 5643.746031428595, 5644.463775941279, 5615.382307946123, 5616.466435688603, 5616.466435688603, 5621.662700237999, 5641.943580564224, 4740.099381117646, 4748.382710247714, 4750.691205071659, 4752.097101550694, 4790.928136077961, 4038.273110840077, 4106.055607210358, 4106.835726570964, 4107.712460127762, 4146.626803587692, 4763.952360476351, 4811.927821082687, 4831.879203019953, 4852.951470485321, 4853.778429202471, 5717.828465146053, 5723.828285151452, 5729.512991395778, 5730.255066841284, 5778.017736984722, 4860.0, 4860.052289803454, 4874.610031197496, 4874.683145595525, 4916.680415772963, 4977.8257760978195, 5032.874178145429, 5053.974730126326, 5075.264086707407, 5081.8475445736685, 5367.060764366299, 5372.785088596413, 5391.16436952273, 5420.701861397661, 5441.918371224356, 5738.1679656450415, 5754.741036653277, 5765.4811067004175, 5768.7404066817935, 5774.0761478163295, 5244.134717771525, 5325.893482130413, 5362.302900622894, 5362.302900622894, 5406.702631355313, 5593.216949627137, 5614.017546929353, 5655.745491452977, 5667.093265077568, 5670.886582268414, 5635.0702134147405, 5677.205191273142, 5679.460451257124, 5691.459311365414, 5741.3971532988435, 5374.919376209438, 5458.8908221834545, 5480.616356855141, 5484.670919744828, 5488.0, 5446.291982042309, 5473.261109750133, 5475.616706830484, 5536.252605898152, 5549.056660367666, 5466.070767969375, 5475.288212532345, 5475.808346707846, 5478.233047373451, 5495.505404513613, 5460.290162278879, 5488.9725551371985, 5546.528545073714, 5548.167774833807, 5572.0, 5360.946390536044, 5381.27352807366, 5407.83776486706, 5454.400015998158, 5487.957288115245], "value": 5154.557437386908, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.2063247897398, 726.5822152262449, 744.2334395572562, 1063.9734006649833, 1082.0261764412023, 28241.293967650792, 33692.83153584232, 33969.49045764309, 34054.65945340546, 34055.14862128445, 37228.62771372285, 37523.624763752356, 37584.62415375846, 37636.247275054484, 37721.62278377215, 5696.231008813798, 5825.563082768788, 7233.674484648177, 7367.889481657766, 7538.585377804218, 7436.0, 7483.663235154431, 7519.624018799065, 7552.433567482433, 7552.8867066994035, 7432.888506672404, 7498.212687667771, 7498.887516687254, 7499.73750918718, 7515.436342274324, 7472.738454154079, 7509.136449308345, 7512.361449276818, 7512.436567257478, 7514.6618402172035, 7418.0, 7468.2531746825425, 7477.476576639638, 7477.551346919148, 7480.588567628778, 35136.82431587826, 35383.4692479613, 35399.64600353989, 35412.29175416503, 35457.64542354595, 2968.807027543203, 2984.970185286073, 2988.148377712363, 2989.491786396296, 3003.459377312083, 26021.479570408486, 26069.217923462325, 26072.73927260722, 26131.0, 26133.477330453476, 3165.3669266146862, 3212.1166679163184, 3212.646608873022, 3212.887548935776, 3221.548983142362, 165550.0, 166319.0, 166971.0, 167537.16231418887, 168537.0, 40531.0, 40678.38982415266, 40682.79658601688, 40683.38974915379, 40729.89051642218, 42972.0, 43131.0, 43153.568464315584, 43232.0, 43234.0, 12744.936275318563, 12867.806982895265, 12867.806982895265, 13050.412731426919, 13070.542531011559, 9630.711078667511, 9702.611895524242, 9785.07041831025, 9785.608575656894, 10488.265821392582, 11563.479643416067, 12938.547150849676, 13034.739305213843, 13226.140300880412, 13239.735205296032, 5305.681659100389, 5323.148296272578, 5323.840284791462, 5386.569074474032, 5452.591055670761, 821.5317269156524, 858.3819649852096, 865.0873328638347, 897.0939351255149, 902.5532361481108, 19680.901595492218, 21075.051622677016, 21390.679139812913, 21537.461563460725, 21816.236431724814, 953.8664586957832, 965.358036905464, 970.8058388322364, 971.1696499492832, 998.0817647764075, 11257.380844053492, 11308.208425410143, 11370.0, 11396.487158077907, 11439.885601143882, 232268.0, 234231.0, 234520.0, 234587.0, 234651.0, 42075.0, 42281.57718422776, 42334.0, 42338.0, 42356.57643423526, 1162.3375021584254, 1216.1669256559107, 1226.6810629236463, 1227.0551675210038, 1260.5714057220405, 19536.31622893192, 19971.60056798885, 20552.177912883915, 20702.0, 20848.167696125234, 30376.0, 30426.543601845548, 30566.694333056384, 30575.694243057285, 30603.0, 219031.0, 219148.0, 219417.0, 219603.0, 219900.0, 29432.26419339534, 29629.5555566671, 29672.109836704934, 30741.0, 31151.704210283853, 36631.633683662825, 37178.628213717515, 37632.623673762915, 37682.0, 37862.24275514529, 27320.08238517086, 28136.859315703292, 28214.85892570524, 28283.43433131285, 29092.563611546266, 27605.585916211676, 28196.0, 28253.71746282511, 28530.85734571314, 28653.856730716212, 29878.70121298846, 30149.849250753607, 30461.23846903845, 30649.54025689661, 30912.227194320323, 26881.193564193105, 26952.595711063957, 27287.863560682068, 27294.863525682245, 28100.297492562848, 21252.893735531223, 22071.0, 22266.666000010337, 22417.32748017562, 22488.0], "value": 15103.8850917476, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.9151940813319, 417.3968615350817, 426.4988638349938, 433.3910855248376, 445.75260730294696, 12617.747645047106, 14177.362018709156, 18198.363057292998, 18654.53363665909, 18955.241790328386, 18345.7248141278, 18365.81634183661, 18825.435236942878, 18868.528286792804, 18901.905490472527, 4022.658074063708, 5659.462351076641, 5818.6217895836635, 5845.503132233765, 5848.649081055129, 5745.368009518949, 5863.648181109126, 5870.911936320958, 5877.823665290027, 5880.353161152269, 5586.91619625706, 5704.686242256675, 5779.2775903012125, 5780.537556995451, 5789.189513468118, 5740.138979153139, 5762.394948530427, 5767.106098554731, 5769.769209231626, 5770.682612456313, 4997.400311962551, 5145.0, 5157.226416037587, 5173.948260517384, 5228.451012643655, 21977.23079692203, 22086.779132208634, 22190.445238869157, 22628.434289142737, 22897.313080607608, 1644.597073716935, 1649.9505014849574, 1672.6069373697171, 1677.773500577431, 1723.4743403262, 14637.853621463755, 14723.705525889529, 14792.0, 14996.775048374284, 15246.847531524765, 2029.512916899948, 2095.298075144828, 2112.1656945506593, 2121.5650791587686, 2132.616129096762, 71049.0, 88490.0, 93192.28288746813, 93201.0, 95295.52352238263, 17389.0, 17925.46223613294, 17976.640467190584, 17983.73024404635, 18499.90750046241, 34575.88817006481, 34594.82702586521, 34802.82598587042, 35048.49515048526, 35091.64908350884, 9236.261099112055, 9285.675001374919, 9315.72052838416, 9356.532173391302, 9592.808143837085, 7502.0, 7599.278068583476, 7799.610019499002, 7800.687972481037, 7802.219778022266, 9254.16712495865, 9370.672026479177, 9590.376625519459, 9661.178799802095, 9752.609895604097, 3679.050103445178, 3680.5583330000572, 3718.6467285607823, 3752.568454627698, 3887.747296425723, 826.4421515477029, 845.4969293270494, 862.1421685423044, 863.2877875752404, 870.8475319344016, 16404.343826247055, 16684.49946501607, 17180.969141851278, 17495.912520437316, 17554.122293885255, 853.3343991686495, 857.9227869491651, 865.182402629509, 865.4980111535294, 873.7160422862595, 9381.859272110923, 9497.715068547956, 9499.097585729345, 9555.61777528891, 9674.274429417681, 425551.0, 427536.0, 433550.0, 437211.0, 446005.0, 65307.99999999905, 87942.0, 89989.0, 92508.53745731228, 93424.0, 1045.0855501436242, 1058.5554067291755, 1079.0180935348951, 1079.8596182496383, 1088.1131877519954, 17008.319667213174, 17539.82460175382, 17801.732974005143, 17834.732479012564, 18169.545761356072, 41710.58289417189, 41944.0, 42238.366424504275, 43137.0196513646, 44621.77689111534, 53551.91256830595, 55420.16869747038, 55574.44425555854, 56673.71663141658, 57709.98015069452, 8285.130061343712, 8394.412391132562, 8396.244338009608, 8440.746777596682, 8734.257588104829, 12416.379181041093, 12610.747785044432, 12822.166559173624, 13022.4139913706, 13099.345032748133, 10499.212559057949, 10756.193285503776, 10817.0, 10972.451377430936, 11636.0, 10318.948405257926, 10498.422586757802, 10516.106130978953, 10524.210684198562, 10557.736056598647, 10729.907668004664, 10809.56761729522, 11032.503537341, 11047.779044418905, 11201.383923884265, 8258.132896045829, 8361.122082181284, 8468.49189048659, 8559.358048146289, 8581.2705919995, 10299.639512617023, 10439.53022114022, 10675.786484270116, 10696.732581685208, 11078.501467434146], "value": 9657.959400212025, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1221.3526830779688, 1261.9053570982178, 1276.4702648400912, 1288.1948782011243, 1293.915895466794, 9317.953410232947, 9763.853542196874, 9772.560234789435, 9777.902220977789, 9782.510874456275, 9555.522223888813, 9770.120689137977, 9990.050945160216, 9999.550020249088, 10004.349717268391, 2069.2757534862826, 2108.5572029873747, 2110.3352443980175, 2114.6510825713817, 2118.745750509941, 1739.782527184102, 1824.3249997500943, 2062.9587408251828, 2073.1292857000094, 2112.41908475169, 2004.5690176612025, 2077.0, 2083.5832833433296, 2085.979140208601, 2086.54096098858, 1981.980180198194, 2068.0383621615947, 2069.813716765498, 2076.2317942361346, 2076.595063962528, 1749.4664127441126, 1832.2670931627322, 2092.790720927895, 2093.1418118571464, 2096.937091887246, 9654.71035868925, 9959.452230127341, 9968.40189588627, 9990.500474976223, 10025.749356266078, 5309.761060752276, 5488.25908502355, 5494.1758736189495, 5498.890022199534, 5499.862503437406, 3065.509518477033, 3240.659730728287, 3290.3805813604845, 3301.8679252829857, 3302.240484688511, 1108.2740804772886, 1136.323887287063, 1146.656003199037, 1191.9582814601447, 1199.412287978893, 13820.654483637889, 14060.507882224074, 14079.507217247346, 14096.224707641075, 14115.576532704137, 4340.47914250292, 4484.484284307281, 4663.976680116578, 4765.356676848651, 4791.5687588117235, 10719.303245289031, 10725.0, 10727.463626818628, 10729.409882456384, 10731.141508679288, 5261.789528418821, 5358.91961620576, 5360.812371566976, 5362.731863406814, 5362.758675859595, 4823.517648235148, 4876.195427754381, 4911.8280860169725, 4957.454679985199, 5018.0, 3628.8911332660064, 3674.9081272967856, 3678.33789917812, 3762.774233545996, 3766.9058273542832, 1044.5560636729513, 1046.5029111172285, 1050.9264351495474, 1057.7249915021996, 1070.261519551507, 660.3495556876472, 687.1101923009714, 691.3915754136328, 693.8751024815582, 704.5702121705858, 5663.858403539944, 5791.362950075489, 5799.2750906136735, 5852.4440178183, 6065.5450841187085, 814.1166833985075, 815.9184081591912, 828.556722153645, 830.1739768929954, 857.9656813727506, 3551.236484155919, 3602.963970360315, 3638.1086633774894, 3741.7567858089683, 3858.401947698111, 12138.0, 12699.936500317439, 12729.363531823372, 12754.61736147917, 12804.80792788109, 12389.132760706845, 12609.87390126087, 12659.556915507914, 12692.238465692088, 12694.80957785634, 9237.12247336502, 9272.119148680864, 9350.812983740423, 9354.251659867194, 9355.06449355059, 5522.861928451821, 5573.108302671553, 5645.633033852787, 5654.886902262014, 5691.4877661010705, 11221.438928053727, 11492.253003554742, 11513.13651476126, 11640.904637165053, 11647.41762911868, 11816.172867899164, 11838.704032399259, 11906.10704197206, 11981.700457488632, 12096.818547721616, 7405.0, 7434.628268586441, 7538.3215510604305, 7557.622118894144, 7636.236376362319, 8940.105989401009, 9185.0, 9202.815943681222, 9218.492982886006, 9218.539073046186, 7503.699852005859, 7575.393968482618, 7662.501937374052, 7747.573883436465, 7853.450258481851, 7738.651760670671, 7818.765437036898, 7862.17447168062, 7864.21357864209, 7905.56519391439, 7007.6846541904715, 7087.929120708727, 7127.429805615435, 7145.285471452813, 7152.642367881481, 5040.924386134137, 5139.897202056013, 5180.145276029563, 5194.3766747990485, 5274.446183150714, 5178.766955487087, 5190.870228244324, 5198.116320225647, 5226.268322434938, 5409.702466364388], "value": 4591.23772782258, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.0547330417827, 367.5919729100698, 390.0871959614502, 394.4438341937868, 397.9880603581893, 5072.44203137655, 5107.948920510794, 5154.793808247675, 5237.135872581029, 5257.973710131453, 5048.823291184809, 5095.592352611791, 5177.223416487529, 5204.973975130129, 5214.947850521494, 4127.525334586516, 4143.564925682806, 4145.834166633331, 4146.295129827921, 4146.917061658757, 3964.1278918637854, 4091.9590804091877, 4139.254934111858, 4144.626983571478, 4161.313383291753, 4022.1955608878193, 4088.652464540503, 4095.4675892133982, 4100.63094321511, 4108.52751933527, 4089.9386509202086, 4092.069056786565, 4093.97953010236, 4095.488063992001, 4101.5488296287385, 3561.0, 3675.650813172744, 3710.628937106295, 3723.925521489555, 3732.085639018431, 4916.237983112587, 5145.048166089286, 5163.889763700822, 5165.405978312505, 5182.818601348935, 4921.064997650471, 4921.458639549646, 4929.580985616227, 4935.728534930578, 4938.753062346868, 5501.826778422501, 5575.052241118979, 5624.746886390081, 5637.3235211774845, 5637.985162670718, 4243.321068629005, 4245.087306229176, 4251.149770046003, 4252.957470425287, 4253.9365158710325, 5826.70866456684, 5833.183354330397, 5841.503472204868, 5843.211166492511, 5868.882622347529, 4268.658507319407, 4330.58859408362, 4373.693841431069, 4380.189664911938, 4388.736675799399, 4164.83340666376, 4452.532484089189, 4457.509673935864, 4460.598546130864, 4471.23988921884, 4681.461631912373, 4754.120487709784, 4826.155422801066, 4834.105690447279, 4840.830570930071, 5548.805791797267, 5567.805126820623, 5572.136318870582, 5578.860528486739, 5596.1605759136455, 1497.2139626695855, 1525.8931874768882, 1544.0735558664712, 1546.072356586062, 1547.7772559677953, 1065.9680209593726, 1084.9620263290747, 1086.8532748079067, 1090.7109615951779, 1109.339942734088, 4836.685615434985, 4859.319695242669, 4864.927026094611, 4870.902581948412, 4897.41231052276, 5699.74351154199, 5763.135529670583, 5766.452187042224, 5775.16260142277, 5782.335031471351, 4658.697184682985, 4860.0, 4861.1006963711825, 4875.122477953932, 4877.561019508261, 2988.925276868096, 3034.5903303054247, 3054.3738533601004, 3056.7554595632296, 3057.1287183152695, 5372.018529716045, 5377.7311134443125, 5383.327084114486, 5425.403205647375, 5428.67427954324, 5723.0, 5845.590808643439, 5870.412958704181, 5888.823335299948, 5897.144913987448, 5353.652012619245, 5378.542823860016, 5384.300040994645, 5392.245085688085, 5413.675179489322, 5582.358028826737, 5725.456081672234, 5728.856778580569, 5746.396628353963, 5748.45389687979, 5622.325320961347, 5633.324001119892, 5657.575681823797, 5664.291963504562, 5680.829575112753, 5358.946410535845, 5364.497940576644, 5376.327959005124, 5382.434844341287, 5386.111291636836, 3855.4000089963474, 4007.29872272357, 4016.0160760613835, 4028.831638824708, 4038.0712436139265, 5465.836024919259, 5590.916136257878, 5633.352164501135, 5735.971320143372, 5749.482546570829, 5541.251930989265, 5544.916826247691, 5554.583406244628, 5563.721813909369, 5579.302587176603, 5294.782200093923, 5532.889342213052, 5550.611457197957, 5571.690652696694, 5578.2748242728185, 5458.645188062763, 5499.972500137474, 5502.614816962934, 5508.9724551376985, 5511.944880551304, 5557.472040156179, 5570.777168913198, 5573.637713548606, 5583.888322233452, 5655.915161272502, 5190.091733946469, 5375.919361209507, 5407.134858422633, 5483.341998960151, 5486.393962867606], "value": 4254.455641660795, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.474972769334, 745.9738909138181, 759.5974133709133, 776.2237762237762, 777.3975169243837, 12186.0, 12436.378181090944, 12483.126181167321, 12490.50037998479, 13580.320983950813, 13580.728385432285, 13615.523456679019, 13723.931380343109, 13732.313384330793, 13745.24401157936, 865.1002956924806, 890.3011136258007, 894.4275663575316, 895.400081945095, 898.2320116300567, 883.4699180491718, 920.1028996728203, 926.8146370725882, 927.2581934452411, 935.2377812083131, 946.9384490008161, 947.6114792934898, 949.3544389814923, 951.1249650321721, 963.2390411574847, 951.5385038256475, 952.0431965874321, 953.6423841059602, 955.0497255231055, 965.826151292767, 696.853660731242, 697.3897839390534, 697.7418355208605, 701.4353445476389, 707.9469039822034, 13983.440662373492, 14093.64765880851, 14150.080244784056, 14210.14739115646, 14488.34802433893, 13570.321483925763, 14178.787318190236, 14257.215853128073, 14330.92834535831, 14382.928085359506, 12334.383280835922, 12421.565245216465, 12468.43892024852, 12484.438200281009, 12614.621561353175, 2915.28575499002, 2954.6602140753876, 2956.586077949089, 2957.8964736234343, 2958.541426078961, 68655.65672171657, 69583.65208173977, 69589.65205173942, 69744.6512767438, 71326.0, 10551.103156231653, 10587.417692027013, 10651.520681569347, 10965.56137754497, 11226.494807733508, 21366.145354185657, 21864.781352186274, 21868.562628747335, 21944.0, 22059.11763529473, 6498.837529061811, 6599.670016499252, 6651.833704157435, 6681.298463661343, 6902.309769023058, 3264.396086723964, 3315.237495376077, 3322.850471728778, 3326.9833650831592, 3378.7634865559176, 3445.9827700861333, 3491.284286721216, 3492.5285086512995, 3495.5106285120105, 3511.367953768295, 728.2208037400037, 739.663453128825, 743.4684200796456, 744.553268039183, 746.958917259556, 591.7573794744134, 598.5630489742513, 601.2424345324922, 601.6089541797867, 628.0704557255197, 8297.784846187666, 9000.0, 9071.682491112912, 9119.0, 9314.813703725888, 586.4194447496948, 605.9484943779828, 610.9327973922865, 621.1304174156127, 621.7171187109855, 3971.702122340836, 4081.9387709184384, 4137.275976704125, 4175.55729898013, 4282.0, 63387.683061584394, 63884.0, 64788.67605661941, 66031.0, 66151.66924165444, 53225.7338713304, 53504.73247633737, 55941.720291398284, 57546.424535754944, 58479.4152058474, 39700.60299397027, 46640.7667961658, 46781.766091169324, 47245.76377118092, 48155.5184448158, 8807.779805504913, 9322.580483878377, 9346.392484488486, 9436.716898493056, 9470.242380609672, 26431.867840660674, 26581.468370632865, 26581.734182657925, 26593.601095983187, 27638.585421218297, 30926.690733092382, 31191.220219493785, 31231.531527027568, 31427.214319642193, 32138.83930580332, 11286.379249141048, 11317.320960742381, 11360.375179365214, 11443.48504317291, 11471.13966452536, 12663.936680316909, 12750.553730619384, 13246.80129798073, 13267.087685692506, 13718.38267277955, 10963.397013164353, 11068.944655276671, 11433.714157146138, 11434.94282528582, 11598.594049208237, 10912.563497460013, 11000.724981875517, 11017.394043327695, 11380.374079425712, 11716.824247636463, 11118.813806999218, 11150.832737508781, 11218.887811122111, 11550.422478876191, 11984.520619175484, 9358.485283309483, 9362.625494980124, 9467.810643786948, 9507.382020168667, 9881.258905581966, 8900.243479304072, 9534.52327383642, 9562.426254424758, 9708.320417570701, 9745.756356091155], "value": 6478.256917296606, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1561.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 113.0, 113.0, 114.0, 112.0, 112.0, 112.0, 112.0, 111.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 126.0, 123.0, 167.0, 125.0, 123.0, 125.0, 123.0, 147.0, 125.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 165.0, 166.0, 166.0, 166.0, 166.0, 166.0, 167.0, 167.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 116.0, 76.0, 77.0, 82.0, 79.0, 97.0, 80.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 112.0, 85.0, 84.0, 84.0, 113.0, 83.0, 83.0, 106.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 124.0, 122.0, 119.0, 114.0, 115.0, 114.0, 114.0, 115.0, 114.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 153.0, 150.0, 150.0, 151.0, 150.0, 152.0, 151.0, 150.0, 151.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 54.0, 55.0, 54.0, 54.0, 54.0, 54.0, 55.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 56.0, 57.0, 56.0, 56.0, 57.0, 56.0, 56.0, 56.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 84.0, 82.0, 83.0, 96.0, 82.0, 94.0, 82.0, 83.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 136.0, 153.0, 134.0, 141.0, 134.0, 142.0, 152.0, 196.0, 137.0], "value": 146.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 201.0, 196.0, 197.0, 202.0, 193.0, 198.0, 196.0, 196.0, 196.0], "value": 197.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 72.0, 72.0, 72.0, 71.0, 71.0, 71.0, 69.0, 74.0, 70.0], "value": 72.1, "unit": "score"}]}]} 12:07:44 INFO - Return code: 0 12:07:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:07:44 ERROR - # TBPL SUCCESS # 12:07:44 INFO - Running post-action listener: _resource_record_post_action 12:07:44 INFO - [mozharness: 2017-04-04 19:07:44.095122Z] Finished run-tests step (success) 12:07:44 INFO - Running post-run listener: _resource_record_post_run 12:07:44 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 0; Write bytes: 357019648; Read time: 0; Write time: 174932 12:07:44 INFO - TinderboxPrint: CPU usage
13.0% 12:07:44 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:07:44 INFO - TinderboxPrint: I/O write bytes / time
357,019,648 / 174,932 12:07:44 INFO - TinderboxPrint: CPU idle
8,367.0 (87.0%) 12:07:44 INFO - TinderboxPrint: CPU user
1,204.7 (12.5%) 12:07:44 INFO - TinderboxPrint: Swap in / out
0 / 0 12:07:44 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 100888576; Read time: 0; Write time: 57744 12:07:44 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 256131072; Read time: 0; Write time: 117188 12:07:44 INFO - Running post-run listener: _upload_blobber_files 12:07:44 INFO - Blob upload gear active. 12:07:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:07:44 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 12:07:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:07:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:07:45 INFO - (blobuploader) - INFO - Open directory for files ... 12:07:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:07:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:07:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:07:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:07:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:07:46 INFO - (blobuploader) - INFO - Done attempting. 12:07:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:07:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:07:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:07:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:07:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:07:47 INFO - (blobuploader) - INFO - Done attempting. 12:07:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:07:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:07:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:07:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:07:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:07:51 INFO - (blobuploader) - INFO - Done attempting. 12:07:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:07:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:07:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:07:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:07:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:07:52 INFO - (blobuploader) - INFO - Done attempting. 12:07:52 INFO - (blobuploader) - INFO - Iteration through files over. 12:07:52 INFO - Return code: 0 12:07:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:07:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:07:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c40abc618b7fc6fb284384c5ba46c2bb088972f9b273770f757bedeb423ed9ab0e199e20337aab01b4efdf8735d0ec8ea1cc1a941276e46134c0a5779ff68f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/58fc05a9411ea819ecdb6ec38a70f20434a56cc91ffcc9b76df0cfb0a116d288a9256f330e48546ad6883e14eeac4bcd3a12ede0d53afa74ecaa142b693fa779", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5effe70cd818c9db21daf6073834bb1c1d7b5bb2c16ff7ff3feae0a1db7000bfef1c6263cc31d5887728003ff69e780318ad9a546eff2bf84d6bbac6ab3b5622", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e4b9b94c41a158f7760058c6a8341d503d028fb9a3f15fb410be86795f728be54e0cb4c271af18ecfce7c5b28e3babe8970d9b285cfa052c5d3325d6f723ef2d"} 12:07:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:07:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:07:52 INFO - Contents: 12:07:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c40abc618b7fc6fb284384c5ba46c2bb088972f9b273770f757bedeb423ed9ab0e199e20337aab01b4efdf8735d0ec8ea1cc1a941276e46134c0a5779ff68f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/58fc05a9411ea819ecdb6ec38a70f20434a56cc91ffcc9b76df0cfb0a116d288a9256f330e48546ad6883e14eeac4bcd3a12ede0d53afa74ecaa142b693fa779", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5effe70cd818c9db21daf6073834bb1c1d7b5bb2c16ff7ff3feae0a1db7000bfef1c6263cc31d5887728003ff69e780318ad9a546eff2bf84d6bbac6ab3b5622", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e4b9b94c41a158f7760058c6a8341d503d028fb9a3f15fb410be86795f728be54e0cb4c271af18ecfce7c5b28e3babe8970d9b285cfa052c5d3325d6f723ef2d"} 12:07:52 INFO - Running post-run listener: copy_logs_to_upload_dir 12:07:52 INFO - Copying logs to upload dir... 12:07:52 INFO - mkdir: /builds/slave/test/build/upload/logs 12:07:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.458635 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-04-04 12:07:51.957239) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 12:07:51.961136) ========= 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=bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c40abc618b7fc6fb284384c5ba46c2bb088972f9b273770f757bedeb423ed9ab0e199e20337aab01b4efdf8735d0ec8ea1cc1a941276e46134c0a5779ff68f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/58fc05a9411ea819ecdb6ec38a70f20434a56cc91ffcc9b76df0cfb0a116d288a9256f330e48546ad6883e14eeac4bcd3a12ede0d53afa74ecaa142b693fa779", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5effe70cd818c9db21daf6073834bb1c1d7b5bb2c16ff7ff3feae0a1db7000bfef1c6263cc31d5887728003ff69e780318ad9a546eff2bf84d6bbac6ab3b5622", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e4b9b94c41a158f7760058c6a8341d503d028fb9a3f15fb410be86795f728be54e0cb4c271af18ecfce7c5b28e3babe8970d9b285cfa052c5d3325d6f723ef2d"} build_url:https://queue.taskcluster.net/v1/task/SNg9V_WgQVCpeEg5um3wdw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011202 build_url: 'https://queue.taskcluster.net/v1/task/SNg9V_WgQVCpeEg5um3wdw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c40abc618b7fc6fb284384c5ba46c2bb088972f9b273770f757bedeb423ed9ab0e199e20337aab01b4efdf8735d0ec8ea1cc1a941276e46134c0a5779ff68f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/58fc05a9411ea819ecdb6ec38a70f20434a56cc91ffcc9b76df0cfb0a116d288a9256f330e48546ad6883e14eeac4bcd3a12ede0d53afa74ecaa142b693fa779", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5effe70cd818c9db21daf6073834bb1c1d7b5bb2c16ff7ff3feae0a1db7000bfef1c6263cc31d5887728003ff69e780318ad9a546eff2bf84d6bbac6ab3b5622", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e4b9b94c41a158f7760058c6a8341d503d028fb9a3f15fb410be86795f728be54e0cb4c271af18ecfce7c5b28e3babe8970d9b285cfa052c5d3325d6f723ef2d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 12:07:51.986867) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 12:07:51.987225) ========= 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=bb9b54edd4a927dc735d112f000001d9-1491328645.624144-1143437970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004380 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 12:07:52.070632) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 12:07:52.070979) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 12:07:52.071321) ========= ========= Total master_lag: 0.17 =========