builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-078 starttime: 1488419431.2 results: success (0) revision: e91de6fb2b3dce9c932428265b0fdb630ea470d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-01 17:50:31.204155) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-01 17:50:31.204662) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-01 17:50:31.204939) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-01 17:50:31.221682) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 17:50:31.222007) ========= 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=dac658600622fd96716c9acf000001b3-1488415547.754645-832626236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-01 17:50:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.5M=0s 2017-03-01 17:50:31 (42.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.199456 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 17:50:31.434474) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 17:50:31.434750) ========= 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=dac658600622fd96716c9acf000001b3-1488415547.754645-832626236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019511 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 17:50:31.483989) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 17:50:31.484308) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e91de6fb2b3dce9c932428265b0fdb630ea470d7 --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 e91de6fb2b3dce9c932428265b0fdb630ea470d7 --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=dac658600622fd96716c9acf000001b3-1488415547.754645-832626236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-01 17:50:32,029 truncating revision to first 12 chars 2017-03-01 17:50:32,029 Setting DEBUG logging. 2017-03-01 17:50:32,029 attempt 1/10 2017-03-01 17:50:32,029 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e91de6fb2b3d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-01 17:50:32,442 unpacking tar archive at: mozilla-central-e91de6fb2b3d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.727791 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 17:50:32.225139) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-01 17:50:32.225486) ========= script_repo_revision: e91de6fb2b3dce9c932428265b0fdb630ea470d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-01 17:50:32.225863) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-01 17:50:32.226128) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-01 17:50:32.234729) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-03-01 17:50:32.235129) ========= /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=dac658600622fd96716c9acf000001b3-1488415547.754645-832626236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:50:32 INFO - MultiFileLogger online at 20170301 17:50:32 in /builds/slave/test 17:50:32 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 17:50:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:50:32 INFO - {'append_to_log': False, 17:50:32 INFO - 'base_work_dir': '/builds/slave/test', 17:50:32 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:50:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:50:32 INFO - 'branch': 'Firefox-Non-PGO', 17:50:32 INFO - 'buildbot_json_path': 'buildprops.json', 17:50:32 INFO - 'config_files': ('talos/linux_config.py',), 17:50:32 INFO - 'default_actions': ('clobber', 17:50:32 INFO - 'read-buildbot-config', 17:50:32 INFO - 'download-and-extract', 17:50:32 INFO - 'populate-webroot', 17:50:32 INFO - 'create-virtualenv', 17:50:32 INFO - 'install', 17:50:32 INFO - 'run-tests'), 17:50:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:50:32 INFO - 'download_minidump_stackwalk': True, 17:50:32 INFO - 'download_symbols': 'ondemand', 17:50:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:50:32 INFO - 'tooltool.py': '/tools/tooltool.py', 17:50:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:50:32 INFO - '/tools/misc-python/virtualenv.py')}, 17:50:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:50:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:50:32 INFO - 'gecko_profile': False, 17:50:32 INFO - 'gecko_profile_interval': 0, 17:50:32 INFO - 'installer_path': 'installer.exe', 17:50:32 INFO - 'log_level': 'info', 17:50:32 INFO - 'log_name': 'talos', 17:50:32 INFO - 'log_to_console': True, 17:50:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:50:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:50:32 INFO - 'opt_config_files': (), 17:50:32 INFO - 'pip_index': False, 17:50:32 INFO - 'suite': 'dromaeojs', 17:50:32 INFO - 'system_bits': '32', 17:50:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:50:32 INFO - 'title': 'talos-linux64-ix-078', 17:50:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:50:32 INFO - 'use_talos_json': True, 17:50:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:50:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:50:32 INFO - 'work_dir': 'build'} 17:50:32 INFO - [mozharness: 2017-03-02 01:50:32.882780Z] Running clobber step. 17:50:32 INFO - Running pre-action listener: _resource_record_pre_action 17:50:32 INFO - Running main action method: clobber 17:50:32 INFO - rmtree: /builds/slave/test/build 17:50:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:50:33 INFO - Running post-action listener: _resource_record_post_action 17:50:33 INFO - [mozharness: 2017-03-02 01:50:33.791564Z] Finished clobber step (success) 17:50:33 INFO - [mozharness: 2017-03-02 01:50:33.791664Z] Running read-buildbot-config step. 17:50:33 INFO - Running pre-action listener: _resource_record_pre_action 17:50:33 INFO - Running main action method: read_buildbot_config 17:50:33 INFO - Using buildbot properties: 17:50:33 INFO - { 17:50:33 INFO - "project": "", 17:50:33 INFO - "product": "firefox", 17:50:33 INFO - "who": "kwierso@gmail.com", 17:50:33 INFO - "installer_path": "public/build/target.tar.bz2", 17:50:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 17:50:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:50:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 17:50:33 INFO - "stage_platform": "linux64", 17:50:33 INFO - "basedir": "/builds/slave/test", 17:50:33 INFO - "buildnumber": 1004, 17:50:33 INFO - "platform": "ubuntu64_hw", 17:50:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:50:33 INFO - "slavebuilddir": "test", 17:50:33 INFO - "taskId": "VfRNMoJDTj-BMgB4nqq1tA", 17:50:33 INFO - "branch": "mozilla-central", 17:50:33 INFO - "script_repo_revision": "production", 17:50:33 INFO - "revision": "e91de6fb2b3dce9c932428265b0fdb630ea470d7", 17:50:33 INFO - "slavename": "talos-linux64-ix-078", 17:50:33 INFO - "repo_path": "mozilla-central" 17:50:33 INFO - } 17:50:33 INFO - Finding installer, test and symbols from parent task. 17:50:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VfRNMoJDTj-BMgB4nqq1tA'}, attempt #1 17:50:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VfRNMoJDTj-BMgB4nqq1tA'}, attempt #1 17:50:34 INFO - Task dependencies: YQ4KV7HrSM2kN4Y5nUZ89A 17:50:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YQ4KV7HrSM2kN4Y5nUZ89A'}, attempt #1 17:50:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YQ4KV7HrSM2kN4Y5nUZ89A/artifacts/public/build/target.tar.bz2 17:50:35 INFO - Set test_url: https://queue.taskcluster.net/v1/task/YQ4KV7HrSM2kN4Y5nUZ89A/artifacts/public/build/test_packages.json 17:50:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YQ4KV7HrSM2kN4Y5nUZ89A/artifacts/public/build/target.crashreporter-symbols.zip 17:50:35 INFO - Running post-action listener: _resource_record_post_action 17:50:35 INFO - [mozharness: 2017-03-02 01:50:35.160633Z] Finished read-buildbot-config step (success) 17:50:35 INFO - [mozharness: 2017-03-02 01:50:35.160850Z] Running download-and-extract step. 17:50:35 INFO - Running pre-action listener: _resource_record_pre_action 17:50:35 INFO - Running main action method: download_and_extract 17:50:35 INFO - mkdir: /builds/slave/test/build/tests 17:50:35 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')]} 17:50:35 INFO - trying https://queue.taskcluster.net/v1/task/YQ4KV7HrSM2kN4Y5nUZ89A/artifacts/public/build/target.test_packages.json 17:50:35 INFO - Downloading https://queue.taskcluster.net/v1/task/YQ4KV7HrSM2kN4Y5nUZ89A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:50:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YQ4KV7HrSM2kN4Y5nUZ89A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:50:35 INFO - Downloaded 896 bytes. 17:50:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:50:35 INFO - Using the following test package requirements: 17:50:35 INFO - {u'common': [u'target.common.tests.zip'], 17:50:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:50:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:50:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:50:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:50:35 INFO - u'mozbase': [u'target.common.tests.zip'], 17:50:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:50:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:50:35 INFO - u'web-platform': [u'target.common.tests.zip', 17:50:35 INFO - u'target.web-platform.tests.zip'], 17:50:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:50:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:50:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YQ4KV7HrSM2kN4Y5nUZ89A/artifacts/public/build/target.common.tests.zip 17:50:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YQ4KV7HrSM2kN4Y5nUZ89A/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:50:35 INFO - Fetch https://queue.taskcluster.net/v1/task/YQ4KV7HrSM2kN4Y5nUZ89A/artifacts/public/build/target.common.tests.zip into memory 17:50:36 INFO - Expected file size: 57476316 17:50:36 INFO - Obtained file size: 57476316 17:50:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:50:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YQ4KV7HrSM2kN4Y5nUZ89A/artifacts/public/build/target.common.tests.zip 17:50:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YQ4KV7HrSM2kN4Y5nUZ89A/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:50:46 INFO - Fetch https://queue.taskcluster.net/v1/task/YQ4KV7HrSM2kN4Y5nUZ89A/artifacts/public/build/target.common.tests.zip into memory 17:50:47 INFO - Expected file size: 57476316 17:50:47 INFO - Obtained file size: 57476316 17:50:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YQ4KV7HrSM2kN4Y5nUZ89A/artifacts/public/build/target.talos.tests.zip 17:50:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YQ4KV7HrSM2kN4Y5nUZ89A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:50:58 INFO - Fetch https://queue.taskcluster.net/v1/task/YQ4KV7HrSM2kN4Y5nUZ89A/artifacts/public/build/target.talos.tests.zip into memory 17:50:58 INFO - Expected file size: 14404424 17:50:58 INFO - Obtained file size: 14404424 17:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:59 INFO - trying https://queue.taskcluster.net/v1/task/YQ4KV7HrSM2kN4Y5nUZ89A/artifacts/public/build/target.tar.bz2 17:50:59 INFO - Downloading https://queue.taskcluster.net/v1/task/YQ4KV7HrSM2kN4Y5nUZ89A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:50:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YQ4KV7HrSM2kN4Y5nUZ89A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:51:00 INFO - Downloaded 61616003 bytes. 17:51:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YQ4KV7HrSM2kN4Y5nUZ89A/artifacts/public/build/target.tar.bz2 17:51:00 INFO - mkdir: /builds/slave/test/properties 17:51:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:51:00 INFO - Writing to file /builds/slave/test/properties/build_url 17:51:00 INFO - Contents: 17:51:00 INFO - build_url:https://queue.taskcluster.net/v1/task/YQ4KV7HrSM2kN4Y5nUZ89A/artifacts/public/build/target.tar.bz2 17:51:00 INFO - Running post-action listener: _resource_record_post_action 17:51:00 INFO - Running post-action listener: set_extra_try_arguments 17:51:00 INFO - [mozharness: 2017-03-02 01:51:00.949308Z] Finished download-and-extract step (success) 17:51:00 INFO - [mozharness: 2017-03-02 01:51:00.949533Z] Running populate-webroot step. 17:51:00 INFO - Running pre-action listener: _resource_record_pre_action 17:51:00 INFO - Running main action method: populate_webroot 17:51:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:51:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:51:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:51:00 INFO - '--tppagecycles', 17:51:00 INFO - '7'], 17:51:00 INFO - 'tests': ['tsvgm']}}, 17:51:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:51:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:51:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:51:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:51:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:51:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:51:00 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:51:00 INFO - 'talos_options': ['--disable-e10s'], 17:51:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:51:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:51:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:51:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:51:00 INFO - 'talos_options': ['--disable-e10s'], 17:51:00 INFO - 'tests': ['damp', 'tps']}, 17:51:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:51:00 INFO - 'tests': ['damp', 'tps']}, 17:51:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:51:00 INFO - 'tests': ['dromaeo_dom']}, 17:51:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:51:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:51:00 INFO - 'tests': ['basic_compositor_video']}, 17:51:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:51:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:51:00 INFO - 'tests': ['a11yr', 17:51:00 INFO - 'ts_paint', 17:51:00 INFO - 'tpaint', 17:51:00 INFO - 'sessionrestore', 17:51:00 INFO - 'sessionrestore_no_auto_restore', 17:51:00 INFO - 'tabpaint']}, 17:51:00 INFO - 'other-e10s': {'tests': ['a11yr', 17:51:00 INFO - 'ts_paint', 17:51:00 INFO - 'tpaint', 17:51:00 INFO - 'sessionrestore', 17:51:00 INFO - 'sessionrestore_no_auto_restore', 17:51:00 INFO - 'tabpaint']}, 17:51:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:51:00 INFO - 'ts_paint', 17:51:00 INFO - 'tpaint', 17:51:00 INFO - 'sessionrestore', 17:51:00 INFO - 'sessionrestore_no_auto_restore', 17:51:00 INFO - 'tabpaint']}, 17:51:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:51:00 INFO - 'ts_paint', 17:51:00 INFO - 'tpaint', 17:51:00 INFO - 'sessionrestore', 17:51:00 INFO - 'sessionrestore_no_auto_restore', 17:51:00 INFO - 'tabpaint']}, 17:51:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:51:00 INFO - 'tests': ['a11yr', 17:51:00 INFO - 'ts_paint', 17:51:00 INFO - 'tpaint', 17:51:00 INFO - 'sessionrestore', 17:51:00 INFO - 'sessionrestore_no_auto_restore', 17:51:00 INFO - 'tabpaint']}, 17:51:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:51:00 INFO - 'tests': ['a11yr', 17:51:00 INFO - 'ts_paint', 17:51:00 INFO - 'tpaint', 17:51:00 INFO - 'sessionrestore', 17:51:00 INFO - 'sessionrestore_no_auto_restore', 17:51:00 INFO - 'tabpaint']}, 17:51:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:51:00 INFO - 'tests': ['tsvgx', 17:51:00 INFO - 'tsvgr_opacity', 17:51:00 INFO - 'tart', 17:51:00 INFO - 'tscrollx', 17:51:00 INFO - 'cart', 17:51:00 INFO - 'tsvg_static']}, 17:51:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:51:00 INFO - 'tsvgr_opacity', 17:51:00 INFO - 'tart', 17:51:00 INFO - 'tscrollx', 17:51:00 INFO - 'cart', 17:51:00 INFO - 'tsvg_static']}, 17:51:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:51:00 INFO - 'talos_options': ['--disable-e10s'], 17:51:00 INFO - 'tests': ['tp5o']}, 17:51:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:51:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:51:00 INFO - 'talos_options': ['--disable-e10s', 17:51:00 INFO - '--xperf_path', 17:51:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:51:00 INFO - 'tests': ['tp5n']}, 17:51:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:51:00 INFO - 'talos_options': ['--xperf_path', 17:51:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:51:00 INFO - 'tests': ['tp5n']}}, 17:51:00 INFO - 'talos.zip': {'path': '', 17:51:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:51:00 INFO - Running post-action listener: _resource_record_post_action 17:51:00 INFO - [mozharness: 2017-03-02 01:51:00.970781Z] Finished populate-webroot step (success) 17:51:00 INFO - [mozharness: 2017-03-02 01:51:00.970874Z] Running create-virtualenv step. 17:51:00 INFO - Running pre-action listener: _resource_record_pre_action 17:51:00 INFO - Running main action method: create_virtualenv 17:51:00 INFO - Creating virtualenv /builds/slave/test/build/venv 17:51:00 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 17:51:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:51:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:51:01 INFO - Using real prefix '/usr' 17:51:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:51:01 INFO - Installing distribute.............................................................................................................................................................................................done. 17:51:03 INFO - Installing pip.................done. 17:51:03 INFO - Return code: 0 17:51:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:51:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:51:03 INFO - Reading from file tmpfile_stdout 17:51:03 INFO - Output received: 17:51:03 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) 17:51:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2404a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a7290>, '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 0x25a7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a8040>, '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': 'dac658600622fd96716c9acf000001b3-1488415547.754645-832626236', '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 17:51:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:51:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:51:03 INFO - Using env: {'DISPLAY': ':0', 17:51:03 INFO - 'HOME': '/home/cltbld', 17:51:03 INFO - 'LANG': 'en_US.UTF-8', 17:51:03 INFO - 'LANGUAGE': 'en_US:en', 17:51:03 INFO - 'LOGNAME': 'cltbld', 17:51:03 INFO - 'MAIL': '/var/mail/cltbld', 17:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:03 INFO - 'MOZ_NO_REMOTE': '1', 17:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:03 INFO - 'NO_EM_RESTART': '1', 17:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:03 INFO - 'PWD': '/builds/slave/test', 17:51:03 INFO - 'SHELL': '/bin/bash', 17:51:03 INFO - 'SHLVL': '1', 17:51:03 INFO - 'TERM': 'linux', 17:51:03 INFO - 'TMOUT': '86400', 17:51:03 INFO - 'USER': 'cltbld', 17:51:03 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1488415547.754645-832626236', 17:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:03 INFO - '_': '/tools/buildbot/bin/python'} 17:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:03 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 17:51:03 INFO - Cleaning up... 17:51:03 INFO - Return code: 0 17:51:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x230c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2404a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a7290>, '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 0x25a7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a8040>, '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': 'dac658600622fd96716c9acf000001b3-1488415547.754645-832626236', '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 17:51:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:51:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:51:03 INFO - Using env: {'DISPLAY': ':0', 17:51:03 INFO - 'HOME': '/home/cltbld', 17:51:03 INFO - 'LANG': 'en_US.UTF-8', 17:51:03 INFO - 'LANGUAGE': 'en_US:en', 17:51:03 INFO - 'LOGNAME': 'cltbld', 17:51:03 INFO - 'MAIL': '/var/mail/cltbld', 17:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:03 INFO - 'MOZ_NO_REMOTE': '1', 17:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:03 INFO - 'NO_EM_RESTART': '1', 17:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:03 INFO - 'PWD': '/builds/slave/test', 17:51:03 INFO - 'SHELL': '/bin/bash', 17:51:03 INFO - 'SHLVL': '1', 17:51:03 INFO - 'TERM': 'linux', 17:51:03 INFO - 'TMOUT': '86400', 17:51:03 INFO - 'USER': 'cltbld', 17:51:03 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1488415547.754645-832626236', 17:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:03 INFO - '_': '/tools/buildbot/bin/python'} 17:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:04 INFO - Downloading/unpacking psutil>=3.1.1 17:51:04 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 17:51:04 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 17:51:04 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 17:51:04 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 17:51:04 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 17:51:04 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 17:51:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:51:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:51:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:51:06 INFO - Installing collected packages: psutil 17:51:06 INFO - Running setup.py install for psutil 17:51:06 INFO - building 'psutil._psutil_linux' extension 17:51:06 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 17:51:06 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 17:51:06 INFO - building 'psutil._psutil_posix' extension 17:51:06 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 17:51:06 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 17:51:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:51:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:51:06 INFO - Successfully installed psutil 17:51:06 INFO - Cleaning up... 17:51:06 INFO - Return code: 0 17:51:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:51:06 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')]} 17:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:06 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')]} 17:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:06 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 0x230c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2404a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a7290>, '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 0x25a7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a8040>, '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': 'dac658600622fd96716c9acf000001b3-1488415547.754645-832626236', '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 17:51:06 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 17:51:06 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 17:51:06 INFO - Using env: {'DISPLAY': ':0', 17:51:06 INFO - 'HOME': '/home/cltbld', 17:51:06 INFO - 'LANG': 'en_US.UTF-8', 17:51:06 INFO - 'LANGUAGE': 'en_US:en', 17:51:06 INFO - 'LOGNAME': 'cltbld', 17:51:06 INFO - 'MAIL': '/var/mail/cltbld', 17:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:06 INFO - 'MOZ_NO_REMOTE': '1', 17:51:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:06 INFO - 'NO_EM_RESTART': '1', 17:51:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:06 INFO - 'PWD': '/builds/slave/test', 17:51:06 INFO - 'SHELL': '/bin/bash', 17:51:06 INFO - 'SHLVL': '1', 17:51:06 INFO - 'TERM': 'linux', 17:51:06 INFO - 'TMOUT': '86400', 17:51:06 INFO - 'USER': 'cltbld', 17:51:06 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1488415547.754645-832626236', 17:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:06 INFO - '_': '/tools/buildbot/bin/python'} 17:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:51:07 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 17:51:07 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 17:51:07 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 17:51:07 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 17:51:07 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 17:51:07 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 17:51:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:51:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:51:09 INFO - Installing collected packages: mozsystemmonitor 17:51:09 INFO - Running setup.py install for mozsystemmonitor 17:51:09 INFO - Successfully installed mozsystemmonitor 17:51:09 INFO - Cleaning up... 17:51:09 INFO - Return code: 0 17:51:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:51:09 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')]} 17:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:09 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')]} 17:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:09 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 0x230c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2404a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a7290>, '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 0x25a7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a8040>, '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': 'dac658600622fd96716c9acf000001b3-1488415547.754645-832626236', '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 17:51:09 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 17:51:09 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 17:51:09 INFO - Using env: {'DISPLAY': ':0', 17:51:09 INFO - 'HOME': '/home/cltbld', 17:51:09 INFO - 'LANG': 'en_US.UTF-8', 17:51:09 INFO - 'LANGUAGE': 'en_US:en', 17:51:09 INFO - 'LOGNAME': 'cltbld', 17:51:09 INFO - 'MAIL': '/var/mail/cltbld', 17:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:09 INFO - 'MOZ_NO_REMOTE': '1', 17:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:09 INFO - 'NO_EM_RESTART': '1', 17:51:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:09 INFO - 'PWD': '/builds/slave/test', 17:51:09 INFO - 'SHELL': '/bin/bash', 17:51:09 INFO - 'SHLVL': '1', 17:51:09 INFO - 'TERM': 'linux', 17:51:09 INFO - 'TMOUT': '86400', 17:51:09 INFO - 'USER': 'cltbld', 17:51:09 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1488415547.754645-832626236', 17:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:09 INFO - '_': '/tools/buildbot/bin/python'} 17:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:09 INFO - Downloading/unpacking jsonschema==2.5.1 17:51:09 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 17:51:09 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 17:51:09 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 17:51:09 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 17:51:09 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 17:51:09 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 17:51:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:51:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:51:11 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 17:51:11 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 17:51:11 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 17:51:11 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 17:51:11 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 17:51:11 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 17:51:11 INFO - Downloading functools32-3.2.3-2.tar.gz 17:51:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:51:12 INFO - warning: no files found matching '*.txt' 17:51:12 INFO - no previously-included directories found matching 'build' 17:51:12 INFO - no previously-included directories found matching 'dist' 17:51:12 INFO - no previously-included directories found matching '.git*' 17:51:12 INFO - Installing collected packages: jsonschema, functools32 17:51:12 INFO - Running setup.py install for functools32 17:51:12 INFO - warning: no files found matching '*.txt' 17:51:12 INFO - no previously-included directories found matching 'build' 17:51:12 INFO - no previously-included directories found matching 'dist' 17:51:12 INFO - no previously-included directories found matching '.git*' 17:51:12 INFO - Successfully installed jsonschema functools32 17:51:12 INFO - Cleaning up... 17:51:12 INFO - Return code: 0 17:51:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:51: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')]} 17:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51: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')]} 17:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:12 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 0x230c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2404a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a7290>, '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 0x25a7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a8040>, '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': 'dac658600622fd96716c9acf000001b3-1488415547.754645-832626236', '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 17:51:12 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 17:51:12 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 17:51:12 INFO - Using env: {'DISPLAY': ':0', 17:51:12 INFO - 'HOME': '/home/cltbld', 17:51:12 INFO - 'LANG': 'en_US.UTF-8', 17:51:12 INFO - 'LANGUAGE': 'en_US:en', 17:51:12 INFO - 'LOGNAME': 'cltbld', 17:51:12 INFO - 'MAIL': '/var/mail/cltbld', 17:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:12 INFO - 'MOZ_NO_REMOTE': '1', 17:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:12 INFO - 'NO_EM_RESTART': '1', 17:51:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:12 INFO - 'PWD': '/builds/slave/test', 17:51:12 INFO - 'SHELL': '/bin/bash', 17:51:12 INFO - 'SHLVL': '1', 17:51:12 INFO - 'TERM': 'linux', 17:51:12 INFO - 'TMOUT': '86400', 17:51:12 INFO - 'USER': 'cltbld', 17:51:12 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1488415547.754645-832626236', 17:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:12 INFO - '_': '/tools/buildbot/bin/python'} 17:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:51:12 INFO - Cleaning up... 17:51:12 INFO - Return code: 0 17:51:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:51: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')]} 17:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51: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')]} 17:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:12 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 0x230c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2404a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a7290>, '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 0x25a7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a8040>, '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': 'dac658600622fd96716c9acf000001b3-1488415547.754645-832626236', '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 17:51:12 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 17:51:12 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 17:51:12 INFO - Using env: {'DISPLAY': ':0', 17:51:12 INFO - 'HOME': '/home/cltbld', 17:51:12 INFO - 'LANG': 'en_US.UTF-8', 17:51:12 INFO - 'LANGUAGE': 'en_US:en', 17:51:12 INFO - 'LOGNAME': 'cltbld', 17:51:12 INFO - 'MAIL': '/var/mail/cltbld', 17:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:12 INFO - 'MOZ_NO_REMOTE': '1', 17:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:12 INFO - 'NO_EM_RESTART': '1', 17:51:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:12 INFO - 'PWD': '/builds/slave/test', 17:51:12 INFO - 'SHELL': '/bin/bash', 17:51:12 INFO - 'SHLVL': '1', 17:51:12 INFO - 'TERM': 'linux', 17:51:12 INFO - 'TMOUT': '86400', 17:51:12 INFO - 'USER': 'cltbld', 17:51:12 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1488415547.754645-832626236', 17:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:12 INFO - '_': '/tools/buildbot/bin/python'} 17:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:12 INFO - Downloading/unpacking blobuploader==1.2.4 17:51:12 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 17:51:12 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 17:51:12 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 17:51:12 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 17:51:12 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 17:51:12 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 17:51:14 INFO - Downloading blobuploader-1.2.4.tar.gz 17:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:51:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:51:14 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 17:51:14 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 17:51:14 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 17:51:14 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 17:51:14 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 17:51:14 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 17:51:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:51:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:51:15 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 17:51:15 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 17:51:15 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 17:51:15 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 17:51:15 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 17:51:15 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 17:51:15 INFO - Downloading docopt-0.6.1.tar.gz 17:51:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:51:15 INFO - Installing collected packages: blobuploader, requests, docopt 17:51:15 INFO - Running setup.py install for blobuploader 17:51:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:51:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:51:15 INFO - Running setup.py install for requests 17:51:15 INFO - Running setup.py install for docopt 17:51:16 INFO - Successfully installed blobuploader requests docopt 17:51:16 INFO - Cleaning up... 17:51:16 INFO - Return code: 0 17:51:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:51: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')]} 17:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51: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')]} 17:51:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:16 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 0x230c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2404a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a7290>, '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 0x25a7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a8040>, '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': 'dac658600622fd96716c9acf000001b3-1488415547.754645-832626236', '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 17:51:16 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 17:51:16 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 17:51:16 INFO - Using env: {'DISPLAY': ':0', 17:51:16 INFO - 'HOME': '/home/cltbld', 17:51:16 INFO - 'LANG': 'en_US.UTF-8', 17:51:16 INFO - 'LANGUAGE': 'en_US:en', 17:51:16 INFO - 'LOGNAME': 'cltbld', 17:51:16 INFO - 'MAIL': '/var/mail/cltbld', 17:51:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:16 INFO - 'MOZ_NO_REMOTE': '1', 17:51:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:16 INFO - 'NO_EM_RESTART': '1', 17:51:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:16 INFO - 'PWD': '/builds/slave/test', 17:51:16 INFO - 'SHELL': '/bin/bash', 17:51:16 INFO - 'SHLVL': '1', 17:51:16 INFO - 'TERM': 'linux', 17:51:16 INFO - 'TMOUT': '86400', 17:51:16 INFO - 'USER': 'cltbld', 17:51:16 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1488415547.754645-832626236', 17:51:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:16 INFO - '_': '/tools/buildbot/bin/python'} 17:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:51:16 INFO - Running setup.py (path:/tmp/pip-SXWXZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:51:16 INFO - Running setup.py (path:/tmp/pip-zYwQQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:51:16 INFO - Running setup.py (path:/tmp/pip-nqrmUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:51:16 INFO - Running setup.py (path:/tmp/pip-PmVg3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:51:16 INFO - Running setup.py (path:/tmp/pip-WmIEOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:51:16 INFO - Running setup.py (path:/tmp/pip-5O82j3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:51:16 INFO - Running setup.py (path:/tmp/pip-SmoAjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:51:16 INFO - Running setup.py (path:/tmp/pip-7j5Gva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:51:16 INFO - Running setup.py (path:/tmp/pip-Zjcw4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:51:16 INFO - Running setup.py (path:/tmp/pip-m2NLIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:51:17 INFO - Running setup.py (path:/tmp/pip-qhIt68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:51:17 INFO - Running setup.py (path:/tmp/pip-3AZvIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:51:17 INFO - Running setup.py (path:/tmp/pip-VBfrvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:51:17 INFO - Running setup.py (path:/tmp/pip-gZYnF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:17 INFO - Running setup.py (path:/tmp/pip-2t7JNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:51:17 INFO - Running setup.py (path:/tmp/pip-_GT3Y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:51:17 INFO - Running setup.py (path:/tmp/pip-wFARjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:51:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:51:17 INFO - Running setup.py install for manifestparser 17:51:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:51:17 INFO - Running setup.py install for mozcrash 17:51:17 INFO - Running setup.py install for mozdebug 17:51:17 INFO - Running setup.py install for mozdevice 17:51:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:51:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:51:17 INFO - Running setup.py install for mozfile 17:51:18 INFO - Running setup.py install for mozhttpd 17:51:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:51:18 INFO - Running setup.py install for mozinfo 17:51:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:51:18 INFO - Running setup.py install for mozInstall 17:51:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:51:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:51:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:51:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:51:18 INFO - Running setup.py install for mozleak 17:51:18 INFO - Running setup.py install for mozlog 17:51:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:51:18 INFO - Running setup.py install for moznetwork 17:51:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:51:18 INFO - Running setup.py install for mozprocess 17:51:18 INFO - Running setup.py install for mozprofile 17:51:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:51:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:51:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:51:18 INFO - Running setup.py install for mozrunner 17:51:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:51:19 INFO - Running setup.py install for mozscreenshot 17:51:19 INFO - Running setup.py install for moztest 17:51:19 INFO - Running setup.py install for mozversion 17:51:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:51:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:51:19 INFO - Cleaning up... 17:51:19 INFO - Return code: 0 17:51:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:51: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')]} 17:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51: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')]} 17:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:19 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 0x230c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2404a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a7290>, '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 0x25a7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a8040>, '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': 'dac658600622fd96716c9acf000001b3-1488415547.754645-832626236', '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 17:51:19 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 17:51:19 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 17:51:19 INFO - Using env: {'DISPLAY': ':0', 17:51:19 INFO - 'HOME': '/home/cltbld', 17:51:19 INFO - 'LANG': 'en_US.UTF-8', 17:51:19 INFO - 'LANGUAGE': 'en_US:en', 17:51:19 INFO - 'LOGNAME': 'cltbld', 17:51:19 INFO - 'MAIL': '/var/mail/cltbld', 17:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:19 INFO - 'MOZ_NO_REMOTE': '1', 17:51:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:19 INFO - 'NO_EM_RESTART': '1', 17:51:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:19 INFO - 'PWD': '/builds/slave/test', 17:51:19 INFO - 'SHELL': '/bin/bash', 17:51:19 INFO - 'SHLVL': '1', 17:51:19 INFO - 'TERM': 'linux', 17:51:19 INFO - 'TMOUT': '86400', 17:51:19 INFO - 'USER': 'cltbld', 17:51:19 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1488415547.754645-832626236', 17:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:19 INFO - '_': '/tools/buildbot/bin/python'} 17:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:51:19 INFO - Running setup.py (path:/tmp/pip-o7dmMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:51:19 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)) 17:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:51:19 INFO - Running setup.py (path:/tmp/pip-k8a1RS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:51:19 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)) 17:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:51:19 INFO - Running setup.py (path:/tmp/pip-I0yC_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:51:19 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)) 17:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:51:19 INFO - Running setup.py (path:/tmp/pip-tMfvoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:51:19 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)) 17:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:51:19 INFO - Running setup.py (path:/tmp/pip-B0tPJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:51:19 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)) 17:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:51:19 INFO - Running setup.py (path:/tmp/pip-sIs6rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:51:19 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)) 17:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:51:19 INFO - Running setup.py (path:/tmp/pip-PQZHbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:51:20 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)) 17:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:51:20 INFO - Running setup.py (path:/tmp/pip-2wSj9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:51:20 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)) 17:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:51:20 INFO - Running setup.py (path:/tmp/pip-Vwj7OB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:51:20 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)) 17:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:51:20 INFO - Running setup.py (path:/tmp/pip-v5Kdd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:51:20 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)) 17:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:51:20 INFO - Running setup.py (path:/tmp/pip-57JwMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:51:20 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)) 17:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:51:20 INFO - Running setup.py (path:/tmp/pip-9W9UXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:51:20 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)) 17:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:51:20 INFO - Running setup.py (path:/tmp/pip-j3a65X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:51:20 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)) 17:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:51:20 INFO - Running setup.py (path:/tmp/pip-IdBHD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:51:20 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)) 17:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:20 INFO - Running setup.py (path:/tmp/pip-FarWBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:20 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)) 17:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:51:20 INFO - Running setup.py (path:/tmp/pip-m0t_J7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:51:20 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)) 17:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:51:20 INFO - Running setup.py (path:/tmp/pip-Pp6W_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:51:20 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)) 17:51:20 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)) 17:51:20 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)) 17:51:20 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)) 17:51:20 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)) 17:51:20 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)) 17:51:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:51:20 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 17:51:20 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 17:51:20 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 17:51:20 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 17:51:20 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 17:51:20 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 17:51:22 INFO - Downloading blessings-1.6.tar.gz 17:51:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:51:22 INFO - Installing collected packages: blessings 17:51:22 INFO - Running setup.py install for blessings 17:51:22 INFO - Successfully installed blessings 17:51:22 INFO - Cleaning up... 17:51:23 INFO - Return code: 0 17:51:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:51:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:51:23 INFO - Reading from file tmpfile_stdout 17:51:23 INFO - Current package versions: 17:51:23 INFO - argparse == 1.2.1 17:51:23 INFO - blessings == 1.6 17:51:23 INFO - blobuploader == 1.2.4 17:51:23 INFO - docopt == 0.6.1 17:51:23 INFO - functools32 == 3.2.3-2 17:51:23 INFO - jsonschema == 2.5.1 17:51:23 INFO - manifestparser == 1.1 17:51:23 INFO - mozInstall == 1.12 17:51:23 INFO - mozcrash == 1.0 17:51:23 INFO - mozdebug == 0.1 17:51:23 INFO - mozdevice == 0.49 17:51:23 INFO - mozfile == 1.2 17:51:23 INFO - mozhttpd == 0.7 17:51:23 INFO - mozinfo == 0.9 17:51:23 INFO - mozleak == 0.1 17:51:23 INFO - mozlog == 3.4 17:51:23 INFO - moznetwork == 0.27 17:51:23 INFO - mozprocess == 0.25 17:51:23 INFO - mozprofile == 0.28 17:51:23 INFO - mozrunner == 6.13 17:51:23 INFO - mozscreenshot == 0.1 17:51:23 INFO - mozsystemmonitor == 0.3 17:51:23 INFO - moztest == 0.8 17:51:23 INFO - mozversion == 1.4 17:51:23 INFO - psutil == 3.1.1 17:51:23 INFO - requests == 1.2.3 17:51:23 INFO - wsgiref == 0.1.2 17:51:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:51:23 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')]} 17:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:23 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')]} 17:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:23 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 0x230c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2404a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a7290>, '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 0x25a7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a8040>, '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': 'dac658600622fd96716c9acf000001b3-1488415547.754645-832626236', '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 17:51:23 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 17:51:23 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 17:51:23 INFO - Using env: {'DISPLAY': ':0', 17:51:23 INFO - 'HOME': '/home/cltbld', 17:51:23 INFO - 'LANG': 'en_US.UTF-8', 17:51:23 INFO - 'LANGUAGE': 'en_US:en', 17:51:23 INFO - 'LOGNAME': 'cltbld', 17:51:23 INFO - 'MAIL': '/var/mail/cltbld', 17:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:23 INFO - 'MOZ_NO_REMOTE': '1', 17:51:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:23 INFO - 'NO_EM_RESTART': '1', 17:51:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:23 INFO - 'PWD': '/builds/slave/test', 17:51:23 INFO - 'SHELL': '/bin/bash', 17:51:23 INFO - 'SHLVL': '1', 17:51:23 INFO - 'TERM': 'linux', 17:51:23 INFO - 'TMOUT': '86400', 17:51:23 INFO - 'USER': 'cltbld', 17:51:23 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1488415547.754645-832626236', 17:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:23 INFO - '_': '/tools/buildbot/bin/python'} 17:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:23 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)) 17:51:23 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)) 17:51:23 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)) 17:51:23 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)) 17:51:23 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)) 17:51:23 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)) 17:51:23 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)) 17:51:23 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)) 17:51:23 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)) 17:51:23 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)) 17:51:23 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)) 17:51:23 INFO - Cleaning up... 17:51:23 INFO - Return code: 0 17:51:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:51:23 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')]} 17:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:23 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')]} 17:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:23 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 0x230c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2404a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a7290>, '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 0x25a7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a8040>, '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': 'dac658600622fd96716c9acf000001b3-1488415547.754645-832626236', '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 17:51:23 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 17:51:23 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 17:51:23 INFO - Using env: {'DISPLAY': ':0', 17:51:23 INFO - 'HOME': '/home/cltbld', 17:51:23 INFO - 'LANG': 'en_US.UTF-8', 17:51:23 INFO - 'LANGUAGE': 'en_US:en', 17:51:23 INFO - 'LOGNAME': 'cltbld', 17:51:23 INFO - 'MAIL': '/var/mail/cltbld', 17:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:23 INFO - 'MOZ_NO_REMOTE': '1', 17:51:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:23 INFO - 'NO_EM_RESTART': '1', 17:51:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:23 INFO - 'PWD': '/builds/slave/test', 17:51:23 INFO - 'SHELL': '/bin/bash', 17:51:23 INFO - 'SHLVL': '1', 17:51:23 INFO - 'TERM': 'linux', 17:51:23 INFO - 'TMOUT': '86400', 17:51:23 INFO - 'USER': 'cltbld', 17:51:23 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1488415547.754645-832626236', 17:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:23 INFO - '_': '/tools/buildbot/bin/python'} 17:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:51:23 INFO - Cleaning up... 17:51:23 INFO - Return code: 0 17:51:23 INFO - Running post-action listener: _resource_record_post_action 17:51:23 INFO - Running post-action listener: _start_resource_monitoring 17:51:23 INFO - Starting resource monitoring. 17:51:23 INFO - [mozharness: 2017-03-02 01:51:23.743469Z] Finished create-virtualenv step (success) 17:51:23 INFO - [mozharness: 2017-03-02 01:51:23.743934Z] Running install step. 17:51:23 INFO - Running pre-action listener: _resource_record_pre_action 17:51:23 INFO - Running main action method: install 17:51:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:51:23 INFO - Reading from file tmpfile_stdout 17:51:23 INFO - Detecting whether we're running mozinstall >=1.0... 17:51:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:51:24 INFO - Reading from file tmpfile_stdout 17:51:24 INFO - Output received: 17:51:24 INFO - Usage: mozinstall [options] installer 17:51:24 INFO - Options: 17:51:24 INFO - -h, --help show this help message and exit 17:51:24 INFO - -d DEST, --destination=DEST 17:51:24 INFO - Directory to install application into. [default: 17:51:24 INFO - "/builds/slave/test"] 17:51:24 INFO - --app=APP Application being installed. [default: firefox] 17:51:24 INFO - mkdir: /builds/slave/test/build/application 17:51:24 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'] 17:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:51:39 INFO - Reading from file tmpfile_stdout 17:51:39 INFO - Output received: 17:51:39 INFO - /builds/slave/test/build/application/firefox/firefox 17:51:39 INFO - Running post-action listener: _resource_record_post_action 17:51:39 INFO - [mozharness: 2017-03-02 01:51:39.467829Z] Finished install step (success) 17:51:39 INFO - [mozharness: 2017-03-02 01:51:39.468100Z] Running run-tests step. 17:51:39 INFO - Running pre-action listener: _resource_record_pre_action 17:51:39 INFO - Running main action method: run_tests 17:51:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:51:39 INFO - Python 2.7.3 17:51:39 INFO - Return code: 0 17:51:39 INFO - grabbing minidump binary from tooltool 17:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:39 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 0x25a7290>, '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 0x25a7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a8040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:51:39 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 17:51:39 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 17:51:39 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 17:51:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:51:39 INFO - Return code: 0 17:51:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:51:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:51:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:51:39 INFO - ENV: RUST_BACKTRACE is now 1 17:51:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:51:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:51:39 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/YQ4KV7HrSM2kN4Y5nUZ89A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-078', '--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 17:51:39 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/YQ4KV7HrSM2kN4Y5nUZ89A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-078 --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 17:51:39 INFO - Using env: {'DISPLAY': ':0', 17:51:39 INFO - 'HOME': '/home/cltbld', 17:51:39 INFO - 'LANG': 'en_US.UTF-8', 17:51:39 INFO - 'LANGUAGE': 'en_US:en', 17:51:39 INFO - 'LOGNAME': 'cltbld', 17:51:39 INFO - 'MAIL': '/var/mail/cltbld', 17:51:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:51:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:39 INFO - 'MOZ_NO_REMOTE': '1', 17:51:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:51:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:39 INFO - 'NO_EM_RESTART': '1', 17:51:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:39 INFO - 'PWD': '/builds/slave/test', 17:51:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:51:39 INFO - 'RUST_BACKTRACE': '1', 17:51:39 INFO - 'SHELL': '/bin/bash', 17:51:39 INFO - 'SHLVL': '1', 17:51:39 INFO - 'TERM': 'linux', 17:51:39 INFO - 'TMOUT': '86400', 17:51:39 INFO - 'USER': 'cltbld', 17:51:39 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1488415547.754645-832626236', 17:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:39 INFO - '_': '/tools/buildbot/bin/python'} 17:51:39 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/YQ4KV7HrSM2kN4Y5nUZ89A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-078', '--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 17:51:39 INFO - mozversion application_buildid: 20170302011852 17:51:39 INFO - mozversion application_changeset: e91de6fb2b3dce9c932428265b0fdb630ea470d7 17:51:39 INFO - mozversion application_display_name: Nightly 17:51:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:51:39 INFO - mozversion application_name: Firefox 17:51:39 INFO - mozversion application_remotingname: firefox 17:51:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:51:39 INFO - mozversion application_vendor: Mozilla 17:51:39 INFO - mozversion application_version: 54.0a1 17:51:39 INFO - mozversion platform_buildid: 20170302011852 17:51:39 INFO - mozversion platform_changeset: e91de6fb2b3dce9c932428265b0fdb630ea470d7 17:51:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:51:39 INFO - mozversion platform_version: 54.0a1 17:51:39 INFO - using testdate: 1488419499 17:51:39 INFO - actual date: 1488419499 17:51:39 INFO - starting webserver on 'localhost:34522' 17:51:39 INFO - SUITE-START | Running 2 tests 17:51:39 INFO - TEST-START | dromaeo_css 17:51:39 INFO - operating with platform_type : linux_ 17:51:39 INFO - Initialising browser for dromaeo_css test... 17:51:39 INFO - TEST-INFO | started process 5346 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphGzXNF/profile http://localhost:34522/getInfo.html) 17:51:43 INFO - PROCESS | 5346 | __metrics Screen width/height:1600/1200 17:51:43 INFO - PROCESS | 5346 | colorDepth:24 17:51:43 INFO - PROCESS | 5346 | Browser inner width/height: 1024/697 17:51:43 INFO - PROCESS | 5346 | __metrics 17:51:44 INFO - PROCESS | 5346 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:51:44 INFO - PROCESS | 5346 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:51:45 INFO - TEST-INFO | 5346: exit 0 17:51:45 INFO - Browser initialized. 17:51:45 INFO - Running cycle 1/1 for dromaeo_css test... 17:51:45 INFO - TEST-INFO | started process 5438 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphGzXNF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:51:57 INFO - PROCESS | 5438 | RSS: Main: 146903040 17:51:57 INFO - PROCESS | 5438 | 17:55:04 INFO - PROCESS | 5438 | Cycle 1(1): loaded http://localhost:34522/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34522/tests/dromaeo/cssquery-ext.html) 17:55:06 INFO - PROCESS | 5438 | RSS: Main: 303759360 17:55:06 INFO - PROCESS | 5438 | 17:56:48 INFO - PROCESS | 5438 | ************************* 17:56:48 INFO - PROCESS | 5438 | A coding exception was thrown and uncaught in a Task. 17:56:48 INFO - PROCESS | 5438 | 17:56:48 ERROR - PROCESS | 5438 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:56:48 INFO - PROCESS | 5438 | Full stack: 17:56:48 INFO - PROCESS | 5438 | ************************* 17:58:09 INFO - PROCESS | 5438 | Cycle 1(1): loaded http://localhost:34522/tests/dromaeo/cssquery-ext.html (next: http://localhost:34522/tests/dromaeo/cssquery-jquery.html) 17:58:09 INFO - PROCESS | 5438 | RSS: Main: 229797888 17:58:09 INFO - PROCESS | 5438 | 18:01:11 INFO - PROCESS | 5438 | Cycle 1(1): loaded http://localhost:34522/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34522/tests/dromaeo/cssquery-mootools.html) 18:01:12 INFO - PROCESS | 5438 | RSS: Main: 227590144 18:01:12 INFO - PROCESS | 5438 | 18:04:14 INFO - PROCESS | 5438 | Cycle 1(1): loaded http://localhost:34522/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34522/tests/dromaeo/cssquery-prototype.html) 18:04:15 INFO - PROCESS | 5438 | RSS: Main: 201592832 18:04:15 INFO - PROCESS | 5438 | 18:07:19 INFO - PROCESS | 5438 | Cycle 1(1): loaded http://localhost:34522/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34522/tests/dromaeo/cssquery-yui.html) 18:07:19 INFO - PROCESS | 5438 | RSS: Main: 182190080 18:07:19 INFO - PROCESS | 5438 | 18:10:22 INFO - PROCESS | 5438 | Cycle 1(1): loaded http://localhost:34522/tests/dromaeo/cssquery-yui.html (next: http://localhost:34522/tests/dromaeo/cssquery-dojo.html) 18:10:22 INFO - PROCESS | 5438 | RSS: Main: 265596928 18:10:22 INFO - PROCESS | 5438 | 18:10:22 INFO - PROCESS | 5438 | __start_tp_report 18:10:22 INFO - PROCESS | 5438 | _x_x_mozilla_page_load 18:10:22 INFO - PROCESS | 5438 | _x_x_mozilla_page_load_details 18:10:22 INFO - PROCESS | 5438 | |i|pagename|runs| 18:10:22 INFO - PROCESS | 5438 | |0;dojo.html;2626.8555229462377;2637.037481319318;2652.3103992961846;2660.866956652167;2685.1004913354027;4775.952240477594;4888.046830867982;4928.753562321887;4952.628552858537;5022.07091688038;4908.852734417964;4926.655134140611;4947.332110165135;4966.826161084363;4970.055689419008;4509.030558429937;4533.297338912474;4545.909081818361;4568.885777855564;4695.8356457524;4563.201439748047;4615.05391394765;4621.491635920063;4644.7213167210075;4705.811767529295;4439.600435960779;4468;4584.7478388688605;4610.423697037871;4640.2343613303765;4506.842260520899;4519.661025423106;4525.162844873676;4527.4114365132655;4531.614812740921;4489.753063581535;4490.236659767847;4496.64026877849;4496.977515112403;4510.932336014962;4822.758862056883;4897.632677549198;4952.727599981999;4977.278294647256;4978.925316120261;5371.597130215249;5375.032494151052;5376.4085950545405;5378.596605254622;5383.401923852059;5183.61122915779;5353.250544923714;5366.195070739382;5378.354597448292;5426.375966763833;4873.122837889143;4903.705777653352;4935.777889994959;4948.678335908155;4949.232868905326;5405.243265942692;5419.485148910847;5455.34535855692;5467.972660136754;5538.695371754511;5088.643794934393;5126.666766660155;5144.845654630367;5268.683878967274;5312.893742125136;5257.553107985787;5262;5264.868378290574;5267.104592219332;5280.867978300574;5241.056609810271;5241.50205730455;5245.632805703564;5245.7114858683135;5246.370435547682;5251.6061295403;5252.29094072303;5253.500917412916;5254.185601231815;5254.605904557174;4472.709273897186;4475.26158183896;4477.664175186874;4540.182767101887;4583.633309335245;3962.5443074046852;3973.463582416337;3978.562358140602;3982.4623675803973;4020.4773379460485;4442.53353397895;4466.888327791831;4562.087582483517;4585.243434833282;4628.69913455631;5437.13005919051;5444.754986025639;5452.182172674131;5457.590680698963;5465.562754979592;4604.585587297092;4615.630749540096;4616.76916154191;4622.86131416058;4661.230896901973;4809.831655892027;4828.396450443694;4829.6860704054125;4836.419629644395;4879.072976134594;4854;4890.437599676083;4892.65751397413;4958.0083983202785;4969.428515720739;5302.28419163408;5306.310179676618;5321.600879933943;5331.067063263836;5345.679259244458;5010.8496745096245;5024.874378140576;5026.44709082008;5042.495750424928;5058.08954388199;5245.947540524546;5289.57683385336;5296.443873393392;5299.346301020463;5341.519263266169;5175.404828444777;5225.529702326809;5227.2943152675425;5312.468753124811;5383.973080134731;5153.3558305211845;5155.948440515697;5160.509751573594;5162.6386152968935;5164.302819119521;5138.794448222029;5139;5150.819721309736;5151.8196863109615;5166.767495462638;5095.77069031887;5126.333576635163;5135.87160320995;5138.614603904647;5171.172612382001;5059.696418214919;5231.89536209266;5235.842924712265;5239.816606418757;5273.815416460559;4927.704337739604;4998.6750861193905;5006.899862002667;5007.3240112584335;5014.297998280171 18:10:22 INFO - PROCESS | 5438 | |1;ext.html;616.238944903045;680.075097866901;702.631118662702;756.73136036707;767.8118860879085;25696.74303256967;27877.581836272446;27891.999999999975;35495.2900941981;36196.45705314422;36147.638523614754;36235.63764362356;36263.456048159234;36336.27327453449;36395;7346.37555807757;7463.776086717407;7482.401407887356;7483.438742094338;7484;6702.329767023283;6871.072405225305;7320.304571065767;7407.222241664628;8948.955255223747;8933.955330223373;9195.310351723614;9221.400608960395;9240.122188392092;9246.306527010467;9110.134537218953;9125.133112354315;9161.358704890661;9167.220786233145;9171.44971301724;9145.536714125708;9174.495402752846;9199.26405887534;9199.724008279762;9208.217301529377;34470.310593788236;34630.134246643785;34638.82680586606;34658;34689.653103468896;3109.160526657812;3116.844157792101;3153.716165545112;3165.9683403165905;3171.4608516552244;23878.403039923967;23987.52024959491;24151.516969660683;24291.392715182086;24302.635460468107;2939.338648804002;2956.098389991052;2970.628671416073;2984.9552256716165;2989.8355590442516;143660;169781;170990;171281;171409;37418.812905935294;37492.62507374891;37595.81202093972;37624;37659.81170094187;38602.61397386046;38675.806620966716;38698.80650596729;38706.41940370897;38789.22421551553;11097.44512774358;11266.887331126583;11269.436528173559;11280.210385273116;11285.43572821372;9314.48770317639;9338;9356.34505584616;9358.157765800974;9368.250539956924;9590.232781377474;9787.62973183755;9803.705888823346;10658.548533837105;11257.71855703614;4810.064617192048;5021.573166280907;5058.165402708585;5139.12634852076;5164.638475306768;983.4443539400216;994.4629899854142;1021.7394564386183;1023.4473384372355;1029.9227557933036;22576.20983265578;22891.427714307276;22901.885490572775;22944;23073.653895191586;1085.847981282621;1093.5133865429807;1097.2812807611028;1108.196557495809;1111.555377848867;11511.48198331077;12276.631701048982;12321.69195770095;12388.442520086617;12408.131430799758;236489;237195;237546;237642;238190;35781.46327805085;36585.45121823175;36592.81703591465;42351.788241059214;43693;1143.9885601143883;1164.039667274485;1175.8481977980275;1177.6682169304825;1178.251810100575;25021.12426065152;25631.23106306814;26066.478670426106;26566.7343326572;26584;36700.63299366972;36788;36810.079748005446;36851.44722829106;36861.63138368582;218342;218788;218826;219493;219750;22266.443338916655;22727.886360568093;22730.43173920665;22732.545349093256;22778.20276290322;32117.357652846345;32826.17934551655;32841.50737738983;35891;35995.28009439744;27361.31596710098;27544.449111018068;27590.310242244104;27857.16428507148;28522.57216141801;28035.43929121447;28087.017263746784;28437.715622843505;28566;28614.117307222805;28769.424611507235;28820.855895720386;29022.709772902002;29058;29344;23059.88470057639;24604.630930536416;25362.619560706236;25707.228783136536;26172.345691357106;20732.378028659165;20750.37748867476;20876.269330573356;20907.477313067295;20933.790662093794 18:10:22 INFO - PROCESS | 5438 | |2;jquery.html;378.57410413285055;390.6620773031327;396.2154933232199;417.8558397352913;435.0689524417747;11321.603743868956;12314.13801033928;12434.689132771673;16216.00003999261;16678.749818752698;15635.921820390911;15672.686546269097;15881;17565.648687026252;17855.821441785578;5320.920186197201;5536.557075433956;5627.6904770237825;5684.772609095631;5691.117876729114;3694.926101477969;4166;5555.694436805974;5641.153826925953;5641.576881733887;6518.837029074263;6672.699728512229;6678.365555272241;6680.498962577802;6687.398134167924;6413.583117097421;6621.536492445531;6660.733570657168;6664.666766661671;6674.232463266713;6444.194475690539;6458.451031662315;6468.805935821886;6479.773207937699;6480.578762380477;20371.388858334274;20838.791612083838;20871.5825683487;20947;20951;2187.3000639795273;2222.2555443926303;2237.5524895021063;2283.8287128465267;2325.953480930372;12970.423114467323;13027.413766380536;13044.934775326157;13249.602511924657;13572.93213533926;1810.592616661254;1838.6138910828743;1841.29110292537;1854.1285595769966;1865.7014877619515;76989.02060625317;78432.60783696102;78524;80572.59713701453;80655.19344806536;14705;15141.924290378698;15193.848061519464;15277.159756213292;15491.5352539424;17310.134493275287;26960.460790784466;27035.161308062765;27062.188134356;27074.864625676746;6860.759873404407;6885.793426197222;6921.446284297244;7077.150741911004;7154.213036565973;5770.855728606818;5794.681292528951;5935.2877654681715;5965.313988891333;5989.1914591529585;5969.447943534712;6003.729832157564;6049.971504844187;6063.575549711566;6140.815775526741;3190.952135717966;3197.6322722887166;3245.3184831185245;3329.900102996914;3351.6983471487683;791.8257983243677;824.3693574415577;829.1708291708292;835.0939230934383;857.3484152044491;15853.762193567105;16109.758353624706;16248.918755406148;16695.833041669426;17142.45717885396;871.3551971541141;875.8117004843989;877.7981064355234;878.7627340618125;885.6988623867916;5745.597808153389;5773.769049237983;5809.651420914759;5934.851628709317;5996.4603185713495;485321;489239;497981;501223;503805;69280.65359673169;82091.58954205191;88720.45876100475;91066.08933910709;93672;974.512743628186;999.1706883286854;1020.4897551224387;1021.9233557483218;1023.8771347438355;13641.181529108286;14527.564173074825;14777.335019924345;15090.396384144511;15397.384104635688;36665.81667091647;41882.37176442417;42180.57819421766;42838.14323713571;43868.56131438645;49945.75027124841;51641.741791290806;51859.48140518546;51866.48133518617;52646.473535265686;8437.11410301934;8801.779955501164;9457.527123643928;9497.762555936157;10306.12397946153;11655.941720291345;11714.297142171155;11749.177557570887;11937.641870743892;12458.688532786753;9751.463669498246;10289.639862605072;10388.896111038794;10451.529681164213;10941;10030.448325342177;10191.082802547806;10288.176945844465;10341.017603327671;10389.688309350731;10769.622045908929;10825.837612435662;10835.295705779099;10995.065419439117;11104.888951110386;9682.661106861226;10093.798124037625;10339.741506462098;10700.143988481059;10706.785864282827;9350.625974960925;9535.094166054214;10127.291089623655;10151.289409741246;10287.279890407899 18:10:22 INFO - PROCESS | 5438 | |3;mootools.html;1407.2471227893077;1409.4150927365145;1429.3567894447501;1439.0214654035256;1442.7475191841424;9144.725658230256;9651.855222171673;9743.220542356612;9752.07355301247;9765.951170244147;9363.48500832454;9407.38851974623;9640.85538716918;9731.464769437678;9999.050090241433;2004.408699433667;2047.4164863014043;2048.3035767838933;2048.8873111978837;2050.6923961405832;1959.9412017639422;1997.1611922992379;2004.6992951057312;2005.979940200594;2007.8895660738654;1628.0801347238832;1686.8397502237328;1686.907220102894;1855.9257629694796;1913.1390874106637;2025.8480613953939;2026.0781344488223;2027.9391618251475;2037.5109973606377;2046.9692954605619;1805.9819401805946;1823.1157888424104;1843.8524918006526;1844.8985305808176;2065.318444913175;7977.3618110551015;8202.753917382488;9079.591418386188;9632.084951929555;9727.124558789672;4479.619232365253;4592.081583683277;4594.816207351702;4600.516945720685;4603.9769801151115;2636.222314417232;2678.7589116979566;2710.9593356099676;2712.145674112648;2723.046933573253;1001.7295330260862;1027.111548510533;1031.5718976624692;1045.5451878432907;1062.7290041039485;13525.188488690612;13768.24274664903;13872.167669939836;13885.166889986633;13906.721865562633;3877.728559000899;3972.6226008529143;4002.7398219115667;4010.6791456683395;4013.518377794625;10848.511816968097;10849;10860.728481788019;10865.45672716361;10874.72813179661;4807.711537307703;4813.975930120397;4814.518548145157;4816.759162041884;4817.181079216542;4179.080602267496;4250.72370295936;4284.3145096784365;4286.807093680792;4459.5986361227;3187.9203019924225;3287.5836260348624;3315.370079684852;3318.3529211803466;3336.8665253390077;823.7643534697953;844.1727107434625;844.7381311793364;848.9745307640657;851.4040171879709;746.2649290448903;768.3699366519512;782.8356045230452;787.8542469643135;797.6490344248512;5215.478452154754;5218.6868787872845;5360.2227676987395;5416.620836541404;5519.448055194529;806.5483329335591;812.4921923797626;819.6393586821779;843.6541018182515;859.4757198109148;2950.704929507075;3001.9099427017222;3029.7727670424365;3042.4827779277575;3046.588710524051;10815.891841081646;11173.10615150786;11578.131640127023;11662.241954272946;12110.212836165798;11814.46834892432;12185.817212741817;12279.201851879778;12344.567940122053;12378.319192444502;8345.499270043816;8621.913780862236;8636.395452318277;8637.568121593895;8639.308855291687;5560.944390556043;5660.688662123623;5809.186713859978;5877.206577112035;5898.852528686645;10723.892761072602;10791;10840.349579024969;10882.945585272022;10973.396463194282;11089.22375433712;11326.207165498665;11416.257943233662;11436.37099959477;11441.942790285995;7811.453198276066;7875.763727088197;7999.280064794197;8009;8030.357571394157;8889.288856891562;8911.598978045873;9002.954985225031;9007.189352958265;9014.233790127913;7347.33873951347;7451.143118541437;7477.327040566375;7496.62516874165;7601.429892758176;7434.665440055102;7533.246675332643;7537.2085930976455;7566.167721550515;7750.534967901944;6599.439047681001;6718.529702920944;6720;6722.798316050526;6732.663366831737;4845.854624361275;4972.65191436596;5018.84943451697;5022.949770502249;5030.647854650139;4784.880377990439;4892.877678057935;4972.825951091694;5035.7985680572365;5047.343845300087 18:10:22 INFO - PROCESS | 5438 | |4;prototype.html;345.4973014264246;360.09256673183575;363.5292296476063;365.85548708260256;366.1359192306157;4855.85432437027;4903.6322275829325;4945.7852395942655;4975.353204083473;4981.501849815021;4675.766211689411;4797.184478638631;4820.542048505386;4832.420109586855;4851.539103785135;4111.773852438115;4111.814968326433;4129.483814523184;4133.256013917501;4139.81370838313;4093.3859921011936;4110.260153172428;4111.588841115894;4137.317342638461;4145.196839374881;3922.41163825427;4061.6344528992386;4075.3886916962397;4094.4441112377253;4114.300568903293;4051.250518654029;4058.553559108496;4067.97966010171;4082.6937979651498;4082.81627326771;3801.1257410795397;3807.8286477108595;3810.1998580298173;3814.7520411173464;3823.222201676206;4606.60843828275;4770.976145119287;4786.329913812069;4791.401074865642;4798.784054717511;4683.695559788603;4692.835750748707;4695.694779839299;4703.952960470386;4710.62315014798;5120.231965205212;5128.820491282824;5129.230615407719;5146.536811686966;5149.7940082397035;3965.524137103537;4168.3955826405;4175.601173606846;4184.979075104636;4187.958120418787;5123.846284611468;5209.453007434165;5242.397124330712;5300.831689103132;5410.215518749759;4214;4218.451601291812;4223.450951376301;4264.936025959613;4277.6739210844735;4315.525292217853;4325.264705000158;4333.198358303724;4353.608175264241;4356.978215108904;4383.956160438419;4429.844955426544;4533.863984080483;4626.606738427204;4653.395058642355;5065.645404821701;5078.289039534468;5080.441151473335;5086.54221120101;5087.414947281036;1457.0019536617451;1461.9634509137356;1470.4853301344658;1477.3425825507761;1480.8593183647536;1052.9730269231698;1111.6771042459447;1132.5866058888612;1137.6018393562354;1145.788029214598;4365.192439398721;4365.432493775789;4374.7408180904795;4386.298192289282;4390.714603550759;5096.796128154832;5122.231665250168;5128.640995130305;5130.4356520782685;5150.819721309736;4222.261104306734;4380.956190438119;4388.407564978751;4390.736555806662;4407.316865885793;2663.8678561611237;2687.986560067187;2694.339886727725;2695.5417579011614;2696.7842572594145;4712.458067322302;4730.834420795256;4741.478437371887;4777.856664300077;4798.688085274446;5163.741812909339;5190;5196.714180720021;5226.97386513065;5406.54044406222;4974.651774375759;4975.179095449283;4978.900421991468;4982.277569752366;4993.775280112331;5307.52232299095;5327.9200811987075;5330.120530112643;5335.973320133375;5351.224072509543;5008.524190201925;5189.662671926313;5212.895742085213;5242;5252.789888404421;4708.976455117702;4779.259214821708;4834.758262086952;4889.877753056202;4960.851174464772;4257.70196086271;4276.16125066212;4309.806058727428;4320.114376552862;4322.978385108055;5286.788528458818;5289.6032797539565;5292.655977361459;5297.841064768063;5309.681419114865;4863.805447782049;5115.5396014358885;5125.666831655931;5142.534377702337;5145.716985565829;5098.566621837185;5105.2086926526445;5121.359830021247;5124.256982737556;5129.461406552258;5020.322256495327;5043.949560504348;5043.957197335085;5086.998670784255;5098.745062746922;4964.751762411937;5152.990333769908;5158.587313014875;5165.509276618715;5189.974050129877;4977.129002424634;4992.276119962513;5007.098722230034;5018.422881368543;5023.372078490189 18:10:22 INFO - PROCESS | 5438 | |5;yui.html;598.5630489742488;603.5624172474953;663.4161937495005;670.6445583840565;682.3176823176823;11945.223560468574;12789.680257993556;13235.13971591847;13688.931555342235;13766.793498097511;12111.939440302809;12219.389030548482;12467.68830779231;12529.185602935802;12543;825.0923983618018;834.5159807311744;834.6619619054293;834.9373796965222;835.3150416658343;794.9682012719484;822.1942496353577;823.9052508961486;826.8594338962391;830.2652152844746;867.0072766682146;867.249828898005;867.5748883047293;867.8611422172454;868.053821334745;870.5516658920661;870.9085546017672;871.5163084488138;871.538084815049;871.5511511571545;636.7389370358131;637.3785559079906;637.5983130627675;639.7185238495093;641.2913730328014;13014.284214368206;13184.538541151014;13197.604071877859;13288.402021909038;13661;12465.439055242536;12550.68623284416;12574.622761317176;12672.80990785139;13135.014873884496;10273.178145748323;10462.843057354146;10470.738231544272;10529.526171322308;10585.788284234271;3105.90682279532;3138.3409484008384;3167.619885613718;3194.4250034993693;3229.1765599771907;28909.71090289091;40805;41547.376789348484;58404;58682.413175868125;9936.850947235653;10222.539985700661;10226.693199204035;10259.384436933808;10296.22778291631;17242.655146896992;17266.91366543159;17511;17529.474115776546;17534.649307013788;6373.980163173963;6399.872002559922;6475.337836161252;6503.122078519434;6598.934010659928;3201.983990080035;3339.348826978716;3376.831158442068;3379.2903490267317;3381.594208694972;2651.9867400662874;2760.4341110072387;2772.861356932145;2776.7362100600412;2793.972060279412;445.5077139760518;447.72017489069333;450.6169755707688;451.3162558723536;454.2799662534919;570.5150621971292;600.5285850607253;608.828006088274;611.3723178145251;625.3433894410941;8651.6106775194;8660.696875609323;8672.479651220947;8690.435121717195;8875.378723489293;585.3034888482692;606.5875204860737;614.2168734863085;617.5245061302771;624.9312575616678;3951.4665520154413;4072.7759973201164;4094.467719196485;4096.221717873595;4241.745495270232;59835;60464.697676511336;61496.69251653802;63453;63905.68047159734;43371.34942975858;44117;48692.02615947661;53195.46804531982;55195;38017.4297385545;43840;44219.557804422184;44285;44407.33388999168;8300.460470069425;8420.705275315335;8478.102880125827;8634.611442484978;8649.221570058726;31209.219769505944;32082.19794505156;32152.19619509531;32183.51724724084;32625.510617341235;36722.44916326204;36900.63099369079;37278.254434911694;42841.1431771369;42938.57061429471;10511.421871796818;10568.154547636324;10639.946800265949;10980.231383803377;11387;11812.940935295268;12034.518619255132;12182.939085304517;12704;12822.615321540368;11531.423428828693;11661.76676466483;11797.823032654689;11902.523899043941;12111.152219344915;11112.888871111509;11374.886251137383;11724.531018759155;11756.70608234801;11958.103142264192;10677.359358438518;10913.890861091288;11039.889601103887;11404.372759497975;11454;8550;8837.469751814911;8952.910470895207;9011.819763604823;9132.77168070777;8662.870056949278;9008.27933765284;9344.532773361441;9431.717048488556;9483.620655173716 18:10:22 INFO - PROCESS | 5438 | __end_tp_report 18:10:22 INFO - PROCESS | 5438 | __start_cc_report 18:10:22 INFO - PROCESS | 5438 | _x_x_mozilla_cycle_collect,1866 18:10:22 INFO - PROCESS | 5438 | __end_cc_report 18:10:22 INFO - PROCESS | 5438 | __startTimestamp1488420622832__endTimestamp 18:10:22 INFO - PROCESS | 5438 | 18:10:22 INFO - PROCESS | 5438 | ------- Summary: start ------- 18:10:22 INFO - PROCESS | 5438 | Number of tests: 6 18:10:22 INFO - PROCESS | 5438 | 18:10:22 INFO - PROCESS | 5438 | [#0] dojo.html Cycles:165 Average:4898.94 Median:5007.32 stddev:529.74 (10.6%) stddev-sans-first:500.48 18:10:22 INFO - PROCESS | 5438 | Values: 2626.9 2637.0 2652.3 2660.9 2685.1 4776.0 4888.0 4928.8 4952.6 5022.1 4908.9 4926.7 4947.3 4966.8 4970.1 4509.0 4533.3 4545.9 4568.9 4695.8 4563.2 4615.1 4621.5 4644.7 4705.8 4439.6 4468.0 4584.7 4610.4 4640.2 4506.8 4519.7 4525.2 4527.4 4531.6 4489.8 4490.2 4496.6 4497.0 4510.9 4822.8 4897.6 4952.7 4977.3 4978.9 5371.6 5375.0 5376.4 5378.6 5383.4 5183.6 5353.3 5366.2 5378.4 5426.4 4873.1 4903.7 4935.8 4948.7 4949.2 5405.2 5419.5 5455.3 5468.0 5538.7 5088.6 5126.7 5144.8 5268.7 5312.9 5257.6 5262.0 5264.9 5267.1 5280.9 5241.1 5241.5 5245.6 5245.7 5246.4 5251.6 5252.3 5253.5 5254.2 5254.6 4472.7 4475.3 4477.7 4540.2 4583.6 3962.5 3973.5 3978.6 3982.5 4020.5 4442.5 4466.9 4562.1 4585.2 4628.7 5437.1 5444.8 5452.2 5457.6 5465.6 4604.6 4615.6 4616.8 4622.9 4661.2 4809.8 4828.4 4829.7 4836.4 4879.1 4854.0 4890.4 4892.7 4958.0 4969.4 5302.3 5306.3 5321.6 5331.1 5345.7 5010.8 5024.9 5026.4 5042.5 5058.1 5245.9 5289.6 5296.4 5299.3 5341.5 5175.4 5225.5 5227.3 5312.5 5384.0 5153.4 5155.9 5160.5 5162.6 5164.3 5138.8 5139.0 5150.8 5151.8 5166.8 5095.8 5126.3 5135.9 5138.6 5171.2 5059.7 5231.9 5235.8 5239.8 5273.8 4927.7 4998.7 5006.9 5007.3 5014.3 18:10:22 INFO - PROCESS | 5438 | 18:10:22 INFO - PROCESS | 5438 | [#1] ext.html Cycles:180 Average:34346.73 Median:2977.79 stddev:54523.56 (1831.0%) stddev-sans-first:54617.70 18:10:22 INFO - PROCESS | 5438 | Values: 616.2 680.1 702.6 756.7 767.8 25696.7 27877.6 27892.0 35495.3 36196.5 36147.6 36235.6 36263.5 36336.3 36395.0 7346.4 7463.8 7482.4 7483.4 7484.0 6702.3 6871.1 7320.3 7407.2 8949.0 8934.0 9195.3 9221.4 9240.1 9246.3 9110.1 9125.1 9161.4 9167.2 9171.4 9145.5 9174.5 9199.3 9199.7 9208.2 34470.3 34630.1 34638.8 34658.0 34689.7 3109.2 3116.8 3153.7 3166.0 3171.5 23878.4 23987.5 24151.5 24291.4 24302.6 2939.3 2956.1 2970.6 2985.0 2989.8 143660.0 169781.0 170990.0 171281.0 171409.0 37418.8 37492.6 37595.8 37624.0 37659.8 38602.6 38675.8 38698.8 38706.4 38789.2 11097.4 11266.9 11269.4 11280.2 11285.4 9314.5 9338.0 9356.3 9358.2 9368.3 9590.2 9787.6 9803.7 10658.5 11257.7 4810.1 5021.6 5058.2 5139.1 5164.6 983.4 994.5 1021.7 1023.4 1029.9 22576.2 22891.4 22901.9 22944.0 23073.7 1085.8 1093.5 1097.3 1108.2 1111.6 11511.5 12276.6 12321.7 12388.4 12408.1 236489.0 237195.0 237546.0 237642.0 238190.0 35781.5 36585.5 36592.8 42351.8 43693.0 1144.0 1164.0 1175.8 1177.7 1178.3 25021.1 25631.2 26066.5 26566.7 26584.0 36700.6 36788.0 36810.1 36851.4 36861.6 218342.0 218788.0 218826.0 219493.0 219750.0 22266.4 22727.9 22730.4 22732.5 22778.2 32117.4 32826.2 32841.5 35891.0 35995.3 27361.3 27544.4 27590.3 27857.2 28522.6 28035.4 28087.0 28437.7 28566.0 28614.1 28769.4 28820.9 29022.7 29058.0 29344.0 23059.9 24604.6 25362.6 25707.2 26172.3 20732.4 20750.4 20876.3 20907.5 20933.8 18:10:22 INFO - PROCESS | 5438 | 18:10:22 INFO - PROCESS | 5438 | [#2] jquery.html Cycles:180 Average:28517.15 Median:2291.93 stddev:81501.86 (3556.0%) stddev-sans-first:81703.11 18:10:22 INFO - PROCESS | 5438 | Values: 378.6 390.7 396.2 417.9 435.1 11321.6 12314.1 12434.7 16216.0 16678.7 15635.9 15672.7 15881.0 17565.6 17855.8 5320.9 5536.6 5627.7 5684.8 5691.1 3694.9 4166.0 5555.7 5641.2 5641.6 6518.8 6672.7 6678.4 6680.5 6687.4 6413.6 6621.5 6660.7 6664.7 6674.2 6444.2 6458.5 6468.8 6479.8 6480.6 20371.4 20838.8 20871.6 20947.0 20951.0 2187.3 2222.3 2237.6 2283.8 2326.0 12970.4 13027.4 13044.9 13249.6 13572.9 1810.6 1838.6 1841.3 1854.1 1865.7 76989.0 78432.6 78524.0 80572.6 80655.2 14705.0 15141.9 15193.8 15277.2 15491.5 17310.1 26960.5 27035.2 27062.2 27074.9 6860.8 6885.8 6921.4 7077.2 7154.2 5770.9 5794.7 5935.3 5965.3 5989.2 5969.4 6003.7 6050.0 6063.6 6140.8 3191.0 3197.6 3245.3 3329.9 3351.7 791.8 824.4 829.2 835.1 857.3 15853.8 16109.8 16248.9 16695.8 17142.5 871.4 875.8 877.8 878.8 885.7 5745.6 5773.8 5809.7 5934.9 5996.5 485321.0 489239.0 497981.0 501223.0 503805.0 69280.7 82091.6 88720.5 91066.1 93672.0 974.5 999.2 1020.5 1021.9 1023.9 13641.2 14527.6 14777.3 15090.4 15397.4 36665.8 41882.4 42180.6 42838.1 43868.6 49945.8 51641.7 51859.5 51866.5 52646.5 8437.1 8801.8 9457.5 9497.8 10306.1 11655.9 11714.3 11749.2 11937.6 12458.7 9751.5 10289.6 10388.9 10451.5 10941.0 10030.4 10191.1 10288.2 10341.0 10389.7 10769.6 10825.8 10835.3 10995.1 11104.9 9682.7 10093.8 10339.7 10700.1 10706.8 9350.6 9535.1 10127.3 10151.3 10287.3 18:10:22 INFO - PROCESS | 5438 | 18:10:22 INFO - PROCESS | 5438 | [#3] mootools.html Cycles:180 Average:5782.82 Median:4535.85 stddev:3782.04 (83.4%) stddev-sans-first:3778.36 18:10:22 INFO - PROCESS | 5438 | Values: 1407.2 1409.4 1429.4 1439.0 1442.7 9144.7 9651.9 9743.2 9752.1 9766.0 9363.5 9407.4 9640.9 9731.5 9999.1 2004.4 2047.4 2048.3 2048.9 2050.7 1959.9 1997.2 2004.7 2006.0 2007.9 1628.1 1686.8 1686.9 1855.9 1913.1 2025.8 2026.1 2027.9 2037.5 2047.0 1806.0 1823.1 1843.9 1844.9 2065.3 7977.4 8202.8 9079.6 9632.1 9727.1 4479.6 4592.1 4594.8 4600.5 4604.0 2636.2 2678.8 2711.0 2712.1 2723.0 1001.7 1027.1 1031.6 1045.5 1062.7 13525.2 13768.2 13872.2 13885.2 13906.7 3877.7 3972.6 4002.7 4010.7 4013.5 10848.5 10849.0 10860.7 10865.5 10874.7 4807.7 4814.0 4814.5 4816.8 4817.2 4179.1 4250.7 4284.3 4286.8 4459.6 3187.9 3287.6 3315.4 3318.4 3336.9 823.8 844.2 844.7 849.0 851.4 746.3 768.4 782.8 787.9 797.6 5215.5 5218.7 5360.2 5416.6 5519.4 806.5 812.5 819.6 843.7 859.5 2950.7 3001.9 3029.8 3042.5 3046.6 10815.9 11173.1 11578.1 11662.2 12110.2 11814.5 12185.8 12279.2 12344.6 12378.3 8345.5 8621.9 8636.4 8637.6 8639.3 5560.9 5660.7 5809.2 5877.2 5898.9 10723.9 10791.0 10840.3 10882.9 10973.4 11089.2 11326.2 11416.3 11436.4 11441.9 7811.5 7875.8 7999.3 8009.0 8030.4 8889.3 8911.6 9003.0 9007.2 9014.2 7347.3 7451.1 7477.3 7496.6 7601.4 7434.7 7533.2 7537.2 7566.2 7750.5 6599.4 6718.5 6720.0 6722.8 6732.7 4845.9 4972.7 5018.8 5022.9 5030.6 4784.9 4892.9 4972.8 5035.8 5047.3 18:10:22 INFO - PROCESS | 5438 | 18:10:22 INFO - PROCESS | 5438 | [#4] prototype.html Cycles:180 Average:4356.98 Median:4756.23 stddev:1162.19 (24.4%) stddev-sans-first:1125.77 18:10:22 INFO - PROCESS | 5438 | Values: 345.5 360.1 363.5 365.9 366.1 4855.9 4903.6 4945.8 4975.4 4981.5 4675.8 4797.2 4820.5 4832.4 4851.5 4111.8 4111.8 4129.5 4133.3 4139.8 4093.4 4110.3 4111.6 4137.3 4145.2 3922.4 4061.6 4075.4 4094.4 4114.3 4051.3 4058.6 4068.0 4082.7 4082.8 3801.1 3807.8 3810.2 3814.8 3823.2 4606.6 4771.0 4786.3 4791.4 4798.8 4683.7 4692.8 4695.7 4704.0 4710.6 5120.2 5128.8 5129.2 5146.5 5149.8 3965.5 4168.4 4175.6 4185.0 4188.0 5123.8 5209.5 5242.4 5300.8 5410.2 4214.0 4218.5 4223.5 4264.9 4277.7 4315.5 4325.3 4333.2 4353.6 4357.0 4384.0 4429.8 4533.9 4626.6 4653.4 5065.6 5078.3 5080.4 5086.5 5087.4 1457.0 1462.0 1470.5 1477.3 1480.9 1053.0 1111.7 1132.6 1137.6 1145.8 4365.2 4365.4 4374.7 4386.3 4390.7 5096.8 5122.2 5128.6 5130.4 5150.8 4222.3 4381.0 4388.4 4390.7 4407.3 2663.9 2688.0 2694.3 2695.5 2696.8 4712.5 4730.8 4741.5 4777.9 4798.7 5163.7 5190.0 5196.7 5227.0 5406.5 4974.7 4975.2 4978.9 4982.3 4993.8 5307.5 5327.9 5330.1 5336.0 5351.2 5008.5 5189.7 5212.9 5242.0 5252.8 4709.0 4779.3 4834.8 4889.9 4960.9 4257.7 4276.2 4309.8 4320.1 4323.0 5286.8 5289.6 5292.7 5297.8 5309.7 4863.8 5115.5 5125.7 5142.5 5145.7 5098.6 5105.2 5121.4 5124.3 5129.5 5020.3 5043.9 5044.0 5087.0 5098.7 4964.8 5153.0 5158.6 5165.5 5190.0 4977.1 4992.3 5007.1 5018.4 5023.4 18:10:22 INFO - PROCESS | 5438 | 18:10:22 INFO - PROCESS | 5438 | [#5] yui.html Cycles:180 Average:13313.57 Median:23541.44 stddev:15641.04 (66.4%) stddev-sans-first:15655.77 18:10:22 INFO - PROCESS | 5438 | Values: 598.6 603.6 663.4 670.6 682.3 11945.2 12789.7 13235.1 13688.9 13766.8 12111.9 12219.4 12467.7 12529.2 12543.0 825.1 834.5 834.7 834.9 835.3 795.0 822.2 823.9 826.9 830.3 867.0 867.2 867.6 867.9 868.1 870.6 870.9 871.5 871.5 871.6 636.7 637.4 637.6 639.7 641.3 13014.3 13184.5 13197.6 13288.4 13661.0 12465.4 12550.7 12574.6 12672.8 13135.0 10273.2 10462.8 10470.7 10529.5 10585.8 3105.9 3138.3 3167.6 3194.4 3229.2 28909.7 40805.0 41547.4 58404.0 58682.4 9936.9 10222.5 10226.7 10259.4 10296.2 17242.7 17266.9 17511.0 17529.5 17534.6 6374.0 6399.9 6475.3 6503.1 6598.9 3202.0 3339.3 3376.8 3379.3 3381.6 2652.0 2760.4 2772.9 2776.7 2794.0 445.5 447.7 450.6 451.3 454.3 570.5 600.5 608.8 611.4 625.3 8651.6 8660.7 8672.5 8690.4 8875.4 585.3 606.6 614.2 617.5 624.9 3951.5 4072.8 4094.5 4096.2 4241.7 59835.0 60464.7 61496.7 63453.0 63905.7 43371.3 44117.0 48692.0 53195.5 55195.0 38017.4 43840.0 44219.6 44285.0 44407.3 8300.5 8420.7 8478.1 8634.6 8649.2 31209.2 32082.2 32152.2 32183.5 32625.5 36722.4 36900.6 37278.3 42841.1 42938.6 10511.4 10568.2 10639.9 10980.2 11387.0 11812.9 12034.5 12182.9 12704.0 12822.6 11531.4 11661.8 11797.8 11902.5 12111.2 11112.9 11374.9 11724.5 11756.7 11958.1 10677.4 10913.9 11039.9 11404.4 11454.0 8550.0 8837.5 8952.9 9011.8 9132.8 8662.9 9008.3 9344.5 9431.7 9483.6 18:10:22 INFO - PROCESS | 5438 | -------- Summary: end -------- 18:10:22 INFO - PROCESS | 5438 | 18:10:23 INFO - TEST-INFO | 5438: exit 0 18:10:23 INFO - TEST-OK | dromaeo_css | took 1123898ms 18:10:23 INFO - TEST-START | kraken 18:10:23 INFO - operating with platform_type : linux_ 18:10:23 INFO - Initialising browser for kraken test... 18:10:23 INFO - TEST-INFO | started process 5758 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKX3FJP/profile http://localhost:34522/getInfo.html) 18:10:27 INFO - PROCESS | 5758 | __metrics Screen width/height:1600/1200 18:10:27 INFO - PROCESS | 5758 | colorDepth:24 18:10:27 INFO - PROCESS | 5758 | Browser inner width/height: 1024/697 18:10:27 INFO - PROCESS | 5758 | __metrics 18:10:28 INFO - PROCESS | 5758 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:10:28 INFO - PROCESS | 5758 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:10:29 INFO - TEST-INFO | 5758: exit 0 18:10:29 INFO - Browser initialized. 18:10:29 INFO - Running cycle 1/1 for kraken test... 18:10:29 INFO - TEST-INFO | started process 5850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKX3FJP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:10:41 INFO - PROCESS | 5850 | RSS: Main: 147714048 18:10:41 INFO - PROCESS | 5850 | 18:10:44 INFO - PROCESS | 5850 | Cycle 1(1): loaded http://localhost:34522/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34522/tests/kraken/driver.html?testName=audio-beat-detection) 18:10:45 INFO - PROCESS | 5850 | RSS: Main: 202932224 18:10:45 INFO - PROCESS | 5850 | 18:10:48 INFO - PROCESS | 5850 | Cycle 1(1): loaded http://localhost:34522/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34522/tests/kraken/driver.html?testName=audio-dft) 18:10:49 INFO - PROCESS | 5850 | RSS: Main: 182673408 18:10:49 INFO - PROCESS | 5850 | 18:10:52 INFO - PROCESS | 5850 | Cycle 1(1): loaded http://localhost:34522/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34522/tests/kraken/driver.html?testName=audio-fft) 18:10:52 INFO - PROCESS | 5850 | RSS: Main: 264572928 18:10:52 INFO - PROCESS | 5850 | 18:10:54 INFO - PROCESS | 5850 | Cycle 1(1): loaded http://localhost:34522/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34522/tests/kraken/driver.html?testName=audio-oscillator) 18:10:55 INFO - PROCESS | 5850 | RSS: Main: 175845376 18:10:55 INFO - PROCESS | 5850 | 18:10:57 INFO - PROCESS | 5850 | Cycle 1(1): loaded http://localhost:34522/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34522/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:10:58 INFO - PROCESS | 5850 | RSS: Main: 179056640 18:10:58 INFO - PROCESS | 5850 | 18:11:01 INFO - PROCESS | 5850 | Cycle 1(1): loaded http://localhost:34522/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34522/tests/kraken/driver.html?testName=imaging-darkroom) 18:11:02 INFO - PROCESS | 5850 | RSS: Main: 218255360 18:11:02 INFO - PROCESS | 5850 | 18:11:06 INFO - PROCESS | 5850 | Cycle 1(1): loaded http://localhost:34522/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34522/tests/kraken/driver.html?testName=imaging-desaturate) 18:11:06 INFO - PROCESS | 5850 | RSS: Main: 212033536 18:11:06 INFO - PROCESS | 5850 | 18:11:09 INFO - PROCESS | 5850 | Cycle 1(1): loaded http://localhost:34522/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34522/tests/kraken/driver.html?testName=json-parse-financial) 18:11:10 INFO - PROCESS | 5850 | RSS: Main: 214421504 18:11:10 INFO - PROCESS | 5850 | 18:11:12 INFO - PROCESS | 5850 | Cycle 1(1): loaded http://localhost:34522/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34522/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:11:12 INFO - PROCESS | 5850 | RSS: Main: 177979392 18:11:12 INFO - PROCESS | 5850 | 18:11:14 INFO - PROCESS | 5850 | Cycle 1(1): loaded http://localhost:34522/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34522/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:11:15 INFO - PROCESS | 5850 | RSS: Main: 184549376 18:11:15 INFO - PROCESS | 5850 | 18:11:17 INFO - PROCESS | 5850 | Cycle 1(1): loaded http://localhost:34522/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34522/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:11:17 INFO - PROCESS | 5850 | RSS: Main: 193986560 18:11:17 INFO - PROCESS | 5850 | 18:11:20 INFO - PROCESS | 5850 | Cycle 1(1): loaded http://localhost:34522/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34522/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:11:21 INFO - PROCESS | 5850 | RSS: Main: 203665408 18:11:21 INFO - PROCESS | 5850 | 18:11:24 INFO - PROCESS | 5850 | Cycle 1(1): loaded http://localhost:34522/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34522/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:11:25 INFO - PROCESS | 5850 | RSS: Main: 199606272 18:11:25 INFO - PROCESS | 5850 | 18:11:27 INFO - PROCESS | 5850 | Cycle 1(1): loaded http://localhost:34522/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34522/tests/kraken/driver.html?testName=ai-astar) 18:11:27 INFO - PROCESS | 5850 | RSS: Main: 252436480 18:11:27 INFO - PROCESS | 5850 | 18:11:27 INFO - PROCESS | 5850 | __start_tp_report 18:11:27 INFO - PROCESS | 5850 | _x_x_mozilla_page_load 18:11:27 INFO - PROCESS | 5850 | _x_x_mozilla_page_load_details 18:11:27 INFO - PROCESS | 5850 | |i|pagename|runs| 18:11:27 INFO - PROCESS | 5850 | |0;ai-astar;110;118;117;119;118;117;117;116;117;116 18:11:27 INFO - PROCESS | 5850 | |1;audio-beat-detection;152;131;130;166;126;127;123;127;150;130 18:11:27 INFO - PROCESS | 5850 | |2;audio-dft;163;160;162;161;163;163;162;162;163;161 18:11:27 INFO - PROCESS | 5850 | |3;audio-fft;77;78;78;105;78;78;78;77;94;77 18:11:27 INFO - PROCESS | 5850 | |4;audio-oscillator;85;85;119;85;84;84;102;84;85;111 18:11:27 INFO - PROCESS | 5850 | |5;imaging-gaussian-blur;113;114;114;113;113;114;113;113;114;115 18:11:27 INFO - PROCESS | 5850 | |6;imaging-darkroom;149;149;150;149;150;149;150;148;149;151 18:11:27 INFO - PROCESS | 5850 | |7;imaging-desaturate;94;94;94;93;94;94;94;94;94;94 18:11:27 INFO - PROCESS | 5850 | |8;json-parse-financial;64;64;64;63;66;66;64;64;64;65 18:11:27 INFO - PROCESS | 5850 | |9;json-stringify-tinderbox;56;57;57;57;56;56;56;56;56;56 18:11:27 INFO - PROCESS | 5850 | |10;stanford-crypto-aes;86;86;85;85;86;85;96;96;84;84 18:11:27 INFO - PROCESS | 5850 | |11;stanford-crypto-ccm;151;148;136;138;134;132;144;141;186;140 18:11:27 INFO - PROCESS | 5850 | |12;stanford-crypto-pbkdf2;186;187;182;186;188;190;186;182;182;182 18:11:27 INFO - PROCESS | 5850 | |13;stanford-crypto-sha256-iterative;70;69;69;67;72;69;67;68;68;66 18:11:27 INFO - PROCESS | 5850 | __end_tp_report 18:11:27 INFO - PROCESS | 5850 | __start_cc_report 18:11:27 INFO - PROCESS | 5850 | _x_x_mozilla_cycle_collect,2013 18:11:27 INFO - PROCESS | 5850 | __end_cc_report 18:11:27 INFO - PROCESS | 5850 | __startTimestamp1488420687301__endTimestamp 18:11:27 INFO - PROCESS | 5850 | 18:11:27 INFO - PROCESS | 5850 | ------- Summary: start ------- 18:11:27 INFO - PROCESS | 5850 | Number of tests: 14 18:11:27 INFO - PROCESS | 5850 | 18:11:27 INFO - PROCESS | 5850 | [#0] ai-astar Cycles:10 Average:116.50 Median:117.00 stddev:2.46 (2.1%) stddev-sans-first:0.97 18:11:27 INFO - PROCESS | 5850 | Values: 110.0 118.0 117.0 119.0 118.0 117.0 117.0 116.0 117.0 116.0 18:11:27 INFO - PROCESS | 5850 | 18:11:27 INFO - PROCESS | 5850 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:130.50 stddev:14.45 (11.1%) stddev-sans-first:14.15 18:11:27 INFO - PROCESS | 5850 | Values: 152.0 131.0 130.0 166.0 126.0 127.0 123.0 127.0 150.0 130.0 18:11:27 INFO - PROCESS | 5850 | 18:11:27 INFO - PROCESS | 5850 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.50 stddev:1.05 (0.6%) stddev-sans-first:1.05 18:11:27 INFO - PROCESS | 5850 | Values: 163.0 160.0 162.0 161.0 163.0 163.0 162.0 162.0 163.0 161.0 18:11:27 INFO - PROCESS | 5850 | 18:11:27 INFO - PROCESS | 5850 | [#3] audio-fft Cycles:10 Average:82.00 Median:78.00 stddev:9.59 (12.3%) stddev-sans-first:10.00 18:11:27 INFO - PROCESS | 5850 | Values: 77.0 78.0 78.0 105.0 78.0 78.0 78.0 77.0 94.0 77.0 18:11:27 INFO - PROCESS | 5850 | 18:11:27 INFO - PROCESS | 5850 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:84.50 stddev:13.23 (15.7%) stddev-sans-first:13.76 18:11:27 INFO - PROCESS | 5850 | Values: 85.0 85.0 119.0 85.0 84.0 84.0 102.0 84.0 85.0 111.0 18:11:27 INFO - PROCESS | 5850 | 18:11:27 INFO - PROCESS | 5850 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 18:11:27 INFO - PROCESS | 5850 | Values: 113.0 114.0 114.0 113.0 113.0 114.0 113.0 113.0 114.0 115.0 18:11:27 INFO - PROCESS | 5850 | 18:11:27 INFO - PROCESS | 5850 | [#6] imaging-darkroom Cycles:10 Average:149.40 Median:149.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 18:11:27 INFO - PROCESS | 5850 | Values: 149.0 149.0 150.0 149.0 150.0 149.0 150.0 148.0 149.0 151.0 18:11:27 INFO - PROCESS | 5850 | 18:11:27 INFO - PROCESS | 5850 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 18:11:27 INFO - PROCESS | 5850 | Values: 94.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 94.0 94.0 18:11:27 INFO - PROCESS | 5850 | 18:11:27 INFO - PROCESS | 5850 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 18:11:27 INFO - PROCESS | 5850 | Values: 64.0 64.0 64.0 63.0 66.0 66.0 64.0 64.0 64.0 65.0 18:11:27 INFO - PROCESS | 5850 | 18:11:27 INFO - PROCESS | 5850 | [#9] json-stringify-tinderbox Cycles:10 Average:56.30 Median:56.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 18:11:27 INFO - PROCESS | 5850 | Values: 56.0 57.0 57.0 57.0 56.0 56.0 56.0 56.0 56.0 56.0 18:11:27 INFO - PROCESS | 5850 | 18:11:27 INFO - PROCESS | 5850 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:86.00 stddev:4.64 (5.4%) stddev-sans-first:4.90 18:11:27 INFO - PROCESS | 5850 | Values: 86.0 86.0 85.0 85.0 86.0 85.0 96.0 96.0 84.0 84.0 18:11:27 INFO - PROCESS | 5850 | 18:11:27 INFO - PROCESS | 5850 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:142.50 stddev:15.59 (10.9%) stddev-sans-first:16.39 18:11:27 INFO - PROCESS | 5850 | Values: 151.0 148.0 136.0 138.0 134.0 132.0 144.0 141.0 186.0 140.0 18:11:27 INFO - PROCESS | 5850 | 18:11:27 INFO - PROCESS | 5850 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.10 Median:186.00 stddev:2.92 (1.6%) stddev-sans-first:3.08 18:11:27 INFO - PROCESS | 5850 | Values: 186.0 187.0 182.0 186.0 188.0 190.0 186.0 182.0 182.0 182.0 18:11:27 INFO - PROCESS | 5850 | 18:11:27 INFO - PROCESS | 5850 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.72 (2.5%) stddev-sans-first:1.73 18:11:27 INFO - PROCESS | 5850 | Values: 70.0 69.0 69.0 67.0 72.0 69.0 67.0 68.0 68.0 66.0 18:11:27 INFO - PROCESS | 5850 | -------- Summary: end -------- 18:11:27 INFO - PROCESS | 5850 | 18:11:28 INFO - TEST-INFO | 5850: exit 0 18:11:28 INFO - TEST-OK | kraken | took 64941ms 18:11:28 INFO - SUITE-END | took 1188s 18:11:28 INFO - Completed test suite (00:19:49) 18:11:28 INFO - javascript benchmark 18:11:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6403.878287162008, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2626.8555229462377, 2637.037481319318, 2652.3103992961846, 2660.866956652167, 2685.1004913354027, 4775.952240477594, 4888.046830867982, 4928.753562321887, 4952.628552858537, 5022.07091688038, 4908.852734417964, 4926.655134140611, 4947.332110165135, 4966.826161084363, 4970.055689419008, 4509.030558429937, 4533.297338912474, 4545.909081818361, 4568.885777855564, 4695.8356457524, 4563.201439748047, 4615.05391394765, 4621.491635920063, 4644.7213167210075, 4705.811767529295, 4439.600435960779, 4468.0, 4584.7478388688605, 4610.423697037871, 4640.2343613303765, 4506.842260520899, 4519.661025423106, 4525.162844873676, 4527.4114365132655, 4531.614812740921, 4489.753063581535, 4490.236659767847, 4496.64026877849, 4496.977515112403, 4510.932336014962, 4822.758862056883, 4897.632677549198, 4952.727599981999, 4977.278294647256, 4978.925316120261, 5371.597130215249, 5375.032494151052, 5376.4085950545405, 5378.596605254622, 5383.401923852059, 5183.61122915779, 5353.250544923714, 5366.195070739382, 5378.354597448292, 5426.375966763833, 4873.122837889143, 4903.705777653352, 4935.777889994959, 4948.678335908155, 4949.232868905326, 5405.243265942692, 5419.485148910847, 5455.34535855692, 5467.972660136754, 5538.695371754511, 5088.643794934393, 5126.666766660155, 5144.845654630367, 5268.683878967274, 5312.893742125136, 5257.553107985787, 5262.0, 5264.868378290574, 5267.104592219332, 5280.867978300574, 5241.056609810271, 5241.50205730455, 5245.632805703564, 5245.7114858683135, 5246.370435547682, 5251.6061295403, 5252.29094072303, 5253.500917412916, 5254.185601231815, 5254.605904557174, 4472.709273897186, 4475.26158183896, 4477.664175186874, 4540.182767101887, 4583.633309335245, 3962.5443074046852, 3973.463582416337, 3978.562358140602, 3982.4623675803973, 4020.4773379460485, 4442.53353397895, 4466.888327791831, 4562.087582483517, 4585.243434833282, 4628.69913455631, 5437.13005919051, 5444.754986025639, 5452.182172674131, 5457.590680698963, 5465.562754979592, 4604.585587297092, 4615.630749540096, 4616.76916154191, 4622.86131416058, 4661.230896901973, 4809.831655892027, 4828.396450443694, 4829.6860704054125, 4836.419629644395, 4879.072976134594, 4854.0, 4890.437599676083, 4892.65751397413, 4958.0083983202785, 4969.428515720739, 5302.28419163408, 5306.310179676618, 5321.600879933943, 5331.067063263836, 5345.679259244458, 5010.8496745096245, 5024.874378140576, 5026.44709082008, 5042.495750424928, 5058.08954388199, 5245.947540524546, 5289.57683385336, 5296.443873393392, 5299.346301020463, 5341.519263266169, 5175.404828444777, 5225.529702326809, 5227.2943152675425, 5312.468753124811, 5383.973080134731, 5153.3558305211845, 5155.948440515697, 5160.509751573594, 5162.6386152968935, 5164.302819119521, 5138.794448222029, 5139.0, 5150.819721309736, 5151.8196863109615, 5166.767495462638, 5095.77069031887, 5126.333576635163, 5135.87160320995, 5138.614603904647, 5171.172612382001, 5059.696418214919, 5231.89536209266, 5235.842924712265, 5239.816606418757, 5273.815416460559, 4927.704337739604, 4998.6750861193905, 5006.899862002667, 5007.3240112584335, 5014.297998280171], "value": 4863.266561617279, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [616.238944903045, 680.075097866901, 702.631118662702, 756.73136036707, 767.8118860879085, 25696.74303256967, 27877.581836272446, 27891.999999999975, 35495.2900941981, 36196.45705314422, 36147.638523614754, 36235.63764362356, 36263.456048159234, 36336.27327453449, 36395.0, 7346.37555807757, 7463.776086717407, 7482.401407887356, 7483.438742094338, 7484.0, 6702.329767023283, 6871.072405225305, 7320.304571065767, 7407.222241664628, 8948.955255223747, 8933.955330223373, 9195.310351723614, 9221.400608960395, 9240.122188392092, 9246.306527010467, 9110.134537218953, 9125.133112354315, 9161.358704890661, 9167.220786233145, 9171.44971301724, 9145.536714125708, 9174.495402752846, 9199.26405887534, 9199.724008279762, 9208.217301529377, 34470.310593788236, 34630.134246643785, 34638.82680586606, 34658.0, 34689.653103468896, 3109.160526657812, 3116.844157792101, 3153.716165545112, 3165.9683403165905, 3171.4608516552244, 23878.403039923967, 23987.52024959491, 24151.516969660683, 24291.392715182086, 24302.635460468107, 2939.338648804002, 2956.098389991052, 2970.628671416073, 2984.9552256716165, 2989.8355590442516, 143660.0, 169781.0, 170990.0, 171281.0, 171409.0, 37418.812905935294, 37492.62507374891, 37595.81202093972, 37624.0, 37659.81170094187, 38602.61397386046, 38675.806620966716, 38698.80650596729, 38706.41940370897, 38789.22421551553, 11097.44512774358, 11266.887331126583, 11269.436528173559, 11280.210385273116, 11285.43572821372, 9314.48770317639, 9338.0, 9356.34505584616, 9358.157765800974, 9368.250539956924, 9590.232781377474, 9787.62973183755, 9803.705888823346, 10658.548533837105, 11257.71855703614, 4810.064617192048, 5021.573166280907, 5058.165402708585, 5139.12634852076, 5164.638475306768, 983.4443539400216, 994.4629899854142, 1021.7394564386183, 1023.4473384372355, 1029.9227557933036, 22576.20983265578, 22891.427714307276, 22901.885490572775, 22944.0, 23073.653895191586, 1085.847981282621, 1093.5133865429807, 1097.2812807611028, 1108.196557495809, 1111.555377848867, 11511.48198331077, 12276.631701048982, 12321.69195770095, 12388.442520086617, 12408.131430799758, 236489.0, 237195.0, 237546.0, 237642.0, 238190.0, 35781.46327805085, 36585.45121823175, 36592.81703591465, 42351.788241059214, 43693.0, 1143.9885601143883, 1164.039667274485, 1175.8481977980275, 1177.6682169304825, 1178.251810100575, 25021.12426065152, 25631.23106306814, 26066.478670426106, 26566.7343326572, 26584.0, 36700.63299366972, 36788.0, 36810.079748005446, 36851.44722829106, 36861.63138368582, 218342.0, 218788.0, 218826.0, 219493.0, 219750.0, 22266.443338916655, 22727.886360568093, 22730.43173920665, 22732.545349093256, 22778.20276290322, 32117.357652846345, 32826.17934551655, 32841.50737738983, 35891.0, 35995.28009439744, 27361.31596710098, 27544.449111018068, 27590.310242244104, 27857.16428507148, 28522.57216141801, 28035.43929121447, 28087.017263746784, 28437.715622843505, 28566.0, 28614.117307222805, 28769.424611507235, 28820.855895720386, 29022.709772902002, 29058.0, 29344.0, 23059.88470057639, 24604.630930536416, 25362.619560706236, 25707.228783136536, 26172.345691357106, 20732.378028659165, 20750.37748867476, 20876.269330573356, 20907.477313067295, 20933.790662093794], "value": 14999.663035081103, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.57410413285055, 390.6620773031327, 396.2154933232199, 417.8558397352913, 435.0689524417747, 11321.603743868956, 12314.13801033928, 12434.689132771673, 16216.00003999261, 16678.749818752698, 15635.921820390911, 15672.686546269097, 15881.0, 17565.648687026252, 17855.821441785578, 5320.920186197201, 5536.557075433956, 5627.6904770237825, 5684.772609095631, 5691.117876729114, 3694.926101477969, 4166.0, 5555.694436805974, 5641.153826925953, 5641.576881733887, 6518.837029074263, 6672.699728512229, 6678.365555272241, 6680.498962577802, 6687.398134167924, 6413.583117097421, 6621.536492445531, 6660.733570657168, 6664.666766661671, 6674.232463266713, 6444.194475690539, 6458.451031662315, 6468.805935821886, 6479.773207937699, 6480.578762380477, 20371.388858334274, 20838.791612083838, 20871.5825683487, 20947.0, 20951.0, 2187.3000639795273, 2222.2555443926303, 2237.5524895021063, 2283.8287128465267, 2325.953480930372, 12970.423114467323, 13027.413766380536, 13044.934775326157, 13249.602511924657, 13572.93213533926, 1810.592616661254, 1838.6138910828743, 1841.29110292537, 1854.1285595769966, 1865.7014877619515, 76989.02060625317, 78432.60783696102, 78524.0, 80572.59713701453, 80655.19344806536, 14705.0, 15141.924290378698, 15193.848061519464, 15277.159756213292, 15491.5352539424, 17310.134493275287, 26960.460790784466, 27035.161308062765, 27062.188134356, 27074.864625676746, 6860.759873404407, 6885.793426197222, 6921.446284297244, 7077.150741911004, 7154.213036565973, 5770.855728606818, 5794.681292528951, 5935.2877654681715, 5965.313988891333, 5989.1914591529585, 5969.447943534712, 6003.729832157564, 6049.971504844187, 6063.575549711566, 6140.815775526741, 3190.952135717966, 3197.6322722887166, 3245.3184831185245, 3329.900102996914, 3351.6983471487683, 791.8257983243677, 824.3693574415577, 829.1708291708292, 835.0939230934383, 857.3484152044491, 15853.762193567105, 16109.758353624706, 16248.918755406148, 16695.833041669426, 17142.45717885396, 871.3551971541141, 875.8117004843989, 877.7981064355234, 878.7627340618125, 885.6988623867916, 5745.597808153389, 5773.769049237983, 5809.651420914759, 5934.851628709317, 5996.4603185713495, 485321.0, 489239.0, 497981.0, 501223.0, 503805.0, 69280.65359673169, 82091.58954205191, 88720.45876100475, 91066.08933910709, 93672.0, 974.512743628186, 999.1706883286854, 1020.4897551224387, 1021.9233557483218, 1023.8771347438355, 13641.181529108286, 14527.564173074825, 14777.335019924345, 15090.396384144511, 15397.384104635688, 36665.81667091647, 41882.37176442417, 42180.57819421766, 42838.14323713571, 43868.56131438645, 49945.75027124841, 51641.741791290806, 51859.48140518546, 51866.48133518617, 52646.473535265686, 8437.11410301934, 8801.779955501164, 9457.527123643928, 9497.762555936157, 10306.12397946153, 11655.941720291345, 11714.297142171155, 11749.177557570887, 11937.641870743892, 12458.688532786753, 9751.463669498246, 10289.639862605072, 10388.896111038794, 10451.529681164213, 10941.0, 10030.448325342177, 10191.082802547806, 10288.176945844465, 10341.017603327671, 10389.688309350731, 10769.622045908929, 10825.837612435662, 10835.295705779099, 10995.065419439117, 11104.888951110386, 9682.661106861226, 10093.798124037625, 10339.741506462098, 10700.143988481059, 10706.785864282827, 9350.625974960925, 9535.094166054214, 10127.291089623655, 10151.289409741246, 10287.279890407899], "value": 9019.764386838462, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1407.2471227893077, 1409.4150927365145, 1429.3567894447501, 1439.0214654035256, 1442.7475191841424, 9144.725658230256, 9651.855222171673, 9743.220542356612, 9752.07355301247, 9765.951170244147, 9363.48500832454, 9407.38851974623, 9640.85538716918, 9731.464769437678, 9999.050090241433, 2004.408699433667, 2047.4164863014043, 2048.3035767838933, 2048.8873111978837, 2050.6923961405832, 1959.9412017639422, 1997.1611922992379, 2004.6992951057312, 2005.979940200594, 2007.8895660738654, 1628.0801347238832, 1686.8397502237328, 1686.907220102894, 1855.9257629694796, 1913.1390874106637, 2025.8480613953939, 2026.0781344488223, 2027.9391618251475, 2037.5109973606377, 2046.9692954605619, 1805.9819401805946, 1823.1157888424104, 1843.8524918006526, 1844.8985305808176, 2065.318444913175, 7977.3618110551015, 8202.753917382488, 9079.591418386188, 9632.084951929555, 9727.124558789672, 4479.619232365253, 4592.081583683277, 4594.816207351702, 4600.516945720685, 4603.9769801151115, 2636.222314417232, 2678.7589116979566, 2710.9593356099676, 2712.145674112648, 2723.046933573253, 1001.7295330260862, 1027.111548510533, 1031.5718976624692, 1045.5451878432907, 1062.7290041039485, 13525.188488690612, 13768.24274664903, 13872.167669939836, 13885.166889986633, 13906.721865562633, 3877.728559000899, 3972.6226008529143, 4002.7398219115667, 4010.6791456683395, 4013.518377794625, 10848.511816968097, 10849.0, 10860.728481788019, 10865.45672716361, 10874.72813179661, 4807.711537307703, 4813.975930120397, 4814.518548145157, 4816.759162041884, 4817.181079216542, 4179.080602267496, 4250.72370295936, 4284.3145096784365, 4286.807093680792, 4459.5986361227, 3187.9203019924225, 3287.5836260348624, 3315.370079684852, 3318.3529211803466, 3336.8665253390077, 823.7643534697953, 844.1727107434625, 844.7381311793364, 848.9745307640657, 851.4040171879709, 746.2649290448903, 768.3699366519512, 782.8356045230452, 787.8542469643135, 797.6490344248512, 5215.478452154754, 5218.6868787872845, 5360.2227676987395, 5416.620836541404, 5519.448055194529, 806.5483329335591, 812.4921923797626, 819.6393586821779, 843.6541018182515, 859.4757198109148, 2950.704929507075, 3001.9099427017222, 3029.7727670424365, 3042.4827779277575, 3046.588710524051, 10815.891841081646, 11173.10615150786, 11578.131640127023, 11662.241954272946, 12110.212836165798, 11814.46834892432, 12185.817212741817, 12279.201851879778, 12344.567940122053, 12378.319192444502, 8345.499270043816, 8621.913780862236, 8636.395452318277, 8637.568121593895, 8639.308855291687, 5560.944390556043, 5660.688662123623, 5809.186713859978, 5877.206577112035, 5898.852528686645, 10723.892761072602, 10791.0, 10840.349579024969, 10882.945585272022, 10973.396463194282, 11089.22375433712, 11326.207165498665, 11416.257943233662, 11436.37099959477, 11441.942790285995, 7811.453198276066, 7875.763727088197, 7999.280064794197, 8009.0, 8030.357571394157, 8889.288856891562, 8911.598978045873, 9002.954985225031, 9007.189352958265, 9014.233790127913, 7347.33873951347, 7451.143118541437, 7477.327040566375, 7496.62516874165, 7601.429892758176, 7434.665440055102, 7533.246675332643, 7537.2085930976455, 7566.167721550515, 7750.534967901944, 6599.439047681001, 6718.529702920944, 6720.0, 6722.798316050526, 6732.663366831737, 4845.854624361275, 4972.65191436596, 5018.84943451697, 5022.949770502249, 5030.647854650139, 4784.880377990439, 4892.877678057935, 4972.825951091694, 5035.7985680572365, 5047.343845300087], "value": 4329.793505086737, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.4973014264246, 360.09256673183575, 363.5292296476063, 365.85548708260256, 366.1359192306157, 4855.85432437027, 4903.6322275829325, 4945.7852395942655, 4975.353204083473, 4981.501849815021, 4675.766211689411, 4797.184478638631, 4820.542048505386, 4832.420109586855, 4851.539103785135, 4111.773852438115, 4111.814968326433, 4129.483814523184, 4133.256013917501, 4139.81370838313, 4093.3859921011936, 4110.260153172428, 4111.588841115894, 4137.317342638461, 4145.196839374881, 3922.41163825427, 4061.6344528992386, 4075.3886916962397, 4094.4441112377253, 4114.300568903293, 4051.250518654029, 4058.553559108496, 4067.97966010171, 4082.6937979651498, 4082.81627326771, 3801.1257410795397, 3807.8286477108595, 3810.1998580298173, 3814.7520411173464, 3823.222201676206, 4606.60843828275, 4770.976145119287, 4786.329913812069, 4791.401074865642, 4798.784054717511, 4683.695559788603, 4692.835750748707, 4695.694779839299, 4703.952960470386, 4710.62315014798, 5120.231965205212, 5128.820491282824, 5129.230615407719, 5146.536811686966, 5149.7940082397035, 3965.524137103537, 4168.3955826405, 4175.601173606846, 4184.979075104636, 4187.958120418787, 5123.846284611468, 5209.453007434165, 5242.397124330712, 5300.831689103132, 5410.215518749759, 4214.0, 4218.451601291812, 4223.450951376301, 4264.936025959613, 4277.6739210844735, 4315.525292217853, 4325.264705000158, 4333.198358303724, 4353.608175264241, 4356.978215108904, 4383.956160438419, 4429.844955426544, 4533.863984080483, 4626.606738427204, 4653.395058642355, 5065.645404821701, 5078.289039534468, 5080.441151473335, 5086.54221120101, 5087.414947281036, 1457.0019536617451, 1461.9634509137356, 1470.4853301344658, 1477.3425825507761, 1480.8593183647536, 1052.9730269231698, 1111.6771042459447, 1132.5866058888612, 1137.6018393562354, 1145.788029214598, 4365.192439398721, 4365.432493775789, 4374.7408180904795, 4386.298192289282, 4390.714603550759, 5096.796128154832, 5122.231665250168, 5128.640995130305, 5130.4356520782685, 5150.819721309736, 4222.261104306734, 4380.956190438119, 4388.407564978751, 4390.736555806662, 4407.316865885793, 2663.8678561611237, 2687.986560067187, 2694.339886727725, 2695.5417579011614, 2696.7842572594145, 4712.458067322302, 4730.834420795256, 4741.478437371887, 4777.856664300077, 4798.688085274446, 5163.741812909339, 5190.0, 5196.714180720021, 5226.97386513065, 5406.54044406222, 4974.651774375759, 4975.179095449283, 4978.900421991468, 4982.277569752366, 4993.775280112331, 5307.52232299095, 5327.9200811987075, 5330.120530112643, 5335.973320133375, 5351.224072509543, 5008.524190201925, 5189.662671926313, 5212.895742085213, 5242.0, 5252.789888404421, 4708.976455117702, 4779.259214821708, 4834.758262086952, 4889.877753056202, 4960.851174464772, 4257.70196086271, 4276.16125066212, 4309.806058727428, 4320.114376552862, 4322.978385108055, 5286.788528458818, 5289.6032797539565, 5292.655977361459, 5297.841064768063, 5309.681419114865, 4863.805447782049, 5115.5396014358885, 5125.666831655931, 5142.534377702337, 5145.716985565829, 5098.566621837185, 5105.2086926526445, 5121.359830021247, 5124.256982737556, 5129.461406552258, 5020.322256495327, 5043.949560504348, 5043.957197335085, 5086.998670784255, 5098.745062746922, 4964.751762411937, 5152.990333769908, 5158.587313014875, 5165.509276618715, 5189.974050129877, 4977.129002424634, 4992.276119962513, 5007.098722230034, 5018.422881368543, 5023.372078490189], "value": 4012.0096647625646, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.5630489742488, 603.5624172474953, 663.4161937495005, 670.6445583840565, 682.3176823176823, 11945.223560468574, 12789.680257993556, 13235.13971591847, 13688.931555342235, 13766.793498097511, 12111.939440302809, 12219.389030548482, 12467.68830779231, 12529.185602935802, 12543.0, 825.0923983618018, 834.5159807311744, 834.6619619054293, 834.9373796965222, 835.3150416658343, 794.9682012719484, 822.1942496353577, 823.9052508961486, 826.8594338962391, 830.2652152844746, 867.0072766682146, 867.249828898005, 867.5748883047293, 867.8611422172454, 868.053821334745, 870.5516658920661, 870.9085546017672, 871.5163084488138, 871.538084815049, 871.5511511571545, 636.7389370358131, 637.3785559079906, 637.5983130627675, 639.7185238495093, 641.2913730328014, 13014.284214368206, 13184.538541151014, 13197.604071877859, 13288.402021909038, 13661.0, 12465.439055242536, 12550.68623284416, 12574.622761317176, 12672.80990785139, 13135.014873884496, 10273.178145748323, 10462.843057354146, 10470.738231544272, 10529.526171322308, 10585.788284234271, 3105.90682279532, 3138.3409484008384, 3167.619885613718, 3194.4250034993693, 3229.1765599771907, 28909.71090289091, 40805.0, 41547.376789348484, 58404.0, 58682.413175868125, 9936.850947235653, 10222.539985700661, 10226.693199204035, 10259.384436933808, 10296.22778291631, 17242.655146896992, 17266.91366543159, 17511.0, 17529.474115776546, 17534.649307013788, 6373.980163173963, 6399.872002559922, 6475.337836161252, 6503.122078519434, 6598.934010659928, 3201.983990080035, 3339.348826978716, 3376.831158442068, 3379.2903490267317, 3381.594208694972, 2651.9867400662874, 2760.4341110072387, 2772.861356932145, 2776.7362100600412, 2793.972060279412, 445.5077139760518, 447.72017489069333, 450.6169755707688, 451.3162558723536, 454.2799662534919, 570.5150621971292, 600.5285850607253, 608.828006088274, 611.3723178145251, 625.3433894410941, 8651.6106775194, 8660.696875609323, 8672.479651220947, 8690.435121717195, 8875.378723489293, 585.3034888482692, 606.5875204860737, 614.2168734863085, 617.5245061302771, 624.9312575616678, 3951.4665520154413, 4072.7759973201164, 4094.467719196485, 4096.221717873595, 4241.745495270232, 59835.0, 60464.697676511336, 61496.69251653802, 63453.0, 63905.68047159734, 43371.34942975858, 44117.0, 48692.02615947661, 53195.46804531982, 55195.0, 38017.4297385545, 43840.0, 44219.557804422184, 44285.0, 44407.33388999168, 8300.460470069425, 8420.705275315335, 8478.102880125827, 8634.611442484978, 8649.221570058726, 31209.219769505944, 32082.19794505156, 32152.19619509531, 32183.51724724084, 32625.510617341235, 36722.44916326204, 36900.63099369079, 37278.254434911694, 42841.1431771369, 42938.57061429471, 10511.421871796818, 10568.154547636324, 10639.946800265949, 10980.231383803377, 11387.0, 11812.940935295268, 12034.518619255132, 12182.939085304517, 12704.0, 12822.615321540368, 11531.423428828693, 11661.76676466483, 11797.823032654689, 11902.523899043941, 12111.152219344915, 11112.888871111509, 11374.886251137383, 11724.531018759155, 11756.70608234801, 11958.103142264192, 10677.359358438518, 10913.890861091288, 11039.889601103887, 11404.372759497975, 11454.0, 8550.0, 8837.469751814911, 8952.910470895207, 9011.819763604823, 9132.77168070777, 8662.870056949278, 9008.27933765284, 9344.532773361441, 9431.717048488556, 9483.620655173716], "value": 6033.710536519886, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 118.0, 117.0, 119.0, 118.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 131.0, 130.0, 166.0, 126.0, 127.0, 123.0, 127.0, 150.0, 130.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 162.0, 161.0, 163.0, 163.0, 162.0, 162.0, 163.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 105.0, 78.0, 78.0, 78.0, 77.0, 94.0, 77.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 119.0, 85.0, 84.0, 84.0, 102.0, 84.0, 85.0, 111.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 113.0, 113.0, 114.0, 113.0, 113.0, 114.0, 115.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 150.0, 149.0, 150.0, 149.0, 150.0, 148.0, 149.0, 151.0], "value": 149.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 63.0, 66.0, 66.0, 64.0, 64.0, 64.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 57.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0], "value": 56.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 85.0, 85.0, 86.0, 85.0, 96.0, 96.0, 84.0, 84.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 148.0, 136.0, 138.0, 134.0, 132.0, 144.0, 141.0, 186.0, 140.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 187.0, 182.0, 186.0, 188.0, 190.0, 186.0, 182.0, 182.0, 182.0], "value": 185.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 67.0, 72.0, 69.0, 67.0, 68.0, 68.0, 66.0], "value": 68.5, "unit": "score"}]}]} 18:11:29 INFO - Return code: 0 18:11:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:11:29 ERROR - # TBPL SUCCESS # 18:11:29 INFO - Running post-action listener: _resource_record_post_action 18:11:29 INFO - [mozharness: 2017-03-02 02:11:29.125899Z] Finished run-tests step (success) 18:11:29 INFO - Running post-run listener: _resource_record_post_run 18:11:29 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 8192; Write bytes: 361009152; Read time: 156; Write time: 191652 18:11:29 INFO - TinderboxPrint: CPU usage
13.1% 18:11:29 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 156 18:11:29 INFO - TinderboxPrint: I/O write bytes / time
361,009,152 / 191,652 18:11:29 INFO - TinderboxPrint: CPU idle
8,355.9 (86.9%) 18:11:29 INFO - TinderboxPrint: CPU user
1,216.1 (12.6%) 18:11:29 INFO - TinderboxPrint: Swap in / out
0 / 0 18:11:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 105762816; Read time: 60; Write time: 79920 18:11:29 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 255246336; Read time: 96; Write time: 111732 18:11:29 INFO - Running post-run listener: _upload_blobber_files 18:11:29 INFO - Blob upload gear active. 18:11:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:11:29 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 18:11:29 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'] 18:11:29 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 18:11:30 INFO - (blobuploader) - INFO - Open directory for files ... 18:11:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:11:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:11:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:11:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:11:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:11:33 INFO - (blobuploader) - INFO - Done attempting. 18:11:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:11:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:11:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:11:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:11:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:11:34 INFO - (blobuploader) - INFO - Done attempting. 18:11:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:11:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:11:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:11:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:11:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:11:35 INFO - (blobuploader) - INFO - Done attempting. 18:11:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:11:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:11:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:11:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:11:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:11:36 INFO - (blobuploader) - INFO - Done attempting. 18:11:36 INFO - (blobuploader) - INFO - Iteration through files over. 18:11:36 INFO - Return code: 0 18:11:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:11:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:11:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/266a06a96a660918633f343b18e7d8f78692f6e2fb6654896314bbd87b9d8a9bc870b65b2a78884591876e53057f2f02c7e456982b014cae505d9fbd23f0f489", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1032a5504fa3c0f00c270c865edce94b258fc2b5fe9e60214ea2d409ddc265b10fa6a6c76bb0fc3ef45d5ad8606bba73cce095a892cf7a94132757625adc9f2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/26e683ad4b7fbe1359c43ba24420903279fc534b857652bd866ccb1dcc78e276f64232f2c11a80e17a08b9afae4f2c9a55a0e8426b307cbee451bbb7a1f69fce", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/30bea0c6d9a63c4bdf03b45d56687151cd7daa2986a3bb32a0566dd2f5681890cbb21c62427496a6a1376339aa6ef42d7ac4e5ee093c69cf9e794b0ad7b55745"} 18:11:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:11:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:11:36 INFO - Contents: 18:11:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/266a06a96a660918633f343b18e7d8f78692f6e2fb6654896314bbd87b9d8a9bc870b65b2a78884591876e53057f2f02c7e456982b014cae505d9fbd23f0f489", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1032a5504fa3c0f00c270c865edce94b258fc2b5fe9e60214ea2d409ddc265b10fa6a6c76bb0fc3ef45d5ad8606bba73cce095a892cf7a94132757625adc9f2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/26e683ad4b7fbe1359c43ba24420903279fc534b857652bd866ccb1dcc78e276f64232f2c11a80e17a08b9afae4f2c9a55a0e8426b307cbee451bbb7a1f69fce", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/30bea0c6d9a63c4bdf03b45d56687151cd7daa2986a3bb32a0566dd2f5681890cbb21c62427496a6a1376339aa6ef42d7ac4e5ee093c69cf9e794b0ad7b55745"} 18:11:36 INFO - Running post-run listener: copy_logs_to_upload_dir 18:11:36 INFO - Copying logs to upload dir... 18:11:36 INFO - mkdir: /builds/slave/test/build/upload/logs 18:11:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.864127 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-03-01 18:11:36.105781) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-01 18:11:36.109818) ========= 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=dac658600622fd96716c9acf000001b3-1488415547.754645-832626236 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/266a06a96a660918633f343b18e7d8f78692f6e2fb6654896314bbd87b9d8a9bc870b65b2a78884591876e53057f2f02c7e456982b014cae505d9fbd23f0f489", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1032a5504fa3c0f00c270c865edce94b258fc2b5fe9e60214ea2d409ddc265b10fa6a6c76bb0fc3ef45d5ad8606bba73cce095a892cf7a94132757625adc9f2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/26e683ad4b7fbe1359c43ba24420903279fc534b857652bd866ccb1dcc78e276f64232f2c11a80e17a08b9afae4f2c9a55a0e8426b307cbee451bbb7a1f69fce", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/30bea0c6d9a63c4bdf03b45d56687151cd7daa2986a3bb32a0566dd2f5681890cbb21c62427496a6a1376339aa6ef42d7ac4e5ee093c69cf9e794b0ad7b55745"} build_url:https://queue.taskcluster.net/v1/task/YQ4KV7HrSM2kN4Y5nUZ89A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011366 build_url: 'https://queue.taskcluster.net/v1/task/YQ4KV7HrSM2kN4Y5nUZ89A/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/266a06a96a660918633f343b18e7d8f78692f6e2fb6654896314bbd87b9d8a9bc870b65b2a78884591876e53057f2f02c7e456982b014cae505d9fbd23f0f489", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1032a5504fa3c0f00c270c865edce94b258fc2b5fe9e60214ea2d409ddc265b10fa6a6c76bb0fc3ef45d5ad8606bba73cce095a892cf7a94132757625adc9f2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/26e683ad4b7fbe1359c43ba24420903279fc534b857652bd866ccb1dcc78e276f64232f2c11a80e17a08b9afae4f2c9a55a0e8426b307cbee451bbb7a1f69fce", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/30bea0c6d9a63c4bdf03b45d56687151cd7daa2986a3bb32a0566dd2f5681890cbb21c62427496a6a1376339aa6ef42d7ac4e5ee093c69cf9e794b0ad7b55745"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-01 18:11:36.134970) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 18:11:36.135293) ========= 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=dac658600622fd96716c9acf000001b3-1488415547.754645-832626236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 18:11:36.219348) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-01 18:11:36.219665) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-01 18:11:36.219983) ========= ========= Total master_lag: 0.16 =========