builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-026 starttime: 1490139524.85 results: success (0) revision: 8744e9f8eb99f1290aae81985812d57364f18708 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 16:38:44.847903) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 16:38:44.848618) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 16:38:44.849098) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 16:38:44.864157) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 16:38:44.864449) ========= 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=41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-21 16:38:44-- 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% 46.4M=0s 2017-03-21 16:38:44 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.103793 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 16:38:44.981709) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 16:38:44.982014) ========= 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=41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015089 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 16:38:45.030854) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 16:38:45.031203) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8744e9f8eb99f1290aae81985812d57364f18708 --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 8744e9f8eb99f1290aae81985812d57364f18708 --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=41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-21 16:38:45,066 truncating revision to first 12 chars 2017-03-21 16:38:45,066 Setting DEBUG logging. 2017-03-21 16:38:45,066 attempt 1/10 2017-03-21 16:38:45,066 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8744e9f8eb99?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-21 16:38:45,419 unpacking tar archive at: mozilla-central-8744e9f8eb99/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661961 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 16:38:45.705971) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 16:38:45.706393) ========= script_repo_revision: 8744e9f8eb99f1290aae81985812d57364f18708 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 16:38:45.706752) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 16:38:45.707011) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 16:38:45.715748) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-21 16:38:45.716018) ========= /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=41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:38:45 INFO - MultiFileLogger online at 20170321 16:38:45 in /builds/slave/test 16:38:45 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 16:38:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:38:45 INFO - {'append_to_log': False, 16:38:45 INFO - 'base_work_dir': '/builds/slave/test', 16:38:45 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:38:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:38:45 INFO - 'branch': 'Firefox-Non-PGO', 16:38:45 INFO - 'buildbot_json_path': 'buildprops.json', 16:38:45 INFO - 'config_files': ('talos/linux_config.py',), 16:38:45 INFO - 'default_actions': ('clobber', 16:38:45 INFO - 'read-buildbot-config', 16:38:45 INFO - 'download-and-extract', 16:38:45 INFO - 'populate-webroot', 16:38:45 INFO - 'create-virtualenv', 16:38:45 INFO - 'install', 16:38:45 INFO - 'run-tests'), 16:38:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:38:45 INFO - 'download_minidump_stackwalk': True, 16:38:45 INFO - 'download_symbols': 'ondemand', 16:38:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:38:45 INFO - 'tooltool.py': '/tools/tooltool.py', 16:38:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:38:45 INFO - '/tools/misc-python/virtualenv.py')}, 16:38:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:38:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:38:45 INFO - 'gecko_profile': False, 16:38:45 INFO - 'gecko_profile_interval': 0, 16:38:45 INFO - 'installer_path': 'installer.exe', 16:38:45 INFO - 'log_level': 'info', 16:38:45 INFO - 'log_name': 'talos', 16:38:45 INFO - 'log_to_console': True, 16:38:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:38:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:38:45 INFO - 'opt_config_files': (), 16:38:45 INFO - 'pip_index': False, 16:38:45 INFO - 'suite': 'dromaeojs', 16:38:45 INFO - 'system_bits': '32', 16:38:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:38:45 INFO - 'title': 'talos-linux64-ix-026', 16:38:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:38:45 INFO - 'use_talos_json': True, 16:38:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:38:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:38:45 INFO - 'work_dir': 'build'} 16:38:45 INFO - [mozharness: 2017-03-21 23:38:45.852527Z] Running clobber step. 16:38:45 INFO - Running pre-action listener: _resource_record_pre_action 16:38:45 INFO - Running main action method: clobber 16:38:45 INFO - rmtree: /builds/slave/test/build 16:38:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:38:46 INFO - Running post-action listener: _resource_record_post_action 16:38:46 INFO - [mozharness: 2017-03-21 23:38:46.772755Z] Finished clobber step (success) 16:38:46 INFO - [mozharness: 2017-03-21 23:38:46.772853Z] Running read-buildbot-config step. 16:38:46 INFO - Running pre-action listener: _resource_record_pre_action 16:38:46 INFO - Running main action method: read_buildbot_config 16:38:46 INFO - Using buildbot properties: 16:38:46 INFO - { 16:38:46 INFO - "project": "", 16:38:46 INFO - "product": "firefox", 16:38:46 INFO - "who": "kwierso@gmail.com", 16:38:46 INFO - "installer_path": "public/build/target.tar.bz2", 16:38:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:38:46 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:38:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 16:38:46 INFO - "stage_platform": "linux64", 16:38:46 INFO - "basedir": "/builds/slave/test", 16:38:46 INFO - "buildnumber": 888, 16:38:46 INFO - "platform": "ubuntu64_hw", 16:38:46 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:38:46 INFO - "slavebuilddir": "test", 16:38:46 INFO - "taskId": "Y886NGslRzqfe-DTQVSLGw", 16:38:46 INFO - "branch": "mozilla-central", 16:38:46 INFO - "script_repo_revision": "production", 16:38:46 INFO - "revision": "8744e9f8eb99f1290aae81985812d57364f18708", 16:38:46 INFO - "slavename": "talos-linux64-ix-026", 16:38:46 INFO - "repo_path": "mozilla-central" 16:38:46 INFO - } 16:38:46 INFO - Finding installer, test and symbols from parent task. 16:38:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y886NGslRzqfe-DTQVSLGw'}, attempt #1 16:38:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y886NGslRzqfe-DTQVSLGw'}, attempt #1 16:38:47 INFO - Task dependencies: HuOhXf_MT0-mU7I9TNQtaQ 16:38:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HuOhXf_MT0-mU7I9TNQtaQ'}, attempt #1 16:38:48 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HuOhXf_MT0-mU7I9TNQtaQ/artifacts/public/build/target.tar.bz2 16:38:48 INFO - Set test_url: https://queue.taskcluster.net/v1/task/HuOhXf_MT0-mU7I9TNQtaQ/artifacts/public/build/test_packages.json 16:38:48 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HuOhXf_MT0-mU7I9TNQtaQ/artifacts/public/build/target.crashreporter-symbols.zip 16:38:48 INFO - Running post-action listener: _resource_record_post_action 16:38:48 INFO - [mozharness: 2017-03-21 23:38:48.176978Z] Finished read-buildbot-config step (success) 16:38:48 INFO - [mozharness: 2017-03-21 23:38:48.177195Z] Running download-and-extract step. 16:38:48 INFO - Running pre-action listener: _resource_record_pre_action 16:38:48 INFO - Running main action method: download_and_extract 16:38:48 INFO - mkdir: /builds/slave/test/build/tests 16:38:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:48 INFO - trying https://queue.taskcluster.net/v1/task/HuOhXf_MT0-mU7I9TNQtaQ/artifacts/public/build/target.test_packages.json 16:38:48 INFO - Downloading https://queue.taskcluster.net/v1/task/HuOhXf_MT0-mU7I9TNQtaQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:38:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HuOhXf_MT0-mU7I9TNQtaQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:38:48 INFO - Downloaded 986 bytes. 16:38:48 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:38:48 INFO - Using the following test package requirements: 16:38:48 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:38:48 INFO - u'common': [u'target.common.tests.zip'], 16:38:48 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:38:48 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:38:48 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:38:48 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:38:48 INFO - u'mozbase': [u'target.common.tests.zip'], 16:38:48 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:38:48 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:38:48 INFO - u'web-platform': [u'target.common.tests.zip', 16:38:48 INFO - u'target.web-platform.tests.zip'], 16:38:48 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:38:48 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:38:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HuOhXf_MT0-mU7I9TNQtaQ/artifacts/public/build/target.common.tests.zip 16:38:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HuOhXf_MT0-mU7I9TNQtaQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:38:48 INFO - Fetch https://queue.taskcluster.net/v1/task/HuOhXf_MT0-mU7I9TNQtaQ/artifacts/public/build/target.common.tests.zip into memory 16:38:49 INFO - Expected file size: 58193451 16:38:49 INFO - Obtained file size: 58193451 16:38:59 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:38:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HuOhXf_MT0-mU7I9TNQtaQ/artifacts/public/build/target.common.tests.zip 16:38:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HuOhXf_MT0-mU7I9TNQtaQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:38:59 INFO - Fetch https://queue.taskcluster.net/v1/task/HuOhXf_MT0-mU7I9TNQtaQ/artifacts/public/build/target.common.tests.zip into memory 16:39:00 INFO - Expected file size: 58193451 16:39:00 INFO - Obtained file size: 58193451 16:39:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HuOhXf_MT0-mU7I9TNQtaQ/artifacts/public/build/target.talos.tests.zip 16:39:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HuOhXf_MT0-mU7I9TNQtaQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:39:11 INFO - Fetch https://queue.taskcluster.net/v1/task/HuOhXf_MT0-mU7I9TNQtaQ/artifacts/public/build/target.talos.tests.zip into memory 16:39:12 INFO - Expected file size: 14404171 16:39:12 INFO - Obtained file size: 14404171 16:39:12 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')]} 16:39:12 INFO - trying https://queue.taskcluster.net/v1/task/HuOhXf_MT0-mU7I9TNQtaQ/artifacts/public/build/target.tar.bz2 16:39:12 INFO - Downloading https://queue.taskcluster.net/v1/task/HuOhXf_MT0-mU7I9TNQtaQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:39:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HuOhXf_MT0-mU7I9TNQtaQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:39:13 INFO - Downloaded 61893342 bytes. 16:39:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HuOhXf_MT0-mU7I9TNQtaQ/artifacts/public/build/target.tar.bz2 16:39:13 INFO - mkdir: /builds/slave/test/properties 16:39:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:39:13 INFO - Writing to file /builds/slave/test/properties/build_url 16:39:13 INFO - Contents: 16:39:13 INFO - build_url:https://queue.taskcluster.net/v1/task/HuOhXf_MT0-mU7I9TNQtaQ/artifacts/public/build/target.tar.bz2 16:39:13 INFO - Running post-action listener: _resource_record_post_action 16:39:13 INFO - Running post-action listener: set_extra_try_arguments 16:39:13 INFO - [mozharness: 2017-03-21 23:39:13.870159Z] Finished download-and-extract step (success) 16:39:13 INFO - [mozharness: 2017-03-21 23:39:13.870256Z] Running populate-webroot step. 16:39:13 INFO - Running pre-action listener: _resource_record_pre_action 16:39:13 INFO - Running main action method: populate_webroot 16:39:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:39:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:39:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:39:13 INFO - '--tppagecycles', 16:39:13 INFO - '7'], 16:39:13 INFO - 'tests': ['tsvgm']}}, 16:39:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:39:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:39:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:39:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:39:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:39:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:39:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:39:13 INFO - 'talos_options': ['--disable-e10s'], 16:39:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:39:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:39:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:39:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:39:13 INFO - 'talos_options': ['--disable-e10s'], 16:39:13 INFO - 'tests': ['damp', 'tps']}, 16:39:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:39:13 INFO - 'tests': ['damp', 'tps']}, 16:39:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:39:13 INFO - 'tests': ['dromaeo_dom']}, 16:39:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:39:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:39:13 INFO - 'tests': ['basic_compositor_video']}, 16:39:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:39:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:39:13 INFO - 'tests': ['a11yr', 16:39:13 INFO - 'ts_paint', 16:39:13 INFO - 'tpaint', 16:39:13 INFO - 'sessionrestore', 16:39:13 INFO - 'sessionrestore_no_auto_restore', 16:39:13 INFO - 'tabpaint']}, 16:39:13 INFO - 'other-e10s': {'tests': ['a11yr', 16:39:13 INFO - 'ts_paint', 16:39:13 INFO - 'tpaint', 16:39:13 INFO - 'sessionrestore', 16:39:13 INFO - 'sessionrestore_no_auto_restore', 16:39:13 INFO - 'tabpaint']}, 16:39:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:39:13 INFO - 'ts_paint', 16:39:13 INFO - 'tpaint', 16:39:13 INFO - 'sessionrestore', 16:39:13 INFO - 'sessionrestore_no_auto_restore', 16:39:13 INFO - 'tabpaint']}, 16:39:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:39:13 INFO - 'ts_paint', 16:39:13 INFO - 'tpaint', 16:39:13 INFO - 'sessionrestore', 16:39:13 INFO - 'sessionrestore_no_auto_restore', 16:39:13 INFO - 'tabpaint']}, 16:39:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:39:13 INFO - 'tests': ['a11yr', 16:39:13 INFO - 'ts_paint', 16:39:13 INFO - 'tpaint', 16:39:13 INFO - 'sessionrestore', 16:39:13 INFO - 'sessionrestore_no_auto_restore', 16:39:13 INFO - 'tabpaint']}, 16:39:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:39:13 INFO - 'tests': ['a11yr', 16:39:13 INFO - 'ts_paint', 16:39:13 INFO - 'tpaint', 16:39:13 INFO - 'sessionrestore', 16:39:13 INFO - 'sessionrestore_no_auto_restore', 16:39:13 INFO - 'tabpaint']}, 16:39:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:39:13 INFO - 'tests': ['tsvgx', 16:39:13 INFO - 'tsvgr_opacity', 16:39:13 INFO - 'tart', 16:39:13 INFO - 'tscrollx', 16:39:13 INFO - 'cart', 16:39:13 INFO - 'tsvg_static']}, 16:39:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:39:13 INFO - 'tsvgr_opacity', 16:39:13 INFO - 'tart', 16:39:13 INFO - 'tscrollx', 16:39:13 INFO - 'cart', 16:39:13 INFO - 'tsvg_static']}, 16:39:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:39:13 INFO - 'talos_options': ['--disable-e10s'], 16:39:13 INFO - 'tests': ['tp5o']}, 16:39:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:39:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:39:13 INFO - 'talos_options': ['--disable-e10s', 16:39:13 INFO - '--xperf_path', 16:39:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:39:13 INFO - 'tests': ['tp5n']}, 16:39:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:39:13 INFO - 'talos_options': ['--xperf_path', 16:39:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:39:13 INFO - 'tests': ['tp5n']}}, 16:39:13 INFO - 'talos.zip': {'path': '', 16:39:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:39:13 INFO - Running post-action listener: _resource_record_post_action 16:39:13 INFO - [mozharness: 2017-03-21 23:39:13.883490Z] Finished populate-webroot step (success) 16:39:13 INFO - [mozharness: 2017-03-21 23:39:13.883579Z] Running create-virtualenv step. 16:39:13 INFO - Running pre-action listener: _resource_record_pre_action 16:39:13 INFO - Running main action method: create_virtualenv 16:39:13 INFO - Creating virtualenv /builds/slave/test/build/venv 16:39:13 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 16:39:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:39:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:39:13 INFO - Using real prefix '/usr' 16:39:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:39:14 INFO - Installing distribute.............................................................................................................................................................................................done. 16:39:16 INFO - Installing pip.................done. 16:39:16 INFO - Return code: 0 16:39:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:39:16 INFO - Reading from file tmpfile_stdout 16:39:16 INFO - Output received: 16:39:16 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) 16:39:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:39:16 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')]} 16:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:16 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')]} 16:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:16 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 0xe621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ffb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd290>, '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 0x10fdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe040>, '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': '41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628', '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 16:39:16 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 16:39:16 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 16:39:16 INFO - Using env: {'DISPLAY': ':0', 16:39:16 INFO - 'HOME': '/home/cltbld', 16:39:16 INFO - 'LANG': 'en_US.UTF-8', 16:39:16 INFO - 'LANGUAGE': 'en_US:en', 16:39:16 INFO - 'LOGNAME': 'cltbld', 16:39:16 INFO - 'MAIL': '/var/mail/cltbld', 16:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:16 INFO - 'MOZ_NO_REMOTE': '1', 16:39:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:16 INFO - 'NO_EM_RESTART': '1', 16:39:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:16 INFO - 'PWD': '/builds/slave/test', 16:39:16 INFO - 'SHELL': '/bin/bash', 16:39:16 INFO - 'SHLVL': '1', 16:39:16 INFO - 'TERM': 'linux', 16:39:16 INFO - 'TMOUT': '86400', 16:39:16 INFO - 'USER': 'cltbld', 16:39:16 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628', 16:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:16 INFO - '_': '/tools/buildbot/bin/python'} 16:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:16 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 16:39:16 INFO - Cleaning up... 16:39:16 INFO - Return code: 0 16:39:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:39:16 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')]} 16:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:16 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')]} 16:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:16 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 0xe621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ffb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd290>, '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 0x10fdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe040>, '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': '41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628', '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 16:39:16 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 16:39:16 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 16:39:16 INFO - Using env: {'DISPLAY': ':0', 16:39:16 INFO - 'HOME': '/home/cltbld', 16:39:16 INFO - 'LANG': 'en_US.UTF-8', 16:39:16 INFO - 'LANGUAGE': 'en_US:en', 16:39:16 INFO - 'LOGNAME': 'cltbld', 16:39:16 INFO - 'MAIL': '/var/mail/cltbld', 16:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:16 INFO - 'MOZ_NO_REMOTE': '1', 16:39:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:16 INFO - 'NO_EM_RESTART': '1', 16:39:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:16 INFO - 'PWD': '/builds/slave/test', 16:39:16 INFO - 'SHELL': '/bin/bash', 16:39:16 INFO - 'SHLVL': '1', 16:39:16 INFO - 'TERM': 'linux', 16:39:16 INFO - 'TMOUT': '86400', 16:39:16 INFO - 'USER': 'cltbld', 16:39:16 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628', 16:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:16 INFO - '_': '/tools/buildbot/bin/python'} 16:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:17 INFO - Downloading/unpacking psutil>=3.1.1 16:39:17 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 16:39:17 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 16:39:17 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 16:39:17 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 16:39:17 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 16:39:17 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 16:39:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:39:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:39:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:39:19 INFO - Installing collected packages: psutil 16:39:19 INFO - Running setup.py install for psutil 16:39:19 INFO - building 'psutil._psutil_linux' extension 16:39:19 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 16:39:19 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 16:39:19 INFO - building 'psutil._psutil_posix' extension 16:39:19 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 16:39:19 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 16:39:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:39:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:39:19 INFO - Successfully installed psutil 16:39:19 INFO - Cleaning up... 16:39:19 INFO - Return code: 0 16:39:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:39: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')]} 16:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39: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')]} 16:39:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ffb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd290>, '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 0x10fdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe040>, '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': '41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628', '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 16:39: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:39: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 mozsystemmonitor==0.3 16:39:19 INFO - Using env: {'DISPLAY': ':0', 16:39:19 INFO - 'HOME': '/home/cltbld', 16:39:19 INFO - 'LANG': 'en_US.UTF-8', 16:39:19 INFO - 'LANGUAGE': 'en_US:en', 16:39:19 INFO - 'LOGNAME': 'cltbld', 16:39:19 INFO - 'MAIL': '/var/mail/cltbld', 16:39:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:19 INFO - 'MOZ_NO_REMOTE': '1', 16:39:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:19 INFO - 'NO_EM_RESTART': '1', 16:39:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:19 INFO - 'PWD': '/builds/slave/test', 16:39:19 INFO - 'SHELL': '/bin/bash', 16:39:19 INFO - 'SHLVL': '1', 16:39:19 INFO - 'TERM': 'linux', 16:39:19 INFO - 'TMOUT': '86400', 16:39:19 INFO - 'USER': 'cltbld', 16:39:19 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628', 16:39:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:19 INFO - '_': '/tools/buildbot/bin/python'} 16:39:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:39: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 16:39: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 16:39: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 16:39: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 16:39: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 16:39: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 16:39:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:39:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:39:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:39:22 INFO - Installing collected packages: mozsystemmonitor 16:39:22 INFO - Running setup.py install for mozsystemmonitor 16:39:22 INFO - Successfully installed mozsystemmonitor 16:39:22 INFO - Cleaning up... 16:39:22 INFO - Return code: 0 16:39:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:39: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')]} 16:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39: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')]} 16:39:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39: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', '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 0xe621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ffb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd290>, '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 0x10fdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe040>, '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': '41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628', '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 16:39: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:39: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 jsonschema==2.5.1 16:39:22 INFO - Using env: {'DISPLAY': ':0', 16:39:22 INFO - 'HOME': '/home/cltbld', 16:39:22 INFO - 'LANG': 'en_US.UTF-8', 16:39:22 INFO - 'LANGUAGE': 'en_US:en', 16:39:22 INFO - 'LOGNAME': 'cltbld', 16:39:22 INFO - 'MAIL': '/var/mail/cltbld', 16:39:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:22 INFO - 'MOZ_NO_REMOTE': '1', 16:39:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:22 INFO - 'NO_EM_RESTART': '1', 16:39:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:22 INFO - 'PWD': '/builds/slave/test', 16:39:22 INFO - 'SHELL': '/bin/bash', 16:39:22 INFO - 'SHLVL': '1', 16:39:22 INFO - 'TERM': 'linux', 16:39:22 INFO - 'TMOUT': '86400', 16:39:22 INFO - 'USER': 'cltbld', 16:39:22 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628', 16:39:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:22 INFO - '_': '/tools/buildbot/bin/python'} 16:39:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:22 INFO - Downloading/unpacking jsonschema==2.5.1 16:39: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 16:39: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 16:39: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 16:39: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 16:39: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 16:39: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 16:39:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:39:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:39: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 16:39: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 16:39: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 16:39: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 16:39: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 16:39: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 16:39:24 INFO - Downloading functools32-3.2.3-2.tar.gz 16:39:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:39:24 INFO - warning: no files found matching '*.txt' 16:39:24 INFO - no previously-included directories found matching 'build' 16:39:24 INFO - no previously-included directories found matching 'dist' 16:39:24 INFO - no previously-included directories found matching '.git*' 16:39:24 INFO - Installing collected packages: jsonschema, functools32 16:39:24 INFO - Running setup.py install for functools32 16:39:24 INFO - warning: no files found matching '*.txt' 16:39:24 INFO - no previously-included directories found matching 'build' 16:39:24 INFO - no previously-included directories found matching 'dist' 16:39:24 INFO - no previously-included directories found matching '.git*' 16:39:24 INFO - Successfully installed jsonschema functools32 16:39:24 INFO - Cleaning up... 16:39:24 INFO - Return code: 0 16:39:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:39: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')]} 16:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39: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')]} 16:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39: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', '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 0xe621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ffb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd290>, '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 0x10fdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe040>, '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': '41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628', '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 16:39: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:39: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 functools32==3.2.3-2 16:39:24 INFO - Using env: {'DISPLAY': ':0', 16:39:24 INFO - 'HOME': '/home/cltbld', 16:39:24 INFO - 'LANG': 'en_US.UTF-8', 16:39:24 INFO - 'LANGUAGE': 'en_US:en', 16:39:24 INFO - 'LOGNAME': 'cltbld', 16:39:24 INFO - 'MAIL': '/var/mail/cltbld', 16:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:24 INFO - 'MOZ_NO_REMOTE': '1', 16:39:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:24 INFO - 'NO_EM_RESTART': '1', 16:39:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:24 INFO - 'PWD': '/builds/slave/test', 16:39:24 INFO - 'SHELL': '/bin/bash', 16:39:24 INFO - 'SHLVL': '1', 16:39:24 INFO - 'TERM': 'linux', 16:39:24 INFO - 'TMOUT': '86400', 16:39:24 INFO - 'USER': 'cltbld', 16:39:24 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628', 16:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:24 INFO - '_': '/tools/buildbot/bin/python'} 16:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:39:25 INFO - Cleaning up... 16:39:25 INFO - Return code: 0 16:39:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:25 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 0xe621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ffb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd290>, '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 0x10fdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe040>, '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': '41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628', '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 16:39:25 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 16:39:25 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 16:39:25 INFO - Using env: {'DISPLAY': ':0', 16:39:25 INFO - 'HOME': '/home/cltbld', 16:39:25 INFO - 'LANG': 'en_US.UTF-8', 16:39:25 INFO - 'LANGUAGE': 'en_US:en', 16:39:25 INFO - 'LOGNAME': 'cltbld', 16:39:25 INFO - 'MAIL': '/var/mail/cltbld', 16:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:25 INFO - 'MOZ_NO_REMOTE': '1', 16:39:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:25 INFO - 'NO_EM_RESTART': '1', 16:39:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:25 INFO - 'PWD': '/builds/slave/test', 16:39:25 INFO - 'SHELL': '/bin/bash', 16:39:25 INFO - 'SHLVL': '1', 16:39:25 INFO - 'TERM': 'linux', 16:39:25 INFO - 'TMOUT': '86400', 16:39:25 INFO - 'USER': 'cltbld', 16:39:25 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628', 16:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:25 INFO - '_': '/tools/buildbot/bin/python'} 16:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:25 INFO - Downloading/unpacking blobuploader==1.2.4 16:39:25 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 16:39:25 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 16:39:25 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 16:39:25 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 16:39:25 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 16:39:25 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 16:39:27 INFO - Downloading blobuploader-1.2.4.tar.gz 16:39:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:39:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:39: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 16:39: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 16:39: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 16:39: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 16:39: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 16:39: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 16:39:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:39:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:39:28 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 16:39:28 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 16:39:28 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 16:39:28 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 16:39:28 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 16:39:28 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 16:39:28 INFO - Downloading docopt-0.6.1.tar.gz 16:39:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:39:28 INFO - Installing collected packages: blobuploader, requests, docopt 16:39:28 INFO - Running setup.py install for blobuploader 16:39:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:39:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:39:28 INFO - Running setup.py install for requests 16:39:29 INFO - Running setup.py install for docopt 16:39:29 INFO - Successfully installed blobuploader requests docopt 16:39:29 INFO - Cleaning up... 16:39:29 INFO - Return code: 0 16:39:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:39:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:29 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 0xe621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ffb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd290>, '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 0x10fdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe040>, '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': '41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628', '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 16:39:29 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 16:39:29 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 16:39:29 INFO - Using env: {'DISPLAY': ':0', 16:39:29 INFO - 'HOME': '/home/cltbld', 16:39:29 INFO - 'LANG': 'en_US.UTF-8', 16:39:29 INFO - 'LANGUAGE': 'en_US:en', 16:39:29 INFO - 'LOGNAME': 'cltbld', 16:39:29 INFO - 'MAIL': '/var/mail/cltbld', 16:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:29 INFO - 'MOZ_NO_REMOTE': '1', 16:39:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:29 INFO - 'NO_EM_RESTART': '1', 16:39:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:29 INFO - 'PWD': '/builds/slave/test', 16:39:29 INFO - 'SHELL': '/bin/bash', 16:39:29 INFO - 'SHLVL': '1', 16:39:29 INFO - 'TERM': 'linux', 16:39:29 INFO - 'TMOUT': '86400', 16:39:29 INFO - 'USER': 'cltbld', 16:39:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628', 16:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:29 INFO - '_': '/tools/buildbot/bin/python'} 16:39:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:39:29 INFO - Running setup.py (path:/tmp/pip-rubjAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:39:29 INFO - Running setup.py (path:/tmp/pip-jToR9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:39:29 INFO - Running setup.py (path:/tmp/pip-SPlO9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:39:29 INFO - Running setup.py (path:/tmp/pip-izJGx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:39:29 INFO - Running setup.py (path:/tmp/pip-n7cm53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:39:29 INFO - Running setup.py (path:/tmp/pip-uR82nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:39:29 INFO - Running setup.py (path:/tmp/pip-8bC2cd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:39:29 INFO - Running setup.py (path:/tmp/pip-3Nmcki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:39:30 INFO - Running setup.py (path:/tmp/pip-el6hGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:39:30 INFO - Running setup.py (path:/tmp/pip-naJx1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:39:30 INFO - Running setup.py (path:/tmp/pip-Zptrev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:39:30 INFO - Running setup.py (path:/tmp/pip-iRxMFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:39:30 INFO - Running setup.py (path:/tmp/pip-Sps7Rg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:39:30 INFO - Running setup.py (path:/tmp/pip-hOqlLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:39:30 INFO - Running setup.py (path:/tmp/pip-XfqS7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:39:30 INFO - Running setup.py (path:/tmp/pip-aCNFi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:39:30 INFO - Running setup.py (path:/tmp/pip-pwv7JC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:39:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:39:30 INFO - Running setup.py install for manifestparser 16:39:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:39:30 INFO - Running setup.py install for mozcrash 16:39:30 INFO - Running setup.py install for mozdebug 16:39:31 INFO - Running setup.py install for mozdevice 16:39:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:39:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:39:31 INFO - Running setup.py install for mozfile 16:39:31 INFO - Running setup.py install for mozhttpd 16:39:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:39:31 INFO - Running setup.py install for mozinfo 16:39:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:39:31 INFO - Running setup.py install for mozInstall 16:39:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:39:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:39:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:39:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:39:31 INFO - Running setup.py install for mozleak 16:39:31 INFO - Running setup.py install for mozlog 16:39:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:39:31 INFO - Running setup.py install for moznetwork 16:39:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:39:31 INFO - Running setup.py install for mozprocess 16:39:31 INFO - Running setup.py install for mozprofile 16:39:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:39:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:39:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:39:32 INFO - Running setup.py install for mozrunner 16:39:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:39:32 INFO - Running setup.py install for mozscreenshot 16:39:32 INFO - Running setup.py install for moztest 16:39:32 INFO - Running setup.py install for mozversion 16:39:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:39:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:39:32 INFO - Cleaning up... 16:39:32 INFO - Return code: 0 16:39:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:39:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:39:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:32 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 0xe621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ffb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd290>, '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 0x10fdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe040>, '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': '41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628', '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 16:39:32 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 16:39:32 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 16:39:32 INFO - Using env: {'DISPLAY': ':0', 16:39:32 INFO - 'HOME': '/home/cltbld', 16:39:32 INFO - 'LANG': 'en_US.UTF-8', 16:39:32 INFO - 'LANGUAGE': 'en_US:en', 16:39:32 INFO - 'LOGNAME': 'cltbld', 16:39:32 INFO - 'MAIL': '/var/mail/cltbld', 16:39:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:32 INFO - 'MOZ_NO_REMOTE': '1', 16:39:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:32 INFO - 'NO_EM_RESTART': '1', 16:39:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:32 INFO - 'PWD': '/builds/slave/test', 16:39:32 INFO - 'SHELL': '/bin/bash', 16:39:32 INFO - 'SHLVL': '1', 16:39:32 INFO - 'TERM': 'linux', 16:39:32 INFO - 'TMOUT': '86400', 16:39:32 INFO - 'USER': 'cltbld', 16:39:32 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628', 16:39:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:32 INFO - '_': '/tools/buildbot/bin/python'} 16:39:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:39:32 INFO - Running setup.py (path:/tmp/pip-yzjJmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:39:32 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)) 16:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:39:32 INFO - Running setup.py (path:/tmp/pip-gTdyRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:39:32 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)) 16:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:39:32 INFO - Running setup.py (path:/tmp/pip-nCVotc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:39:32 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)) 16:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:39:32 INFO - Running setup.py (path:/tmp/pip-P3T_jF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:39:33 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)) 16:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:39:33 INFO - Running setup.py (path:/tmp/pip-PXwsSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:39:33 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)) 16:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:39:33 INFO - Running setup.py (path:/tmp/pip-XHF0wk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:39:33 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)) 16:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:39:33 INFO - Running setup.py (path:/tmp/pip-8FQ2S_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:39:33 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)) 16:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:39:33 INFO - Running setup.py (path:/tmp/pip-_8KIos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:39:33 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)) 16:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:39:33 INFO - Running setup.py (path:/tmp/pip-ZxwSHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:39:33 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)) 16:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:39:33 INFO - Running setup.py (path:/tmp/pip-RivxyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:39:33 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)) 16:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:39:33 INFO - Running setup.py (path:/tmp/pip-owPUZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:39:33 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)) 16:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:39:33 INFO - Running setup.py (path:/tmp/pip-BJuhW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:39:33 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)) 16:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:39:33 INFO - Running setup.py (path:/tmp/pip-RO2n38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:39:33 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)) 16:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:39:33 INFO - Running setup.py (path:/tmp/pip-U61yD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:39:33 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)) 16:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:39:33 INFO - Running setup.py (path:/tmp/pip-y5rl0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:39:33 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)) 16:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:39:33 INFO - Running setup.py (path:/tmp/pip-IH7GyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:39:33 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)) 16:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:39:33 INFO - Running setup.py (path:/tmp/pip-8DMXZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:39:34 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)) 16:39:34 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)) 16:39:34 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)) 16:39:34 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)) 16:39:34 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)) 16:39:34 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)) 16:39:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:36 INFO - Downloading blessings-1.6.tar.gz 16:39:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:39:36 INFO - Installing collected packages: blessings 16:39:36 INFO - Running setup.py install for blessings 16:39:36 INFO - Successfully installed blessings 16:39:36 INFO - Cleaning up... 16:39:36 INFO - Return code: 0 16:39:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:39:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:39:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:39:36 INFO - Reading from file tmpfile_stdout 16:39:36 INFO - Current package versions: 16:39:36 INFO - argparse == 1.2.1 16:39:36 INFO - blessings == 1.6 16:39:36 INFO - blobuploader == 1.2.4 16:39:36 INFO - docopt == 0.6.1 16:39:36 INFO - functools32 == 3.2.3-2 16:39:36 INFO - jsonschema == 2.5.1 16:39:36 INFO - manifestparser == 1.1 16:39:36 INFO - mozInstall == 1.12 16:39:36 INFO - mozcrash == 1.0 16:39:36 INFO - mozdebug == 0.1 16:39:36 INFO - mozdevice == 0.49 16:39:36 INFO - mozfile == 1.2 16:39:36 INFO - mozhttpd == 0.7 16:39:36 INFO - mozinfo == 0.9 16:39:36 INFO - mozleak == 0.1 16:39:36 INFO - mozlog == 3.4 16:39:36 INFO - moznetwork == 0.27 16:39:36 INFO - mozprocess == 0.25 16:39:36 INFO - mozprofile == 0.28 16:39:36 INFO - mozrunner == 6.13 16:39:36 INFO - mozscreenshot == 0.1 16:39:36 INFO - mozsystemmonitor == 0.3 16:39:36 INFO - moztest == 0.8 16:39:36 INFO - mozversion == 1.4 16:39:36 INFO - psutil == 3.1.1 16:39:36 INFO - requests == 1.2.3 16:39:36 INFO - wsgiref == 0.1.2 16:39:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:39:36 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')]} 16:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:36 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')]} 16:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:36 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 0xe621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ffb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd290>, '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 0x10fdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe040>, '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': '41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628', '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 16:39:36 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 16:39:36 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 16:39:36 INFO - Using env: {'DISPLAY': ':0', 16:39:36 INFO - 'HOME': '/home/cltbld', 16:39:36 INFO - 'LANG': 'en_US.UTF-8', 16:39:36 INFO - 'LANGUAGE': 'en_US:en', 16:39:36 INFO - 'LOGNAME': 'cltbld', 16:39:36 INFO - 'MAIL': '/var/mail/cltbld', 16:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:36 INFO - 'MOZ_NO_REMOTE': '1', 16:39:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:36 INFO - 'NO_EM_RESTART': '1', 16:39:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:36 INFO - 'PWD': '/builds/slave/test', 16:39:36 INFO - 'SHELL': '/bin/bash', 16:39:36 INFO - 'SHLVL': '1', 16:39:36 INFO - 'TERM': 'linux', 16:39:36 INFO - 'TMOUT': '86400', 16:39:36 INFO - 'USER': 'cltbld', 16:39:36 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628', 16:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:36 INFO - '_': '/tools/buildbot/bin/python'} 16:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:36 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)) 16:39:36 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)) 16:39:36 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)) 16:39:36 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)) 16:39:36 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)) 16:39:36 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)) 16:39:36 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)) 16:39:36 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)) 16:39:36 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)) 16:39:36 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)) 16:39:36 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)) 16:39:36 INFO - Cleaning up... 16:39:36 INFO - Return code: 0 16:39:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:39:36 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')]} 16:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:36 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')]} 16:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:36 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 0xe621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ffb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd290>, '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 0x10fdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe040>, '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': '41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628', '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 16:39:36 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 16:39:36 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 16:39:36 INFO - Using env: {'DISPLAY': ':0', 16:39:36 INFO - 'HOME': '/home/cltbld', 16:39:36 INFO - 'LANG': 'en_US.UTF-8', 16:39:36 INFO - 'LANGUAGE': 'en_US:en', 16:39:36 INFO - 'LOGNAME': 'cltbld', 16:39:36 INFO - 'MAIL': '/var/mail/cltbld', 16:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:36 INFO - 'MOZ_NO_REMOTE': '1', 16:39:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:36 INFO - 'NO_EM_RESTART': '1', 16:39:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:36 INFO - 'PWD': '/builds/slave/test', 16:39:36 INFO - 'SHELL': '/bin/bash', 16:39:36 INFO - 'SHLVL': '1', 16:39:36 INFO - 'TERM': 'linux', 16:39:36 INFO - 'TMOUT': '86400', 16:39:36 INFO - 'USER': 'cltbld', 16:39:36 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628', 16:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:36 INFO - '_': '/tools/buildbot/bin/python'} 16:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:39:36 INFO - Cleaning up... 16:39:36 INFO - Return code: 0 16:39:36 INFO - Running post-action listener: _resource_record_post_action 16:39:36 INFO - Running post-action listener: _start_resource_monitoring 16:39:36 INFO - Starting resource monitoring. 16:39:36 INFO - [mozharness: 2017-03-21 23:39:36.996810Z] Finished create-virtualenv step (success) 16:39:36 INFO - [mozharness: 2017-03-21 23:39:36.997268Z] Running install step. 16:39:36 INFO - Running pre-action listener: _resource_record_pre_action 16:39:36 INFO - Running main action method: install 16:39:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:39:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:39:37 INFO - Reading from file tmpfile_stdout 16:39:37 INFO - Detecting whether we're running mozinstall >=1.0... 16:39:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:39:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:39:37 INFO - Reading from file tmpfile_stdout 16:39:37 INFO - Output received: 16:39:37 INFO - Usage: mozinstall [options] installer 16:39:37 INFO - Options: 16:39:37 INFO - -h, --help show this help message and exit 16:39:37 INFO - -d DEST, --destination=DEST 16:39:37 INFO - Directory to install application into. [default: 16:39:37 INFO - "/builds/slave/test"] 16:39:37 INFO - --app=APP Application being installed. [default: firefox] 16:39:37 INFO - mkdir: /builds/slave/test/build/application 16:39:37 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'] 16:39:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:39:52 INFO - Reading from file tmpfile_stdout 16:39:52 INFO - Output received: 16:39:52 INFO - /builds/slave/test/build/application/firefox/firefox 16:39:52 INFO - Running post-action listener: _resource_record_post_action 16:39:52 INFO - [mozharness: 2017-03-21 23:39:52.746729Z] Finished install step (success) 16:39:52 INFO - [mozharness: 2017-03-21 23:39:52.746998Z] Running run-tests step. 16:39:52 INFO - Running pre-action listener: _resource_record_pre_action 16:39:52 INFO - Running main action method: run_tests 16:39:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:39:52 INFO - Python 2.7.3 16:39:52 INFO - Return code: 0 16:39:52 INFO - grabbing minidump binary from tooltool 16:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:39:52 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 0x10fd290>, '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 0x10fdb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:39:52 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 16:39:52 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 16:39:52 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 16:39:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:39:52 INFO - Return code: 0 16:39:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:39:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:39:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:39:52 INFO - ENV: RUST_BACKTRACE is now 1 16:39:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:39:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:39:52 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/HuOhXf_MT0-mU7I9TNQtaQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 16:39:52 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/HuOhXf_MT0-mU7I9TNQtaQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 16:39:52 INFO - Using env: {'DISPLAY': ':0', 16:39:52 INFO - 'HOME': '/home/cltbld', 16:39:52 INFO - 'LANG': 'en_US.UTF-8', 16:39:52 INFO - 'LANGUAGE': 'en_US:en', 16:39:52 INFO - 'LOGNAME': 'cltbld', 16:39:52 INFO - 'MAIL': '/var/mail/cltbld', 16:39:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:39:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:52 INFO - 'MOZ_NO_REMOTE': '1', 16:39:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:52 INFO - 'NO_EM_RESTART': '1', 16:39:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:52 INFO - 'PWD': '/builds/slave/test', 16:39:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:39:52 INFO - 'RUST_BACKTRACE': '1', 16:39:52 INFO - 'SHELL': '/bin/bash', 16:39:52 INFO - 'SHLVL': '1', 16:39:52 INFO - 'TERM': 'linux', 16:39:52 INFO - 'TMOUT': '86400', 16:39:52 INFO - 'USER': 'cltbld', 16:39:52 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628', 16:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:52 INFO - '_': '/tools/buildbot/bin/python'} 16:39:52 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/HuOhXf_MT0-mU7I9TNQtaQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 16:39:53 INFO - mozversion application_buildid: 20170321230853 16:39:53 INFO - mozversion application_changeset: 8744e9f8eb99f1290aae81985812d57364f18708 16:39:53 INFO - mozversion application_display_name: Nightly 16:39:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:39:53 INFO - mozversion application_name: Firefox 16:39:53 INFO - mozversion application_remotingname: firefox 16:39:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:39:53 INFO - mozversion application_vendor: Mozilla 16:39:53 INFO - mozversion application_version: 55.0a1 16:39:53 INFO - mozversion platform_buildid: 20170321230853 16:39:53 INFO - mozversion platform_changeset: 8744e9f8eb99f1290aae81985812d57364f18708 16:39:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:39:53 INFO - mozversion platform_version: 55.0a1 16:39:53 INFO - using testdate: 1490139593 16:39:53 INFO - actual date: 1490139593 16:39:53 INFO - starting webserver on 'localhost:60692' 16:39:53 INFO - SUITE-START | Running 2 tests 16:39:53 INFO - TEST-START | dromaeo_css 16:39:53 INFO - operating with platform_type : linux_ 16:39:53 INFO - Initialising browser for dromaeo_css test... 16:39:53 INFO - TEST-INFO | started process 16860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCdQ6Qy/profile http://localhost:60692/getInfo.html) 16:39:56 INFO - PID 16860 | __metrics Screen width/height:1600/1200 16:39:56 INFO - PID 16860 | colorDepth:24 16:39:56 INFO - PID 16860 | Browser inner width/height: 1024/697 16:39:56 INFO - PID 16860 | __metrics 16:39:58 INFO - PID 16860 | 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" 16:39:58 INFO - PID 16860 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:39:58 INFO - TEST-INFO | 16860: exit 0 16:39:58 INFO - Browser initialized. 16:39:58 INFO - Running cycle 1/1 for dromaeo_css test... 16:39:58 INFO - TEST-INFO | started process 16954 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCdQ6Qy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:40:11 INFO - PID 16954 | RSS: Main: 150024192 16:40:11 INFO - PID 16954 | 16:43:17 INFO - PID 16954 | Cycle 1(1): loaded http://localhost:60692/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60692/tests/dromaeo/cssquery-ext.html) 16:43:19 INFO - PID 16954 | RSS: Main: 316170240 16:43:19 INFO - PID 16954 | 16:45:00 INFO - PID 16954 | ************************* 16:45:00 INFO - PID 16954 | A coding exception was thrown and uncaught in a Task. 16:45:00 INFO - PID 16954 | 16:45:00 ERROR - PID 16954 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:45:00 INFO - PID 16954 | Full stack: 16:45:00 INFO - PID 16954 | ************************* 16:46:22 INFO - PID 16954 | Cycle 1(1): loaded http://localhost:60692/tests/dromaeo/cssquery-ext.html (next: http://localhost:60692/tests/dromaeo/cssquery-jquery.html) 16:46:23 INFO - PID 16954 | RSS: Main: 235593728 16:46:23 INFO - PID 16954 | 16:49:25 INFO - PID 16954 | Cycle 1(1): loaded http://localhost:60692/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60692/tests/dromaeo/cssquery-mootools.html) 16:49:25 INFO - PID 16954 | RSS: Main: 198529024 16:49:25 INFO - PID 16954 | 16:52:28 INFO - PID 16954 | Cycle 1(1): loaded http://localhost:60692/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60692/tests/dromaeo/cssquery-prototype.html) 16:52:28 INFO - PID 16954 | RSS: Main: 217067520 16:52:28 INFO - PID 16954 | 16:55:31 INFO - PID 16954 | Cycle 1(1): loaded http://localhost:60692/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60692/tests/dromaeo/cssquery-yui.html) 16:55:32 INFO - PID 16954 | RSS: Main: 194043904 16:55:32 INFO - PID 16954 | 16:58:35 INFO - PID 16954 | Cycle 1(1): loaded http://localhost:60692/tests/dromaeo/cssquery-yui.html (next: http://localhost:60692/tests/dromaeo/cssquery-dojo.html) 16:58:35 INFO - PID 16954 | RSS: Main: 277643264 16:58:35 INFO - PID 16954 | 16:58:35 INFO - PID 16954 | __start_tp_report 16:58:35 INFO - PID 16954 | _x_x_mozilla_page_load 16:58:35 INFO - PID 16954 | _x_x_mozilla_page_load_details 16:58:35 INFO - PID 16954 | |i|pagename|runs| 16:58:35 INFO - PID 16954 | |0;dojo.html;2721.7822574194065;2746.148693904891;2763.861806909655;2769.8615069246534;2776.527990241659;5105.540501354877;5203;5268.604854635899;5285.709285989269;5331.680099194046;5237.188235823444;5245.86885327867;5294.602904782138;5310.150375939841;5327.467253274671;4768.260919557474;4818.42178938527;4829.541193586604;4896.314515967767;4959.50404959503;4859.732714700708;4884.731339776311;4904.950950490503;4918.555734992127;4973.104841128614;4725.31482934976;4725.976370118162;4737.265723812815;4757.119932812441;4846.0550192712435;4797.280407938837;4812.374391329105;4825.927611085836;4884.951150488485;4886.3403440535785;4764.737939413366;4782.33047373368;4786.7845946932475;4796.5683088521855;4806.086843499759;5151.072806894757;5201.063808514466;5275.736213189325;5286.920696189561;5350.464953504657;5629.549636029149;5661.122526008434;5725.627834190765;5726.083826587767;5726.570507211975;5736.512396446307;5755.539556835443;5767.394423585547;5768.336641286264;5769.480746732815;5340.91988620171;5351.678899266057;5352.143657014859;5353.732313384316;5401;5697.088465845528;5708.514776244066;5754.309482862083;5779.768809247667;5886.911696324559;5624.775008999594;5661.235733175969;5669.801556945569;5675.063614503643;5676.035074037423;5708.514776244066;5711.514521265656;5712.6286791358425;5713.371529131792;5715.1713001614535;5616.5787565932715;5666.716664166775;5672.4894759471845;5677.971610141923;5679.517241034476;5529.889402211933;5577.776888924479;5579.38626751057;5655.208270842086;5691.459311365414;4721.15019296523;4725.220338644154;4726.574608285271;4740.810367585327;4768.523147685273;4060.898477538085;4067.2272268268935;4072.328065869158;4082.693797965105;4110.23960567296;4641.489436162019;4734.19518681825;4819.927701084486;4825.445073816486;4879.682820616648;5763.711814409263;5769.451902069297;5784.913226301609;5798.246227990334;5822.7088645567555;4777.546133117348;4792.376990991149;4817.662763606514;4818.855434336975;4856.441509226484;4930.556249937523;4981.252812078217;5060.418051924076;5064.746762661852;5079.1365467870555;5285.286486324297;5289.841304760864;5315.069862774077;5337.252784610236;5342.9465705342445;5569.888602227852;5602.85992850182;5763.7118144093465;5785;5788.334341550607;5280.3663560373;5335.11970524859;5350.411454739898;5375.919361209507;5385.6230063895155;5601.887962240814;5658.292713410824;5665.575081868794;5667.093265077568;5667.773289068556;5592.804251851166;5627.127795191752;5640.689762063126;5659.688717120598;5732.885342293214;5587.469190426903;5587.99416105105;5588.2455868458865;5591.27313449249;5634.267545219095;5574.052411090043;5581.386047534849;5582.358028826575;5584.860378490408;5586.13414920688;5340.145576707863;5367.1680889462195;5367.221752845893;5441.891162176655;5536.944630553643;5396.1905714143195;5458.972705136449;5459.672419654833;5460;5463.098588732973;5305.575553955597;5318.175682769177;5318.335208098988;5319.361676598833;5322.308099947137 16:58:35 INFO - PID 16954 | |1;ext.html;728.3626826526789;747.5552046532315;986.1814693804143;1001.1590264178099;1002.0530598584336;30717;31540.842295788516;31619.683803161963;31653.683463165362;31702.841485792596;35388.469172962425;35982.100447488825;35996.100097497576;36029.81985090078;36500.634993650056;5630.746616402272;5771.134329850535;7435.479516433838;7574.09110906692;7574.772756817277;7166.17588977269;7365.926340736604;7369.447291453135;7377;7377.704891804321;7429.771068679374;7479.513831600929;7484.139323977731;7484.176740558534;7491.850162996737;5629.071203251499;7408.518446301;7465.6267186641;7466.066741657293;7470.701171953116;5672.234248376499;7126.501144919857;7307.525010874276;7314.707411703525;7338;30118.397632047454;30477.08568742941;30556.236094097603;30564.777408903617;30568.2357941051;2628.7371262873753;2638.5382558052456;2642.537555927724;2648.7218842021693;2660.201939418186;21681.891590542105;21732.456688582755;21848;21979.780202197933;23186.188483403;2535.049356491316;2696.730326967307;2699.824511406752;2709.580015097663;2735.0974178521237;164528;166069;166492;166790.99999999878;167107;32820.67179328176;33543.49684754731;33600.831995839864;44136.558634413246;44643.776781115885;36336;36750.26499469996;38907.416388754194;39707.20585588272;39724.80137599294;11027.338359698444;11201.60794372193;11252.212345135762;11547.884521154681;11556.537738490366;8873.866891996626;8945.73162805117;8951.851555626732;8957.328200384996;8957.731268061969;13451.663708407172;13452.32738363078;13501.257430841202;13600.659983500294;13704.931475342759;5494.780208791683;5516.448355164532;5516.779328826882;5609.27079479665;5705.971470142623;851.3359579527978;879.0989236033117;885.4377470306401;889.235257678396;913.1097180249204;20387.59224815525;21085.89457052705;21274.893625531775;21304.680429793567;21575.56848863014;946.9147776699992;951.8762560867043;956.297121615612;961.9086186812242;968.6658102954469;10632.627858024933;10788.190885683605;10829.729256768644;10939.83590246147;11331.263467874562;226441;227680;227943;227948;228702;40818.38772418416;41303.38044929328;41338.37992430116;41409.1718165635;41431.58568414338;1173.976520469586;1210.9394530273628;1217.0324591949422;1218.056006594896;1227.4231111377637;19622.509437264183;19635.803641963397;20735.585288294453;20876.164953401694;20884.164633414493;29933.401331972804;30010.3997920036;30050.54924176183;30061.699383006766;30064.549031764105;216849;217161;217392;217518;218211;22099.116035358405;22570.322890313317;28507;29109.85445072761;29380.55929161107;35803.10492237715;35944;36043.27913441769;36202.63797362098;36855.44716829196;32271;32565.34869302553;32834;32940;33340.83329583336;31841;32284.515732264506;33197.50203746994;33408.83295583507;33573.66426335705;32614;33167.17082072871;33274.500882487264;33421.83289083539;33434.66565334413;25293.747062529874;26821.463570728865;26859.462810744066;26999.460010800067;27530.311742206606;23199;23573.52852942897;23626.637336266234;24132.758672413755;24148.63777043381 16:58:35 INFO - PID 16954 | |2;jquery.html;396.80953142491603;408.64039645112297;415.50554839740704;430.09035889094565;445.58560538699015;11106.337057095478;17113.48659540214;17470.737938930924;17764.822351776493;17772.555686107855;13566.660833479167;14316.642083947907;17370.826291737078;17636;18749;5364.195370694398;5423.593230507708;5616.241807356016;5633.324001119871;5633.887322253552;5629.746661400247;5656.8020119295625;5663.830085097454;5664.745086471098;5667.744951477172;5444.373897001836;5647.1529270609535;5653.886922261552;5663.575231857607;5674.687892165929;5499.257600223958;5565.9443405565835;5570.554355651539;5610.523105536035;5642.4357564243655;5098.770555325019;5124.76938537763;5132.769025393866;5136;5140.922886156711;21434.57130857374;21698.674519882214;21764.347069587937;21764.782352176433;21771.129154833787;1487.0334282716321;1492.1420183394591;1495.6036650287683;1535.9232038398147;1539.0919357579082;13054.804177937338;13056.934715326362;13351;14520.056196347203;14765.557033289018;1673.8828282020263;1690;1700.5918579540944;1708.44475545447;1732.5841797968396;84849.15150848475;86189;87848;89793.10206897913;90475.54762226212;10426;10647.84028239577;10664;10728.94635526833;10791.946040269906;14900.329485173193;14955.401783928739;14973.625659358386;14974.101553906801;14987.475438359605;6016.639001659914;6245.437910588069;6574.8356291093105;6778.796636100925;7012.719491220396;5690.658560486384;5713.714314284269;5955.791547295824;5982.790602328898;5993.490553303018;6552.3775241352;6670.366315200048;6678.732850686015;6805;6909.7581584644295;2012.3661046770221;2029.5488725561295;2080.3238947342174;2082.9270975515783;2216.9445763856033;815.339574944297;830.6594296338473;849.0133088572769;860.8837806895989;870.5821205821114;16169.272382742805;16340.509784706477;16666;16864.747028794576;17196.1401929903;847.576211894053;850.2093053460342;853.4495250563352;855.7432770168924;870.9520976346236;8942.73171804847;9126.817463650823;9238.815223695623;9251.95374023139;9363.859542106873;439095;456743;477685;478946;488771;77823.61088194523;88442.11557884338;89136.554317228;90409;90448;1041.6979076068008;1054.0987455725244;1091.410638255349;1091.9071878890384;1096.3969816600998;16345.182740862672;16709.415170469463;17130.31478740886;17145.742813857552;17438.91280543589;36389.81805090958;37608.811955940044;38335.61664383321;40110.598894011855;40558.39162412625;50603.2409513865;50879;51163.232551512505;52556;53545.46454535405;7812.125089978251;7827.74756039031;7971.0833254174195;7993.72021979228;8034.437589368688;11692;11748.35384053851;11756.235844670411;11885.465154067915;11953.163278570417;9844.704658859959;10087.897495862726;10096.899031009596;10281.640142595272;10295.588176472857;11021.669349919515;11041.116710663287;11071.730295289608;11112.833307500232;11125.44372781374;10189.133923616278;10209.38743675382;10415.270931034755;10494.160467162761;10564.683059508227;7796.557636837203;7891.250331218525;7963;8101.230383113595;8131.349492040505;9740.512974351112;9785.315027947976;10867;10877.836832447361;11098.722531936442 16:58:35 INFO - PID 16954 | |3;mootools.html;1264.5068423314906;1291.9677008074798;1315.611894491125;1323.4441534555492;1333.6532501549593;9238.168564829164;9658.855117173249;9659.46872921989;9660.178884794792;9661.130498255156;9376.343655944069;9705.320627556073;9758;9758.414495130279;9762.853557196648;2176.4123686604607;2212.7012853264846;2214.1586197245024;2214.413180507167;2215.3353993801793;1776.2894842063213;1842.9354972575964;2033.0749508973456;2079.5736873940805;2095.423758466426;1836.742856000161;1861.1345724238226;1870.1023508715825;2098.800613941673;2162.4377661807966;2078.740157480315;2086.5096702274955;2099.548597051626;2101.9789802101936;2105.1263725553954;1994.8104930031623;2069.4205622425743;2070.33749200256;2073.4919944613516;2080.9687854682193;8256.091829898767;8521.44610600309;8521.872171917426;8529.360297977677;9709.514524273758;4561.270196768534;5265.815696450644;5421.783128674848;5430.891382172374;5436.891262174774;3010.1872494426384;3025.773067019982;3073.707997740211;3075.0621060576514;3161.7944833585743;948.5684013773716;953.8759961205068;978.5254151736402;987.6395115782688;995.1889210293588;13622.659433514142;13924.373403196982;14005.509807156803;14007.929960350133;14024.228667423287;4220.177065472203;4394.340848872695;4572.359869618256;4697.577218050392;4720.339152518582;10045.146162576117;10046.296759226783;10057.748556286006;10066.547005384775;10073.395596264247;5036.093503169464;5100.209467532539;5102.311187989574;5108.463611320833;5111.923321150186;4853.296272040534;4922.089413458521;4996.600271978233;5025.899482010339;5046.571041461517;3577.5706915170344;3634.47300141478;3662.1393972416463;3700.1674623209565;3762.021874312644;1039.2828948025838;1042.801867645145;1047.984280235797;1048.9370637761758;1061.6708820265742;676.24936320684;694.9583025018414;695.4581006421537;705.4356514788149;731.0605871455155;5011.724355160502;5309.920351194735;5454.563634909197;5486.972565137149;5537.335519737658;802.1336956087412;807.4832107451236;811.2050190812919;812.4597142899905;821.109096630163;3399.439092549751;3526.858925642997;3537.4870643756512;3542.1321776165005;3620.456931460302;11574;11880.584179553674;12439.440225189888;12617.747645047048;12620.55828046014;12275.140740148105;12336.074794390457;12467.688307792196;12508.937455312665;12547.623571292876;7938.761837144895;8238.299744521662;8721.30229581632;9084.273258139334;9107.814124610046;5468.48049435303;5547.611667183259;5550.55595552363;5657.8019769307875;5956.821295361146;11214.55141794319;11364.090872730327;11379.54481820718;11413.258138220988;11462.828057578976;11220.887791121984;11893.881061189277;11955.64133076009;11984.340861252365;11986.700332491757;8548.487090774574;8747.781305467159;8756.518391488275;8763.561821908752;8765.386422950332;8779.297656187617;8949.284057275532;9039.81920361576;9088.863667044867;9090.545472726206;8146.796330091795;8147.826564270038;8265.876011859948;8457.661693532189;8493.915060849313;7958.522488650699;8035.236652518001;8101.635426405944;8160.918390816016;8282.17178282191;6996.790096297119;7014.123234595676;7082.893756593552;7086.255943125898;7089.220185779457;4740.739259340769;4859.684120532154;4921.803127874988;4980.402351717817;5141.331626888481;4690.624750020059;4747.2879068140055;4752.952470475389;4775.33145359643;4873.829415970424 16:58:35 INFO - PID 16954 | |4;prototype.html;367.8321329777956;396.494469551322;401.6405317241071;402.86101295053203;405.3190639725264;5185.222216667502;5264.789408423663;5268.6575372600755;5281.2342210379475;5320.042392369372;4998.600111991041;5131.153359695646;5131.538161565459;5169.534741873231;5234.293370394996;4026.2752704513177;4028.2950483665386;4040.7777572233517;4056.4523789288364;4067.8983025424304;4060.2894493463673;4075.266452038632;4075.286824805662;4078.2659121358142;4084.305668036426;3936.4488971543865;3991.241664083829;4005.499312585927;4036.6770658347264;4044.7370920890194;3965.861194858166;4010.3984402339593;4013.4581831452965;4052.3111071117983;4059.9594004060023;3521.3765744520497;3521.4893840393;3521.8730006397964;3532.6997205237585;3538.486919396673;4945.653804233705;5064.164412871872;5071.366079240095;5072.644914855961;5081.085404627165;4589.036302376505;4618.8152473901;4618.953810461886;4630.953690463086;4640.303954406832;5410.215518749798;5439.292891924064;5444.3194600674915;5448.346198456171;5454.427285135043;3879.9806000970098;3889.183271512986;3897.707671924617;3900.258950799339;3902.843886244547;5500;5759.5968282220265;5769.221155144086;5770.730439303388;5811.012127938261;3985.720999530005;3987.1826275614007;3991.44119823225;3994.1811928554575;4006.8196931137586;4033.6773058155277;4042.413849991735;4043.3126368516832;4053.5135783706146;4055;4505.324201369821;4575.702579332333;4602.65480088988;4623;4637.814487420465;5475.507204351547;5494.5054945055135;5501.449855014546;5516.613837031449;5520.067976208295;1381.5233744358181;1386.9098508596908;1389.7081612861411;1391.172252509755;1392.1229625335973;883.2404132446092;930.497531333086;941.9293552983416;954.7565370830393;955.145145095136;4775.73733444657;4778.450478194983;4780.521947805191;4781.856544303677;4800.35195248644;5643.548516118701;5645.322561292671;5658;5658.943410565924;5683.60214784961;4598.908021839545;4760.785764640599;4768.332433459318;4785.138675038457;4801.903961920742;2961.955570666442;2971.138369872756;2973.628296462942;2980.3177140573225;2994.7903646744517;5256.6320357574605;5259.500347466985;5280.735963201824;5285.894282114336;5295.861389801211;5586.748177475514;5741;5748.109043098327;5765.394633563499;5770.6249093808765;5254.185601231815;5261.657992230493;5275.709835959059;5276.577873770012;5278;5515.531179849758;5645.661260324394;5652.576056795839;5659.405762394889;5660.830175094754;5524.8342549723575;5533.170024496358;5552.250446189712;5566.803137325494;5571.220029195835;5232.267482552522;5259.789608415621;5269.578433725216;5281.042616134977;5322.635438940187;3836.4628951946193;3979.3036218662196;3993.840246390228;4008.1783234437453;4009.278329900529;5610;5611.831645050655;5611.971940140274;5617.7191140442;5630.915536267041;5417.943501017264;5431.484009019295;5448.45515448452;5459.836204913859;5481.095619222783;5321.3348331458565;5439.5648348132845;5440.4365140832815;5462.644928079662;5486.698231597141;5369.972520609543;5402.297701298963;5412.621116521806;5422.996745602076;5427.6472029317965;5504.422035686355;5508.7521061553125;5516.3380394352935;5528.419515950928;5549.916751248816;5239.44985776488;5302.761375738024;5358.544523715372;5377.3816011159215;5383.300170977748 16:58:35 INFO - PID 16954 | |5;yui.html;620.3207487800856;625.5777350288554;674.5885010143811;681.2029924987764;688.545559930446;14311.713765724679;14882.925585372084;14890.776638350433;14922;14935.850641493582;14669.266536673176;14707.264636768172;14767.556973290819;14838.851611483882;14859.108453492798;822.2722890242134;823.3577809308749;837.7738010737097;839.9664013439485;846.5894041389921;848.3552500099937;848.8811566380712;849.864021756519;850.4982060584254;851.4252879306474;880.9779755506131;882.788130848595;883.5228976352762;886.9866951995725;888.9199972002518;881.858902575588;889.7864512517014;890.1009979920294;890.3233542507676;891.0777345447431;656.5699466849221;660.9669516524154;662.6653539962289;662.8707402056601;663.1081195791653;11595.130365222642;11738.23701459411;11803.822942655866;11808.881911180864;13819.792703109462;13131.418417538958;13585.252811095386;13651.249181295025;13853.307334633228;13993.3702983366;9134.269258459308;9274.48990305533;9409.76475588109;9439.622415103388;9893.75265618358;2701.567749160125;2738.657667791526;2742.465219282241;2785.2897511134734;2803.6775770786417;62556.68721656408;63418.68290658564;64828.351716482706;65210.673946630435;65486.67256663686;10279.845802312972;10376.533056012497;10438.37369757817;10522.210834187466;10740.516676749565;21190.576188476454;21483.355499335044;21550.353489395344;21558.353249402542;21949.231776887733;6496.447801936888;6512.641804700692;6543.247526534415;6545.181852268466;6794.592324460548;3005.353848922492;3137.498000319938;3240.513922911535;3365.596128464551;3381.8309084545676;3421.623621401644;3470.1845066409373;3477.51314815926;3485.0938755923644;3509.78941263525;637.5027478566725;648.0085469232082;682.5938566552893;717.3149642091789;720.2390156068362;450.4864454521848;458.2370353361682;460.6821293307607;484.88605177783194;490.82821012646;7536.585487798224;7698.422618303538;7783.455158138989;7836.725714599962;7999.36005119589;456.7647661454354;476.19047619047063;480.12856665152634;482.79722516543137;490.5168409117088;3558.5373901393173;3589;3604.7296452766145;3617.3850445423814;3780.1305699689224;61406.69296653488;62435.68782156151;63057.68471157615;63525.364746351945;64242.6787866067;56907.43092569021;57465.425345746844;57588.424115759146;57628.42371576314;58333.70833145892;48291.75854120707;49541;49942.99999999927;50581.74709126431;51605;7174.1032370953635;7291.8177045572165;7376.7418140364825;7466.925330746623;7619.123800762984;25020.874895626133;26007.739922600533;26183.214503564923;26598.33504162334;26928.73071269262;31275;31916.361672766878;31937;32194.839025804722;32667.509987350684;9470.14768670823;9504.95247523758;9519.476428796483;9792.265580081665;10090.73865766779;9474.668386606436;9613.279004074582;9755.268354873555;10109.747256318651;10120.59517619287;9497.28770342241;9510.714678559654;9521.143097121292;9849.65526206608;9875.703728888146;9121.863172052557;9289.16397524199;9354.29842761782;9459.243260539279;9573.521323933915;8802.29581633455;8834.646614135363;8963.327750418875;9008.684696035607;9347.392419492984;8026.8795968061695;8260.917390826255;8360.372972027;8372.706955256537;8866.069062748576;8044.959775201087;8424.915750842412;8679.392442528962;9252.181906289175;9826.65606703762 16:58:35 INFO - PID 16954 | __end_tp_report 16:58:35 INFO - PID 16954 | __start_cc_report 16:58:35 INFO - PID 16954 | _x_x_mozilla_cycle_collect,1930 16:58:35 INFO - PID 16954 | __end_cc_report 16:58:35 INFO - PID 16954 | __startTimestamp1490140715819__endTimestamp 16:58:35 INFO - PID 16954 | 16:58:35 INFO - PID 16954 | ------- Summary: start ------- 16:58:35 INFO - PID 16954 | Number of tests: 6 16:58:35 INFO - PID 16954 | 16:58:35 INFO - PID 16954 | [#0] dojo.html Cycles:165 Average:5216.35 Median:5342.95 stddev:599.55 (11.2%) stddev-sans-first:568.56 16:58:35 INFO - PID 16954 | Values: 2721.8 2746.1 2763.9 2769.9 2776.5 5105.5 5203.0 5268.6 5285.7 5331.7 5237.2 5245.9 5294.6 5310.2 5327.5 4768.3 4818.4 4829.5 4896.3 4959.5 4859.7 4884.7 4905.0 4918.6 4973.1 4725.3 4726.0 4737.3 4757.1 4846.1 4797.3 4812.4 4825.9 4885.0 4886.3 4764.7 4782.3 4786.8 4796.6 4806.1 5151.1 5201.1 5275.7 5286.9 5350.5 5629.5 5661.1 5725.6 5726.1 5726.6 5736.5 5755.5 5767.4 5768.3 5769.5 5340.9 5351.7 5352.1 5353.7 5401.0 5697.1 5708.5 5754.3 5779.8 5886.9 5624.8 5661.2 5669.8 5675.1 5676.0 5708.5 5711.5 5712.6 5713.4 5715.2 5616.6 5666.7 5672.5 5678.0 5679.5 5529.9 5577.8 5579.4 5655.2 5691.5 4721.2 4725.2 4726.6 4740.8 4768.5 4060.9 4067.2 4072.3 4082.7 4110.2 4641.5 4734.2 4819.9 4825.4 4879.7 5763.7 5769.5 5784.9 5798.2 5822.7 4777.5 4792.4 4817.7 4818.9 4856.4 4930.6 4981.3 5060.4 5064.7 5079.1 5285.3 5289.8 5315.1 5337.3 5342.9 5569.9 5602.9 5763.7 5785.0 5788.3 5280.4 5335.1 5350.4 5375.9 5385.6 5601.9 5658.3 5665.6 5667.1 5667.8 5592.8 5627.1 5640.7 5659.7 5732.9 5587.5 5588.0 5588.2 5591.3 5634.3 5574.1 5581.4 5582.4 5584.9 5586.1 5340.1 5367.2 5367.2 5441.9 5536.9 5396.2 5459.0 5459.7 5460.0 5463.1 5305.6 5318.2 5318.3 5319.4 5322.3 16:58:35 INFO - PID 16954 | 16:58:35 INFO - PID 16954 | [#1] ext.html Cycles:180 Average:34085.51 Median:31678.26 stddev:53478.76 (168.8%) stddev-sans-first:53570.14 16:58:35 INFO - PID 16954 | Values: 728.4 747.6 986.2 1001.2 1002.1 30717.0 31540.8 31619.7 31653.7 31702.8 35388.5 35982.1 35996.1 36029.8 36500.6 5630.7 5771.1 7435.5 7574.1 7574.8 7166.2 7365.9 7369.4 7377.0 7377.7 7429.8 7479.5 7484.1 7484.2 7491.9 5629.1 7408.5 7465.6 7466.1 7470.7 5672.2 7126.5 7307.5 7314.7 7338.0 30118.4 30477.1 30556.2 30564.8 30568.2 2628.7 2638.5 2642.5 2648.7 2660.2 21681.9 21732.5 21848.0 21979.8 23186.2 2535.0 2696.7 2699.8 2709.6 2735.1 164528.0 166069.0 166492.0 166791.0 167107.0 32820.7 33543.5 33600.8 44136.6 44643.8 36336.0 36750.3 38907.4 39707.2 39724.8 11027.3 11201.6 11252.2 11547.9 11556.5 8873.9 8945.7 8951.9 8957.3 8957.7 13451.7 13452.3 13501.3 13600.7 13704.9 5494.8 5516.4 5516.8 5609.3 5706.0 851.3 879.1 885.4 889.2 913.1 20387.6 21085.9 21274.9 21304.7 21575.6 946.9 951.9 956.3 961.9 968.7 10632.6 10788.2 10829.7 10939.8 11331.3 226441.0 227680.0 227943.0 227948.0 228702.0 40818.4 41303.4 41338.4 41409.2 41431.6 1174.0 1210.9 1217.0 1218.1 1227.4 19622.5 19635.8 20735.6 20876.2 20884.2 29933.4 30010.4 30050.5 30061.7 30064.5 216849.0 217161.0 217392.0 217518.0 218211.0 22099.1 22570.3 28507.0 29109.9 29380.6 35803.1 35944.0 36043.3 36202.6 36855.4 32271.0 32565.3 32834.0 32940.0 33340.8 31841.0 32284.5 33197.5 33408.8 33573.7 32614.0 33167.2 33274.5 33421.8 33434.7 25293.7 26821.5 26859.5 26999.5 27530.3 23199.0 23573.5 23626.6 24132.8 24148.6 16:58:35 INFO - PID 16954 | 16:58:35 INFO - PID 16954 | [#2] jquery.html Cycles:180 Average:27637.82 Median:219762.55 stddev:77457.46 (35.2%) stddev-sans-first:77647.75 16:58:35 INFO - PID 16954 | Values: 396.8 408.6 415.5 430.1 445.6 11106.3 17113.5 17470.7 17764.8 17772.6 13566.7 14316.6 17370.8 17636.0 18749.0 5364.2 5423.6 5616.2 5633.3 5633.9 5629.7 5656.8 5663.8 5664.7 5667.7 5444.4 5647.2 5653.9 5663.6 5674.7 5499.3 5565.9 5570.6 5610.5 5642.4 5098.8 5124.8 5132.8 5136.0 5140.9 21434.6 21698.7 21764.3 21764.8 21771.1 1487.0 1492.1 1495.6 1535.9 1539.1 13054.8 13056.9 13351.0 14520.1 14765.6 1673.9 1690.0 1700.6 1708.4 1732.6 84849.2 86189.0 87848.0 89793.1 90475.5 10426.0 10647.8 10664.0 10728.9 10791.9 14900.3 14955.4 14973.6 14974.1 14987.5 6016.6 6245.4 6574.8 6778.8 7012.7 5690.7 5713.7 5955.8 5982.8 5993.5 6552.4 6670.4 6678.7 6805.0 6909.8 2012.4 2029.5 2080.3 2082.9 2216.9 815.3 830.7 849.0 860.9 870.6 16169.3 16340.5 16666.0 16864.7 17196.1 847.6 850.2 853.4 855.7 871.0 8942.7 9126.8 9238.8 9252.0 9363.9 439095.0 456743.0 477685.0 478946.0 488771.0 77823.6 88442.1 89136.6 90409.0 90448.0 1041.7 1054.1 1091.4 1091.9 1096.4 16345.2 16709.4 17130.3 17145.7 17438.9 36389.8 37608.8 38335.6 40110.6 40558.4 50603.2 50879.0 51163.2 52556.0 53545.5 7812.1 7827.7 7971.1 7993.7 8034.4 11692.0 11748.4 11756.2 11885.5 11953.2 9844.7 10087.9 10096.9 10281.6 10295.6 11021.7 11041.1 11071.7 11112.8 11125.4 10189.1 10209.4 10415.3 10494.2 10564.7 7796.6 7891.3 7963.0 8101.2 8131.3 9740.5 9785.3 10867.0 10877.8 11098.7 16:58:35 INFO - PID 16954 | 16:58:35 INFO - PID 16954 | [#3] mootools.html Cycles:180 Average:5984.31 Median:4814.31 stddev:3822.81 (79.4%) stddev-sans-first:3817.09 16:58:35 INFO - PID 16954 | Values: 1264.5 1292.0 1315.6 1323.4 1333.7 9238.2 9658.9 9659.5 9660.2 9661.1 9376.3 9705.3 9758.0 9758.4 9762.9 2176.4 2212.7 2214.2 2214.4 2215.3 1776.3 1842.9 2033.1 2079.6 2095.4 1836.7 1861.1 1870.1 2098.8 2162.4 2078.7 2086.5 2099.5 2102.0 2105.1 1994.8 2069.4 2070.3 2073.5 2081.0 8256.1 8521.4 8521.9 8529.4 9709.5 4561.3 5265.8 5421.8 5430.9 5436.9 3010.2 3025.8 3073.7 3075.1 3161.8 948.6 953.9 978.5 987.6 995.2 13622.7 13924.4 14005.5 14007.9 14024.2 4220.2 4394.3 4572.4 4697.6 4720.3 10045.1 10046.3 10057.7 10066.5 10073.4 5036.1 5100.2 5102.3 5108.5 5111.9 4853.3 4922.1 4996.6 5025.9 5046.6 3577.6 3634.5 3662.1 3700.2 3762.0 1039.3 1042.8 1048.0 1048.9 1061.7 676.2 695.0 695.5 705.4 731.1 5011.7 5309.9 5454.6 5487.0 5537.3 802.1 807.5 811.2 812.5 821.1 3399.4 3526.9 3537.5 3542.1 3620.5 11574.0 11880.6 12439.4 12617.7 12620.6 12275.1 12336.1 12467.7 12508.9 12547.6 7938.8 8238.3 8721.3 9084.3 9107.8 5468.5 5547.6 5550.6 5657.8 5956.8 11214.6 11364.1 11379.5 11413.3 11462.8 11220.9 11893.9 11955.6 11984.3 11986.7 8548.5 8747.8 8756.5 8763.6 8765.4 8779.3 8949.3 9039.8 9088.9 9090.5 8146.8 8147.8 8265.9 8457.7 8493.9 7958.5 8035.2 8101.6 8160.9 8282.2 6996.8 7014.1 7082.9 7086.3 7089.2 4740.7 4859.7 4921.8 4980.4 5141.3 4690.6 4747.3 4753.0 4775.3 4873.8 16:58:35 INFO - PID 16954 | 16:58:35 INFO - PID 16954 | [#4] prototype.html Cycles:180 Average:4534.22 Median:5233.28 stddev:1315.08 (25.1%) stddev-sans-first:1281.05 16:58:35 INFO - PID 16954 | Values: 367.8 396.5 401.6 402.9 405.3 5185.2 5264.8 5268.7 5281.2 5320.0 4998.6 5131.2 5131.5 5169.5 5234.3 4026.3 4028.3 4040.8 4056.5 4067.9 4060.3 4075.3 4075.3 4078.3 4084.3 3936.4 3991.2 4005.5 4036.7 4044.7 3965.9 4010.4 4013.5 4052.3 4060.0 3521.4 3521.5 3521.9 3532.7 3538.5 4945.7 5064.2 5071.4 5072.6 5081.1 4589.0 4618.8 4619.0 4631.0 4640.3 5410.2 5439.3 5444.3 5448.3 5454.4 3880.0 3889.2 3897.7 3900.3 3902.8 5500.0 5759.6 5769.2 5770.7 5811.0 3985.7 3987.2 3991.4 3994.2 4006.8 4033.7 4042.4 4043.3 4053.5 4055.0 4505.3 4575.7 4602.7 4623.0 4637.8 5475.5 5494.5 5501.4 5516.6 5520.1 1381.5 1386.9 1389.7 1391.2 1392.1 883.2 930.5 941.9 954.8 955.1 4775.7 4778.5 4780.5 4781.9 4800.4 5643.5 5645.3 5658.0 5658.9 5683.6 4598.9 4760.8 4768.3 4785.1 4801.9 2962.0 2971.1 2973.6 2980.3 2994.8 5256.6 5259.5 5280.7 5285.9 5295.9 5586.7 5741.0 5748.1 5765.4 5770.6 5254.2 5261.7 5275.7 5276.6 5278.0 5515.5 5645.7 5652.6 5659.4 5660.8 5524.8 5533.2 5552.3 5566.8 5571.2 5232.3 5259.8 5269.6 5281.0 5322.6 3836.5 3979.3 3993.8 4008.2 4009.3 5610.0 5611.8 5612.0 5617.7 5630.9 5417.9 5431.5 5448.5 5459.8 5481.1 5321.3 5439.6 5440.4 5462.6 5486.7 5370.0 5402.3 5412.6 5423.0 5427.6 5504.4 5508.8 5516.3 5528.4 5549.9 5239.4 5302.8 5358.5 5377.4 5383.3 16:58:35 INFO - PID 16954 | 16:58:35 INFO - PID 16954 | [#5] yui.html Cycles:180 Average:13769.32 Median:32081.43 stddev:17559.36 (54.7%) stddev-sans-first:17580.86 16:58:35 INFO - PID 16954 | Values: 620.3 625.6 674.6 681.2 688.5 14311.7 14882.9 14890.8 14922.0 14935.9 14669.3 14707.3 14767.6 14838.9 14859.1 822.3 823.4 837.8 840.0 846.6 848.4 848.9 849.9 850.5 851.4 881.0 882.8 883.5 887.0 888.9 881.9 889.8 890.1 890.3 891.1 656.6 661.0 662.7 662.9 663.1 11595.1 11738.2 11803.8 11808.9 13819.8 13131.4 13585.3 13651.2 13853.3 13993.4 9134.3 9274.5 9409.8 9439.6 9893.8 2701.6 2738.7 2742.5 2785.3 2803.7 62556.7 63418.7 64828.4 65210.7 65486.7 10279.8 10376.5 10438.4 10522.2 10740.5 21190.6 21483.4 21550.4 21558.4 21949.2 6496.4 6512.6 6543.2 6545.2 6794.6 3005.4 3137.5 3240.5 3365.6 3381.8 3421.6 3470.2 3477.5 3485.1 3509.8 637.5 648.0 682.6 717.3 720.2 450.5 458.2 460.7 484.9 490.8 7536.6 7698.4 7783.5 7836.7 7999.4 456.8 476.2 480.1 482.8 490.5 3558.5 3589.0 3604.7 3617.4 3780.1 61406.7 62435.7 63057.7 63525.4 64242.7 56907.4 57465.4 57588.4 57628.4 58333.7 48291.8 49541.0 49943.0 50581.7 51605.0 7174.1 7291.8 7376.7 7466.9 7619.1 25020.9 26007.7 26183.2 26598.3 26928.7 31275.0 31916.4 31937.0 32194.8 32667.5 9470.1 9505.0 9519.5 9792.3 10090.7 9474.7 9613.3 9755.3 10109.7 10120.6 9497.3 9510.7 9521.1 9849.7 9875.7 9121.9 9289.2 9354.3 9459.2 9573.5 8802.3 8834.6 8963.3 9008.7 9347.4 8026.9 8260.9 8360.4 8372.7 8866.1 8045.0 8424.9 8679.4 9252.2 9826.7 16:58:35 INFO - PID 16954 | -------- Summary: end -------- 16:58:35 INFO - PID 16954 | 16:58:36 INFO - TEST-INFO | 16954: exit 0 16:58:36 INFO - TEST-OK | dromaeo_css | took 1123700ms 16:58:36 INFO - TEST-START | kraken 16:58:36 INFO - operating with platform_type : linux_ 16:58:36 INFO - Initialising browser for kraken test... 16:58:36 INFO - TEST-INFO | started process 17277 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5zuGge/profile http://localhost:60692/getInfo.html) 16:58:40 INFO - PID 17277 | __metrics Screen width/height:1600/1200 16:58:40 INFO - PID 17277 | colorDepth:24 16:58:40 INFO - PID 17277 | Browser inner width/height: 1024/697 16:58:40 INFO - PID 17277 | __metrics 16:58:41 INFO - PID 17277 | 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" 16:58:41 INFO - PID 17277 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:58:42 INFO - TEST-INFO | 17277: exit 0 16:58:42 INFO - Browser initialized. 16:58:42 INFO - Running cycle 1/1 for kraken test... 16:58:42 INFO - TEST-INFO | started process 17368 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5zuGge/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:58:54 INFO - PID 17368 | RSS: Main: 149065728 16:58:54 INFO - PID 17368 | 16:58:57 INFO - PID 17368 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60692/tests/kraken/driver.html?testName=audio-beat-detection) 16:58:58 INFO - PID 17368 | RSS: Main: 204288000 16:58:58 INFO - PID 17368 | 16:59:01 INFO - PID 17368 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60692/tests/kraken/driver.html?testName=audio-dft) 16:59:01 INFO - PID 17368 | RSS: Main: 183164928 16:59:01 INFO - PID 17368 | 16:59:04 INFO - PID 17368 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60692/tests/kraken/driver.html?testName=audio-fft) 16:59:05 INFO - PID 17368 | RSS: Main: 265801728 16:59:05 INFO - PID 17368 | 16:59:07 INFO - PID 17368 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60692/tests/kraken/driver.html?testName=audio-oscillator) 16:59:08 INFO - PID 17368 | RSS: Main: 176889856 16:59:08 INFO - PID 17368 | 16:59:10 INFO - PID 17368 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60692/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:59:11 INFO - PID 17368 | RSS: Main: 180412416 16:59:11 INFO - PID 17368 | 16:59:14 INFO - PID 17368 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60692/tests/kraken/driver.html?testName=imaging-darkroom) 16:59:14 INFO - PID 17368 | RSS: Main: 219250688 16:59:14 INFO - PID 17368 | 16:59:18 INFO - PID 17368 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60692/tests/kraken/driver.html?testName=imaging-desaturate) 16:59:19 INFO - PID 17368 | RSS: Main: 214454272 16:59:19 INFO - PID 17368 | 16:59:21 INFO - PID 17368 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60692/tests/kraken/driver.html?testName=json-parse-financial) 16:59:22 INFO - PID 17368 | RSS: Main: 215916544 16:59:22 INFO - PID 17368 | 16:59:24 INFO - PID 17368 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60692/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:59:24 INFO - PID 17368 | RSS: Main: 179814400 16:59:24 INFO - PID 17368 | 16:59:26 INFO - PID 17368 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60692/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:59:27 INFO - PID 17368 | RSS: Main: 187621376 16:59:27 INFO - PID 17368 | 16:59:29 INFO - PID 17368 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60692/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:59:30 INFO - PID 17368 | RSS: Main: 195686400 16:59:30 INFO - PID 17368 | 16:59:33 INFO - PID 17368 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60692/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:59:33 INFO - PID 17368 | RSS: Main: 205697024 16:59:33 INFO - PID 17368 | 16:59:37 INFO - PID 17368 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60692/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:59:37 INFO - PID 17368 | RSS: Main: 201932800 16:59:37 INFO - PID 17368 | 16:59:39 INFO - PID 17368 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60692/tests/kraken/driver.html?testName=ai-astar) 16:59:39 INFO - PID 17368 | RSS: Main: 270618624 16:59:39 INFO - PID 17368 | 16:59:39 INFO - PID 17368 | __start_tp_report 16:59:39 INFO - PID 17368 | _x_x_mozilla_page_load 16:59:39 INFO - PID 17368 | _x_x_mozilla_page_load_details 16:59:39 INFO - PID 17368 | |i|pagename|runs| 16:59:39 INFO - PID 17368 | |0;ai-astar;109;111;112;112;112;111;111;112;111;112 16:59:39 INFO - PID 17368 | |1;audio-beat-detection;149;125;124;166;126;125;125;130;145;125 16:59:39 INFO - PID 17368 | |2;audio-dft;164;164;164;163;164;163;164;163;161;163 16:59:39 INFO - PID 17368 | |3;audio-fft;82;76;75;108;75;75;75;76;98;75 16:59:39 INFO - PID 17368 | |4;audio-oscillator;85;84;124;84;85;85;101;84;85;111 16:59:39 INFO - PID 17368 | |5;imaging-gaussian-blur;114;113;113;114;113;113;113;113;112;113 16:59:39 INFO - PID 17368 | |6;imaging-darkroom;150;150;150;149;150;149;149;149;149;149 16:59:39 INFO - PID 17368 | |7;imaging-desaturate;94;93;94;94;93;94;93;94;94;93 16:59:39 INFO - PID 17368 | |8;json-parse-financial;66;65;65;65;67;66;66;66;67;67 16:59:39 INFO - PID 17368 | |9;json-stringify-tinderbox;56;59;56;56;58;57;56;56;56;56 16:59:39 INFO - PID 17368 | |10;stanford-crypto-aes;89;89;81;82;80;81;86;82;81;81 16:59:39 INFO - PID 17368 | |11;stanford-crypto-ccm;136;138;143;140;138;132;141;131;192;131 16:59:39 INFO - PID 17368 | |12;stanford-crypto-pbkdf2;199;194;186;194;194;196;194;194;194;192 16:59:39 INFO - PID 17368 | |13;stanford-crypto-sha256-iterative;71;71;73;74;73;74;70;70;72;72 16:59:39 INFO - PID 17368 | __end_tp_report 16:59:39 INFO - PID 17368 | __start_cc_report 16:59:39 INFO - PID 17368 | _x_x_mozilla_cycle_collect,2002 16:59:39 INFO - PID 17368 | __end_cc_report 16:59:39 INFO - PID 17368 | __startTimestamp1490140779684__endTimestamp 16:59:39 INFO - PID 17368 | 16:59:39 INFO - PID 17368 | ------- Summary: start ------- 16:59:39 INFO - PID 17368 | Number of tests: 14 16:59:39 INFO - PID 17368 | 16:59:39 INFO - PID 17368 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:0.95 (0.8%) stddev-sans-first:0.53 16:59:39 INFO - PID 17368 | Values: 109.0 111.0 112.0 112.0 112.0 111.0 111.0 112.0 111.0 112.0 16:59:39 INFO - PID 17368 | 16:59:39 INFO - PID 17368 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:128.00 stddev:14.43 (11.3%) stddev-sans-first:14.25 16:59:39 INFO - PID 17368 | Values: 149.0 125.0 124.0 166.0 126.0 125.0 125.0 130.0 145.0 125.0 16:59:39 INFO - PID 17368 | 16:59:39 INFO - PID 17368 | [#2] audio-dft Cycles:10 Average:163.30 Median:164.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 16:59:39 INFO - PID 17368 | Values: 164.0 164.0 164.0 163.0 164.0 163.0 164.0 163.0 161.0 163.0 16:59:39 INFO - PID 17368 | 16:59:39 INFO - PID 17368 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.50 stddev:11.77 (15.6%) stddev-sans-first:12.48 16:59:39 INFO - PID 17368 | Values: 82.0 76.0 75.0 108.0 75.0 75.0 75.0 76.0 98.0 75.0 16:59:39 INFO - PID 17368 | 16:59:39 INFO - PID 17368 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:84.50 stddev:14.33 (17.0%) stddev-sans-first:14.92 16:59:39 INFO - PID 17368 | Values: 85.0 84.0 124.0 84.0 85.0 85.0 101.0 84.0 85.0 111.0 16:59:39 INFO - PID 17368 | 16:59:39 INFO - PID 17368 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:113.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 16:59:39 INFO - PID 17368 | Values: 114.0 113.0 113.0 114.0 113.0 113.0 113.0 113.0 112.0 113.0 16:59:39 INFO - PID 17368 | 16:59:39 INFO - PID 17368 | [#6] imaging-darkroom Cycles:10 Average:149.40 Median:149.50 stddev:0.52 (0.3%) stddev-sans-first:0.50 16:59:39 INFO - PID 17368 | Values: 150.0 150.0 150.0 149.0 150.0 149.0 149.0 149.0 149.0 149.0 16:59:39 INFO - PID 17368 | 16:59:39 INFO - PID 17368 | [#7] imaging-desaturate Cycles:10 Average:93.60 Median:94.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:59:39 INFO - PID 17368 | Values: 94.0 93.0 94.0 94.0 93.0 94.0 93.0 94.0 94.0 93.0 16:59:39 INFO - PID 17368 | 16:59:39 INFO - PID 17368 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 16:59:39 INFO - PID 17368 | Values: 66.0 65.0 65.0 65.0 67.0 66.0 66.0 66.0 67.0 67.0 16:59:39 INFO - PID 17368 | 16:59:39 INFO - PID 17368 | [#9] json-stringify-tinderbox Cycles:10 Average:56.60 Median:56.00 stddev:1.07 (1.9%) stddev-sans-first:1.12 16:59:39 INFO - PID 17368 | Values: 56.0 59.0 56.0 56.0 58.0 57.0 56.0 56.0 56.0 56.0 16:59:39 INFO - PID 17368 | 16:59:39 INFO - PID 17368 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:82.00 stddev:3.46 (4.2%) stddev-sans-first:2.96 16:59:39 INFO - PID 17368 | Values: 89.0 89.0 81.0 82.0 80.0 81.0 86.0 82.0 81.0 81.0 16:59:39 INFO - PID 17368 | 16:59:39 INFO - PID 17368 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:139.00 stddev:18.00 (12.9%) stddev-sans-first:18.95 16:59:39 INFO - PID 17368 | Values: 136.0 138.0 143.0 140.0 138.0 132.0 141.0 131.0 192.0 131.0 16:59:39 INFO - PID 17368 | 16:59:39 INFO - PID 17368 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.70 Median:194.00 stddev:3.27 (1.7%) stddev-sans-first:2.85 16:59:39 INFO - PID 17368 | Values: 199.0 194.0 186.0 194.0 194.0 196.0 194.0 194.0 194.0 192.0 16:59:39 INFO - PID 17368 | 16:59:39 INFO - PID 17368 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:72.50 stddev:1.49 (2.1%) stddev-sans-first:1.54 16:59:39 INFO - PID 17368 | Values: 71.0 71.0 73.0 74.0 73.0 74.0 70.0 70.0 72.0 72.0 16:59:39 INFO - PID 17368 | -------- Summary: end -------- 16:59:39 INFO - PID 17368 | 16:59:40 INFO - TEST-INFO | 17368: exit 0 16:59:40 INFO - TEST-OK | kraken | took 64125ms 16:59:40 INFO - SUITE-END | took 1187s 16:59:41 INFO - Completed test suite (00:19:48) 16:59:41 INFO - javascript benchmark 16:59:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6456.645445225727, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2721.7822574194065, 2746.148693904891, 2763.861806909655, 2769.8615069246534, 2776.527990241659, 5105.540501354877, 5203.0, 5268.604854635899, 5285.709285989269, 5331.680099194046, 5237.188235823444, 5245.86885327867, 5294.602904782138, 5310.150375939841, 5327.467253274671, 4768.260919557474, 4818.42178938527, 4829.541193586604, 4896.314515967767, 4959.50404959503, 4859.732714700708, 4884.731339776311, 4904.950950490503, 4918.555734992127, 4973.104841128614, 4725.31482934976, 4725.976370118162, 4737.265723812815, 4757.119932812441, 4846.0550192712435, 4797.280407938837, 4812.374391329105, 4825.927611085836, 4884.951150488485, 4886.3403440535785, 4764.737939413366, 4782.33047373368, 4786.7845946932475, 4796.5683088521855, 4806.086843499759, 5151.072806894757, 5201.063808514466, 5275.736213189325, 5286.920696189561, 5350.464953504657, 5629.549636029149, 5661.122526008434, 5725.627834190765, 5726.083826587767, 5726.570507211975, 5736.512396446307, 5755.539556835443, 5767.394423585547, 5768.336641286264, 5769.480746732815, 5340.91988620171, 5351.678899266057, 5352.143657014859, 5353.732313384316, 5401.0, 5697.088465845528, 5708.514776244066, 5754.309482862083, 5779.768809247667, 5886.911696324559, 5624.775008999594, 5661.235733175969, 5669.801556945569, 5675.063614503643, 5676.035074037423, 5708.514776244066, 5711.514521265656, 5712.6286791358425, 5713.371529131792, 5715.1713001614535, 5616.5787565932715, 5666.716664166775, 5672.4894759471845, 5677.971610141923, 5679.517241034476, 5529.889402211933, 5577.776888924479, 5579.38626751057, 5655.208270842086, 5691.459311365414, 4721.15019296523, 4725.220338644154, 4726.574608285271, 4740.810367585327, 4768.523147685273, 4060.898477538085, 4067.2272268268935, 4072.328065869158, 4082.693797965105, 4110.23960567296, 4641.489436162019, 4734.19518681825, 4819.927701084486, 4825.445073816486, 4879.682820616648, 5763.711814409263, 5769.451902069297, 5784.913226301609, 5798.246227990334, 5822.7088645567555, 4777.546133117348, 4792.376990991149, 4817.662763606514, 4818.855434336975, 4856.441509226484, 4930.556249937523, 4981.252812078217, 5060.418051924076, 5064.746762661852, 5079.1365467870555, 5285.286486324297, 5289.841304760864, 5315.069862774077, 5337.252784610236, 5342.9465705342445, 5569.888602227852, 5602.85992850182, 5763.7118144093465, 5785.0, 5788.334341550607, 5280.3663560373, 5335.11970524859, 5350.411454739898, 5375.919361209507, 5385.6230063895155, 5601.887962240814, 5658.292713410824, 5665.575081868794, 5667.093265077568, 5667.773289068556, 5592.804251851166, 5627.127795191752, 5640.689762063126, 5659.688717120598, 5732.885342293214, 5587.469190426903, 5587.99416105105, 5588.2455868458865, 5591.27313449249, 5634.267545219095, 5574.052411090043, 5581.386047534849, 5582.358028826575, 5584.860378490408, 5586.13414920688, 5340.145576707863, 5367.1680889462195, 5367.221752845893, 5441.891162176655, 5536.944630553643, 5396.1905714143195, 5458.972705136449, 5459.672419654833, 5460.0, 5463.098588732973, 5305.575553955597, 5318.175682769177, 5318.335208098988, 5319.361676598833, 5322.308099947137], "value": 5173.3669701083145, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.3626826526789, 747.5552046532315, 986.1814693804143, 1001.1590264178099, 1002.0530598584336, 30717.0, 31540.842295788516, 31619.683803161963, 31653.683463165362, 31702.841485792596, 35388.469172962425, 35982.100447488825, 35996.100097497576, 36029.81985090078, 36500.634993650056, 5630.746616402272, 5771.134329850535, 7435.479516433838, 7574.09110906692, 7574.772756817277, 7166.17588977269, 7365.926340736604, 7369.447291453135, 7377.0, 7377.704891804321, 7429.771068679374, 7479.513831600929, 7484.139323977731, 7484.176740558534, 7491.850162996737, 5629.071203251499, 7408.518446301, 7465.6267186641, 7466.066741657293, 7470.701171953116, 5672.234248376499, 7126.501144919857, 7307.525010874276, 7314.707411703525, 7338.0, 30118.397632047454, 30477.08568742941, 30556.236094097603, 30564.777408903617, 30568.2357941051, 2628.7371262873753, 2638.5382558052456, 2642.537555927724, 2648.7218842021693, 2660.201939418186, 21681.891590542105, 21732.456688582755, 21848.0, 21979.780202197933, 23186.188483403, 2535.049356491316, 2696.730326967307, 2699.824511406752, 2709.580015097663, 2735.0974178521237, 164528.0, 166069.0, 166492.0, 166790.99999999878, 167107.0, 32820.67179328176, 33543.49684754731, 33600.831995839864, 44136.558634413246, 44643.776781115885, 36336.0, 36750.26499469996, 38907.416388754194, 39707.20585588272, 39724.80137599294, 11027.338359698444, 11201.60794372193, 11252.212345135762, 11547.884521154681, 11556.537738490366, 8873.866891996626, 8945.73162805117, 8951.851555626732, 8957.328200384996, 8957.731268061969, 13451.663708407172, 13452.32738363078, 13501.257430841202, 13600.659983500294, 13704.931475342759, 5494.780208791683, 5516.448355164532, 5516.779328826882, 5609.27079479665, 5705.971470142623, 851.3359579527978, 879.0989236033117, 885.4377470306401, 889.235257678396, 913.1097180249204, 20387.59224815525, 21085.89457052705, 21274.893625531775, 21304.680429793567, 21575.56848863014, 946.9147776699992, 951.8762560867043, 956.297121615612, 961.9086186812242, 968.6658102954469, 10632.627858024933, 10788.190885683605, 10829.729256768644, 10939.83590246147, 11331.263467874562, 226441.0, 227680.0, 227943.0, 227948.0, 228702.0, 40818.38772418416, 41303.38044929328, 41338.37992430116, 41409.1718165635, 41431.58568414338, 1173.976520469586, 1210.9394530273628, 1217.0324591949422, 1218.056006594896, 1227.4231111377637, 19622.509437264183, 19635.803641963397, 20735.585288294453, 20876.164953401694, 20884.164633414493, 29933.401331972804, 30010.3997920036, 30050.54924176183, 30061.699383006766, 30064.549031764105, 216849.0, 217161.0, 217392.0, 217518.0, 218211.0, 22099.116035358405, 22570.322890313317, 28507.0, 29109.85445072761, 29380.55929161107, 35803.10492237715, 35944.0, 36043.27913441769, 36202.63797362098, 36855.44716829196, 32271.0, 32565.34869302553, 32834.0, 32940.0, 33340.83329583336, 31841.0, 32284.515732264506, 33197.50203746994, 33408.83295583507, 33573.66426335705, 32614.0, 33167.17082072871, 33274.500882487264, 33421.83289083539, 33434.66565334413, 25293.747062529874, 26821.463570728865, 26859.462810744066, 26999.460010800067, 27530.311742206606, 23199.0, 23573.52852942897, 23626.637336266234, 24132.758672413755, 24148.63777043381], "value": 14690.285602572983, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.80953142491603, 408.64039645112297, 415.50554839740704, 430.09035889094565, 445.58560538699015, 11106.337057095478, 17113.48659540214, 17470.737938930924, 17764.822351776493, 17772.555686107855, 13566.660833479167, 14316.642083947907, 17370.826291737078, 17636.0, 18749.0, 5364.195370694398, 5423.593230507708, 5616.241807356016, 5633.324001119871, 5633.887322253552, 5629.746661400247, 5656.8020119295625, 5663.830085097454, 5664.745086471098, 5667.744951477172, 5444.373897001836, 5647.1529270609535, 5653.886922261552, 5663.575231857607, 5674.687892165929, 5499.257600223958, 5565.9443405565835, 5570.554355651539, 5610.523105536035, 5642.4357564243655, 5098.770555325019, 5124.76938537763, 5132.769025393866, 5136.0, 5140.922886156711, 21434.57130857374, 21698.674519882214, 21764.347069587937, 21764.782352176433, 21771.129154833787, 1487.0334282716321, 1492.1420183394591, 1495.6036650287683, 1535.9232038398147, 1539.0919357579082, 13054.804177937338, 13056.934715326362, 13351.0, 14520.056196347203, 14765.557033289018, 1673.8828282020263, 1690.0, 1700.5918579540944, 1708.44475545447, 1732.5841797968396, 84849.15150848475, 86189.0, 87848.0, 89793.10206897913, 90475.54762226212, 10426.0, 10647.84028239577, 10664.0, 10728.94635526833, 10791.946040269906, 14900.329485173193, 14955.401783928739, 14973.625659358386, 14974.101553906801, 14987.475438359605, 6016.639001659914, 6245.437910588069, 6574.8356291093105, 6778.796636100925, 7012.719491220396, 5690.658560486384, 5713.714314284269, 5955.791547295824, 5982.790602328898, 5993.490553303018, 6552.3775241352, 6670.366315200048, 6678.732850686015, 6805.0, 6909.7581584644295, 2012.3661046770221, 2029.5488725561295, 2080.3238947342174, 2082.9270975515783, 2216.9445763856033, 815.339574944297, 830.6594296338473, 849.0133088572769, 860.8837806895989, 870.5821205821114, 16169.272382742805, 16340.509784706477, 16666.0, 16864.747028794576, 17196.1401929903, 847.576211894053, 850.2093053460342, 853.4495250563352, 855.7432770168924, 870.9520976346236, 8942.73171804847, 9126.817463650823, 9238.815223695623, 9251.95374023139, 9363.859542106873, 439095.0, 456743.0, 477685.0, 478946.0, 488771.0, 77823.61088194523, 88442.11557884338, 89136.554317228, 90409.0, 90448.0, 1041.6979076068008, 1054.0987455725244, 1091.410638255349, 1091.9071878890384, 1096.3969816600998, 16345.182740862672, 16709.415170469463, 17130.31478740886, 17145.742813857552, 17438.91280543589, 36389.81805090958, 37608.811955940044, 38335.61664383321, 40110.598894011855, 40558.39162412625, 50603.2409513865, 50879.0, 51163.232551512505, 52556.0, 53545.46454535405, 7812.125089978251, 7827.74756039031, 7971.0833254174195, 7993.72021979228, 8034.437589368688, 11692.0, 11748.35384053851, 11756.235844670411, 11885.465154067915, 11953.163278570417, 9844.704658859959, 10087.897495862726, 10096.899031009596, 10281.640142595272, 10295.588176472857, 11021.669349919515, 11041.116710663287, 11071.730295289608, 11112.833307500232, 11125.44372781374, 10189.133923616278, 10209.38743675382, 10415.270931034755, 10494.160467162761, 10564.683059508227, 7796.557636837203, 7891.250331218525, 7963.0, 8101.230383113595, 8131.349492040505, 9740.512974351112, 9785.315027947976, 10867.0, 10877.836832447361, 11098.722531936442], "value": 8623.655208735947, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1264.5068423314906, 1291.9677008074798, 1315.611894491125, 1323.4441534555492, 1333.6532501549593, 9238.168564829164, 9658.855117173249, 9659.46872921989, 9660.178884794792, 9661.130498255156, 9376.343655944069, 9705.320627556073, 9758.0, 9758.414495130279, 9762.853557196648, 2176.4123686604607, 2212.7012853264846, 2214.1586197245024, 2214.413180507167, 2215.3353993801793, 1776.2894842063213, 1842.9354972575964, 2033.0749508973456, 2079.5736873940805, 2095.423758466426, 1836.742856000161, 1861.1345724238226, 1870.1023508715825, 2098.800613941673, 2162.4377661807966, 2078.740157480315, 2086.5096702274955, 2099.548597051626, 2101.9789802101936, 2105.1263725553954, 1994.8104930031623, 2069.4205622425743, 2070.33749200256, 2073.4919944613516, 2080.9687854682193, 8256.091829898767, 8521.44610600309, 8521.872171917426, 8529.360297977677, 9709.514524273758, 4561.270196768534, 5265.815696450644, 5421.783128674848, 5430.891382172374, 5436.891262174774, 3010.1872494426384, 3025.773067019982, 3073.707997740211, 3075.0621060576514, 3161.7944833585743, 948.5684013773716, 953.8759961205068, 978.5254151736402, 987.6395115782688, 995.1889210293588, 13622.659433514142, 13924.373403196982, 14005.509807156803, 14007.929960350133, 14024.228667423287, 4220.177065472203, 4394.340848872695, 4572.359869618256, 4697.577218050392, 4720.339152518582, 10045.146162576117, 10046.296759226783, 10057.748556286006, 10066.547005384775, 10073.395596264247, 5036.093503169464, 5100.209467532539, 5102.311187989574, 5108.463611320833, 5111.923321150186, 4853.296272040534, 4922.089413458521, 4996.600271978233, 5025.899482010339, 5046.571041461517, 3577.5706915170344, 3634.47300141478, 3662.1393972416463, 3700.1674623209565, 3762.021874312644, 1039.2828948025838, 1042.801867645145, 1047.984280235797, 1048.9370637761758, 1061.6708820265742, 676.24936320684, 694.9583025018414, 695.4581006421537, 705.4356514788149, 731.0605871455155, 5011.724355160502, 5309.920351194735, 5454.563634909197, 5486.972565137149, 5537.335519737658, 802.1336956087412, 807.4832107451236, 811.2050190812919, 812.4597142899905, 821.109096630163, 3399.439092549751, 3526.858925642997, 3537.4870643756512, 3542.1321776165005, 3620.456931460302, 11574.0, 11880.584179553674, 12439.440225189888, 12617.747645047048, 12620.55828046014, 12275.140740148105, 12336.074794390457, 12467.688307792196, 12508.937455312665, 12547.623571292876, 7938.761837144895, 8238.299744521662, 8721.30229581632, 9084.273258139334, 9107.814124610046, 5468.48049435303, 5547.611667183259, 5550.55595552363, 5657.8019769307875, 5956.821295361146, 11214.55141794319, 11364.090872730327, 11379.54481820718, 11413.258138220988, 11462.828057578976, 11220.887791121984, 11893.881061189277, 11955.64133076009, 11984.340861252365, 11986.700332491757, 8548.487090774574, 8747.781305467159, 8756.518391488275, 8763.561821908752, 8765.386422950332, 8779.297656187617, 8949.284057275532, 9039.81920361576, 9088.863667044867, 9090.545472726206, 8146.796330091795, 8147.826564270038, 8265.876011859948, 8457.661693532189, 8493.915060849313, 7958.522488650699, 8035.236652518001, 8101.635426405944, 8160.918390816016, 8282.17178282191, 6996.790096297119, 7014.123234595676, 7082.893756593552, 7086.255943125898, 7089.220185779457, 4740.739259340769, 4859.684120532154, 4921.803127874988, 4980.402351717817, 5141.331626888481, 4690.624750020059, 4747.2879068140055, 4752.952470475389, 4775.33145359643, 4873.829415970424], "value": 4506.988989885287, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.8321329777956, 396.494469551322, 401.6405317241071, 402.86101295053203, 405.3190639725264, 5185.222216667502, 5264.789408423663, 5268.6575372600755, 5281.2342210379475, 5320.042392369372, 4998.600111991041, 5131.153359695646, 5131.538161565459, 5169.534741873231, 5234.293370394996, 4026.2752704513177, 4028.2950483665386, 4040.7777572233517, 4056.4523789288364, 4067.8983025424304, 4060.2894493463673, 4075.266452038632, 4075.286824805662, 4078.2659121358142, 4084.305668036426, 3936.4488971543865, 3991.241664083829, 4005.499312585927, 4036.6770658347264, 4044.7370920890194, 3965.861194858166, 4010.3984402339593, 4013.4581831452965, 4052.3111071117983, 4059.9594004060023, 3521.3765744520497, 3521.4893840393, 3521.8730006397964, 3532.6997205237585, 3538.486919396673, 4945.653804233705, 5064.164412871872, 5071.366079240095, 5072.644914855961, 5081.085404627165, 4589.036302376505, 4618.8152473901, 4618.953810461886, 4630.953690463086, 4640.303954406832, 5410.215518749798, 5439.292891924064, 5444.3194600674915, 5448.346198456171, 5454.427285135043, 3879.9806000970098, 3889.183271512986, 3897.707671924617, 3900.258950799339, 3902.843886244547, 5500.0, 5759.5968282220265, 5769.221155144086, 5770.730439303388, 5811.012127938261, 3985.720999530005, 3987.1826275614007, 3991.44119823225, 3994.1811928554575, 4006.8196931137586, 4033.6773058155277, 4042.413849991735, 4043.3126368516832, 4053.5135783706146, 4055.0, 4505.324201369821, 4575.702579332333, 4602.65480088988, 4623.0, 4637.814487420465, 5475.507204351547, 5494.5054945055135, 5501.449855014546, 5516.613837031449, 5520.067976208295, 1381.5233744358181, 1386.9098508596908, 1389.7081612861411, 1391.172252509755, 1392.1229625335973, 883.2404132446092, 930.497531333086, 941.9293552983416, 954.7565370830393, 955.145145095136, 4775.73733444657, 4778.450478194983, 4780.521947805191, 4781.856544303677, 4800.35195248644, 5643.548516118701, 5645.322561292671, 5658.0, 5658.943410565924, 5683.60214784961, 4598.908021839545, 4760.785764640599, 4768.332433459318, 4785.138675038457, 4801.903961920742, 2961.955570666442, 2971.138369872756, 2973.628296462942, 2980.3177140573225, 2994.7903646744517, 5256.6320357574605, 5259.500347466985, 5280.735963201824, 5285.894282114336, 5295.861389801211, 5586.748177475514, 5741.0, 5748.109043098327, 5765.394633563499, 5770.6249093808765, 5254.185601231815, 5261.657992230493, 5275.709835959059, 5276.577873770012, 5278.0, 5515.531179849758, 5645.661260324394, 5652.576056795839, 5659.405762394889, 5660.830175094754, 5524.8342549723575, 5533.170024496358, 5552.250446189712, 5566.803137325494, 5571.220029195835, 5232.267482552522, 5259.789608415621, 5269.578433725216, 5281.042616134977, 5322.635438940187, 3836.4628951946193, 3979.3036218662196, 3993.840246390228, 4008.1783234437453, 4009.278329900529, 5610.0, 5611.831645050655, 5611.971940140274, 5617.7191140442, 5630.915536267041, 5417.943501017264, 5431.484009019295, 5448.45515448452, 5459.836204913859, 5481.095619222783, 5321.3348331458565, 5439.5648348132845, 5440.4365140832815, 5462.644928079662, 5486.698231597141, 5369.972520609543, 5402.297701298963, 5412.621116521806, 5422.996745602076, 5427.6472029317965, 5504.422035686355, 5508.7521061553125, 5516.3380394352935, 5528.419515950928, 5549.916751248816, 5239.44985776488, 5302.761375738024, 5358.544523715372, 5377.3816011159215, 5383.300170977748], "value": 4135.571520520778, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.3207487800856, 625.5777350288554, 674.5885010143811, 681.2029924987764, 688.545559930446, 14311.713765724679, 14882.925585372084, 14890.776638350433, 14922.0, 14935.850641493582, 14669.266536673176, 14707.264636768172, 14767.556973290819, 14838.851611483882, 14859.108453492798, 822.2722890242134, 823.3577809308749, 837.7738010737097, 839.9664013439485, 846.5894041389921, 848.3552500099937, 848.8811566380712, 849.864021756519, 850.4982060584254, 851.4252879306474, 880.9779755506131, 882.788130848595, 883.5228976352762, 886.9866951995725, 888.9199972002518, 881.858902575588, 889.7864512517014, 890.1009979920294, 890.3233542507676, 891.0777345447431, 656.5699466849221, 660.9669516524154, 662.6653539962289, 662.8707402056601, 663.1081195791653, 11595.130365222642, 11738.23701459411, 11803.822942655866, 11808.881911180864, 13819.792703109462, 13131.418417538958, 13585.252811095386, 13651.249181295025, 13853.307334633228, 13993.3702983366, 9134.269258459308, 9274.48990305533, 9409.76475588109, 9439.622415103388, 9893.75265618358, 2701.567749160125, 2738.657667791526, 2742.465219282241, 2785.2897511134734, 2803.6775770786417, 62556.68721656408, 63418.68290658564, 64828.351716482706, 65210.673946630435, 65486.67256663686, 10279.845802312972, 10376.533056012497, 10438.37369757817, 10522.210834187466, 10740.516676749565, 21190.576188476454, 21483.355499335044, 21550.353489395344, 21558.353249402542, 21949.231776887733, 6496.447801936888, 6512.641804700692, 6543.247526534415, 6545.181852268466, 6794.592324460548, 3005.353848922492, 3137.498000319938, 3240.513922911535, 3365.596128464551, 3381.8309084545676, 3421.623621401644, 3470.1845066409373, 3477.51314815926, 3485.0938755923644, 3509.78941263525, 637.5027478566725, 648.0085469232082, 682.5938566552893, 717.3149642091789, 720.2390156068362, 450.4864454521848, 458.2370353361682, 460.6821293307607, 484.88605177783194, 490.82821012646, 7536.585487798224, 7698.422618303538, 7783.455158138989, 7836.725714599962, 7999.36005119589, 456.7647661454354, 476.19047619047063, 480.12856665152634, 482.79722516543137, 490.5168409117088, 3558.5373901393173, 3589.0, 3604.7296452766145, 3617.3850445423814, 3780.1305699689224, 61406.69296653488, 62435.68782156151, 63057.68471157615, 63525.364746351945, 64242.6787866067, 56907.43092569021, 57465.425345746844, 57588.424115759146, 57628.42371576314, 58333.70833145892, 48291.75854120707, 49541.0, 49942.99999999927, 50581.74709126431, 51605.0, 7174.1032370953635, 7291.8177045572165, 7376.7418140364825, 7466.925330746623, 7619.123800762984, 25020.874895626133, 26007.739922600533, 26183.214503564923, 26598.33504162334, 26928.73071269262, 31275.0, 31916.361672766878, 31937.0, 32194.839025804722, 32667.509987350684, 9470.14768670823, 9504.95247523758, 9519.476428796483, 9792.265580081665, 10090.73865766779, 9474.668386606436, 9613.279004074582, 9755.268354873555, 10109.747256318651, 10120.59517619287, 9497.28770342241, 9510.714678559654, 9521.143097121292, 9849.65526206608, 9875.703728888146, 9121.863172052557, 9289.16397524199, 9354.29842761782, 9459.243260539279, 9573.521323933915, 8802.29581633455, 8834.646614135363, 8963.327750418875, 9008.684696035607, 9347.392419492984, 8026.8795968061695, 8260.917390826255, 8360.372972027, 8372.706955256537, 8866.069062748576, 8044.959775201087, 8424.915750842412, 8679.392442528962, 9252.181906289175, 9826.65606703762], "value": 5930.479384405439, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 112.0, 112.0, 112.0, 111.0, 111.0, 112.0, 111.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 125.0, 124.0, 166.0, 126.0, 125.0, 125.0, 130.0, 145.0, 125.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 164.0, 163.0, 164.0, 163.0, 164.0, 163.0, 161.0, 163.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 76.0, 75.0, 108.0, 75.0, 75.0, 75.0, 76.0, 98.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 124.0, 84.0, 85.0, 85.0, 101.0, 84.0, 85.0, 111.0], "value": 92.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 149.0, 150.0, 149.0, 149.0, 149.0, 149.0, 149.0], "value": 149.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 93.0, 94.0, 93.0, 94.0, 94.0, 93.0], "value": 93.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 67.0, 66.0, 66.0, 66.0, 67.0, 67.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 56.0, 56.0, 58.0, 57.0, 56.0, 56.0, 56.0, 56.0], "value": 56.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 81.0, 82.0, 80.0, 81.0, 86.0, 82.0, 81.0, 81.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 138.0, 143.0, 140.0, 138.0, 132.0, 141.0, 131.0, 192.0, 131.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 194.0, 186.0, 194.0, 194.0, 196.0, 194.0, 194.0, 194.0, 192.0], "value": 193.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 73.0, 74.0, 73.0, 74.0, 70.0, 70.0, 72.0, 72.0], "value": 72.0, "unit": "score"}]}]} 16:59:41 INFO - Return code: 0 16:59:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:59:41 ERROR - # TBPL SUCCESS # 16:59:41 INFO - Running post-action listener: _resource_record_post_action 16:59:41 INFO - [mozharness: 2017-03-21 23:59:41.490081Z] Finished run-tests step (success) 16:59:41 INFO - Running post-run listener: _resource_record_post_run 16:59:41 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 369868800; Read time: 12; Write time: 258668 16:59:41 INFO - TinderboxPrint: CPU usage
12.9% 16:59:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:59:41 INFO - TinderboxPrint: I/O write bytes / time
369,868,800 / 258,668 16:59:41 INFO - TinderboxPrint: CPU idle
8,365.5 (87.0%) 16:59:41 INFO - TinderboxPrint: CPU user
1,201.0 (12.5%) 16:59:41 INFO - TinderboxPrint: Swap in / out
0 / 0 16:59:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 111218688; Read time: 0; Write time: 89332 16:59:41 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 258650112; Read time: 12; Write time: 169336 16:59:42 INFO - Running post-run listener: _upload_blobber_files 16:59:42 INFO - Blob upload gear active. 16:59:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:59:42 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 16:59:42 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'] 16:59:42 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 16:59:42 INFO - (blobuploader) - INFO - Open directory for files ... 16:59:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:59:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:59:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:59:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:59:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:59:43 INFO - (blobuploader) - INFO - Done attempting. 16:59:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:59:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:59:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:59:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:59:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:59:44 INFO - (blobuploader) - INFO - Done attempting. 16:59:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:59:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:59:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:59:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:59:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:59:47 INFO - (blobuploader) - INFO - Done attempting. 16:59:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:59:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:59:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:59:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:59:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:59:48 INFO - (blobuploader) - INFO - Done attempting. 16:59:48 INFO - (blobuploader) - INFO - Iteration through files over. 16:59:48 INFO - Return code: 0 16:59:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:59:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:59:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9fae421b542b6af1e1fb251e4d54dbb756aec8dbc636dc16ffbf89a0d9f6a39c22ff1a19bb58332866b5727e9ec3fa76cc660b6a7f813ece63b731f1f6835ca6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b2ab4c8607276c9304b74f5641097ec73f5c779f70995c800949d913ea5f09dd4e22ec16ca6dcab1d47df5b91e28693ded832c0a4ca1de981b10d066d4762e3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a21986f18f3878408c522daf944997850c7771e4b770637cfa7e7e392574ccab0c8c20c660f0724cc8b3c7058554dc28de0670c945814c54fa1cd068eef932a6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86039c2e6f3a00d61f2140d1c05b61fe7e13aa608b532aac26534a97656bcd103830b7dc39995b39a6ed4a5620882960a79d69a573263a8859fe25d862770c5a"} 16:59:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:59:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:59:48 INFO - Contents: 16:59:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9fae421b542b6af1e1fb251e4d54dbb756aec8dbc636dc16ffbf89a0d9f6a39c22ff1a19bb58332866b5727e9ec3fa76cc660b6a7f813ece63b731f1f6835ca6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b2ab4c8607276c9304b74f5641097ec73f5c779f70995c800949d913ea5f09dd4e22ec16ca6dcab1d47df5b91e28693ded832c0a4ca1de981b10d066d4762e3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a21986f18f3878408c522daf944997850c7771e4b770637cfa7e7e392574ccab0c8c20c660f0724cc8b3c7058554dc28de0670c945814c54fa1cd068eef932a6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86039c2e6f3a00d61f2140d1c05b61fe7e13aa608b532aac26534a97656bcd103830b7dc39995b39a6ed4a5620882960a79d69a573263a8859fe25d862770c5a"} 16:59:48 INFO - Running post-run listener: copy_logs_to_upload_dir 16:59:48 INFO - Copying logs to upload dir... 16:59:48 INFO - mkdir: /builds/slave/test/build/upload/logs 16:59:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.558060 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-21 16:59:48.298758) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 16:59:48.306587) ========= 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=41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628 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/9fae421b542b6af1e1fb251e4d54dbb756aec8dbc636dc16ffbf89a0d9f6a39c22ff1a19bb58332866b5727e9ec3fa76cc660b6a7f813ece63b731f1f6835ca6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b2ab4c8607276c9304b74f5641097ec73f5c779f70995c800949d913ea5f09dd4e22ec16ca6dcab1d47df5b91e28693ded832c0a4ca1de981b10d066d4762e3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a21986f18f3878408c522daf944997850c7771e4b770637cfa7e7e392574ccab0c8c20c660f0724cc8b3c7058554dc28de0670c945814c54fa1cd068eef932a6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86039c2e6f3a00d61f2140d1c05b61fe7e13aa608b532aac26534a97656bcd103830b7dc39995b39a6ed4a5620882960a79d69a573263a8859fe25d862770c5a"} build_url:https://queue.taskcluster.net/v1/task/HuOhXf_MT0-mU7I9TNQtaQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011379 build_url: 'https://queue.taskcluster.net/v1/task/HuOhXf_MT0-mU7I9TNQtaQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9fae421b542b6af1e1fb251e4d54dbb756aec8dbc636dc16ffbf89a0d9f6a39c22ff1a19bb58332866b5727e9ec3fa76cc660b6a7f813ece63b731f1f6835ca6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b2ab4c8607276c9304b74f5641097ec73f5c779f70995c800949d913ea5f09dd4e22ec16ca6dcab1d47df5b91e28693ded832c0a4ca1de981b10d066d4762e3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a21986f18f3878408c522daf944997850c7771e4b770637cfa7e7e392574ccab0c8c20c660f0724cc8b3c7058554dc28de0670c945814c54fa1cd068eef932a6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86039c2e6f3a00d61f2140d1c05b61fe7e13aa608b532aac26534a97656bcd103830b7dc39995b39a6ed4a5620882960a79d69a573263a8859fe25d862770c5a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 16:59:48.334410) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 16:59:48.334744) ========= 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=41bf3e9aed84707956354da8000001c5-1490139524.255308-2019554628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004387 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 16:59:48.413848) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 16:59:48.417170) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 16:59:48.417513) ========= ========= Total master_lag: 0.18 =========