builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-065 starttime: 1488646706.47 results: success (0) revision: 14cf0c8a70e142e1416aa091f11b94619de1dcba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-04 08:58:26.469304) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-04 08:58:26.469855) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-04 08:58:26.470191) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-04 08:58:26.486494) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-04 08:58:26.487078) ========= 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=523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-04 08:58:28-- 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% 225M=0s 2017-03-04 08:58:28 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.350758 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-04 08:58:26.856327) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-04 08:58:26.856719) ========= 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=523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019244 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-04 08:58:26.908535) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-04 08:58:26.908918) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 14cf0c8a70e142e1416aa091f11b94619de1dcba --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 14cf0c8a70e142e1416aa091f11b94619de1dcba --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=523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-04 08:58:28,622 truncating revision to first 12 chars 2017-03-04 08:58:28,623 Setting DEBUG logging. 2017-03-04 08:58:28,623 attempt 1/10 2017-03-04 08:58:28,623 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/14cf0c8a70e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-04 08:58:29,945 unpacking tar archive at: mozilla-aurora-14cf0c8a70e1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.645834 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-04 08:58:28.572442) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-04 08:58:28.573134) ========= script_repo_revision: 14cf0c8a70e142e1416aa091f11b94619de1dcba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-04 08:58:28.574115) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-04 08:58:28.574820) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-04 08:58:28.585869) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-03-04 08:58:28.586203) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:58:30 INFO - MultiFileLogger online at 20170304 08:58:30 in /builds/slave/test 08:58:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:58:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:58:30 INFO - {'append_to_log': False, 08:58:30 INFO - 'base_work_dir': '/builds/slave/test', 08:58:30 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:58:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:58:30 INFO - 'branch': 'Mozilla-Aurora', 08:58:30 INFO - 'buildbot_json_path': 'buildprops.json', 08:58:30 INFO - 'config_files': ('talos/linux_config.py',), 08:58:30 INFO - 'default_actions': ('clobber', 08:58:30 INFO - 'read-buildbot-config', 08:58:30 INFO - 'download-and-extract', 08:58:30 INFO - 'populate-webroot', 08:58:30 INFO - 'create-virtualenv', 08:58:30 INFO - 'install', 08:58:30 INFO - 'run-tests'), 08:58:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:58:30 INFO - 'download_minidump_stackwalk': True, 08:58:30 INFO - 'download_symbols': 'ondemand', 08:58:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:58:30 INFO - 'tooltool.py': '/tools/tooltool.py', 08:58:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:58:30 INFO - '/tools/misc-python/virtualenv.py')}, 08:58:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:58:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:58:30 INFO - 'installer_path': 'installer.exe', 08:58:30 INFO - 'log_level': 'info', 08:58:30 INFO - 'log_name': 'talos', 08:58:30 INFO - 'log_to_console': True, 08:58:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:58:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:58:30 INFO - 'opt_config_files': (), 08:58:30 INFO - 'pip_index': False, 08:58:30 INFO - 'sps_profile': False, 08:58:30 INFO - 'sps_profile_interval': 0, 08:58:30 INFO - 'suite': 'dromaeojs', 08:58:30 INFO - 'system_bits': '32', 08:58:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:58:30 INFO - 'title': 'talos-linux64-ix-065', 08:58:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:58:30 INFO - 'use_talos_json': True, 08:58:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:58:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:58:30 INFO - 'work_dir': 'build'} 08:58:30 INFO - [mozharness: 2017-03-04 16:58:30.402409Z] Running clobber step. 08:58:30 INFO - Running pre-action listener: _resource_record_pre_action 08:58:30 INFO - Running main action method: clobber 08:58:30 INFO - rmtree: /builds/slave/test/build 08:58:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:58:31 INFO - Running post-action listener: _resource_record_post_action 08:58:31 INFO - [mozharness: 2017-03-04 16:58:31.335810Z] Finished clobber step (success) 08:58:31 INFO - [mozharness: 2017-03-04 16:58:31.335911Z] Running read-buildbot-config step. 08:58:31 INFO - Running pre-action listener: _resource_record_pre_action 08:58:31 INFO - Running main action method: read_buildbot_config 08:58:31 INFO - Using buildbot properties: 08:58:31 INFO - { 08:58:31 INFO - "project": "", 08:58:31 INFO - "product": "firefox", 08:58:31 INFO - "who": "ffxbld@noreply.mozilla.org", 08:58:31 INFO - "installer_path": "public/build/target.tar.bz2", 08:58:31 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:58:31 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 08:58:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:58:31 INFO - "stage_platform": "linux64-pgo", 08:58:31 INFO - "basedir": "/builds/slave/test", 08:58:31 INFO - "buildnumber": 788, 08:58:31 INFO - "platform": "ubuntu64_hw", 08:58:31 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:58:31 INFO - "slavebuilddir": "test", 08:58:31 INFO - "taskId": "bGyK0NYuRC2JFma_x5NYmQ", 08:58:31 INFO - "branch": "mozilla-aurora", 08:58:31 INFO - "script_repo_revision": "production", 08:58:31 INFO - "revision": "14cf0c8a70e142e1416aa091f11b94619de1dcba", 08:58:31 INFO - "slavename": "talos-linux64-ix-065", 08:58:31 INFO - "repo_path": "releases/mozilla-aurora" 08:58:31 INFO - } 08:58:31 INFO - Finding installer, test and symbols from parent task. 08:58:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bGyK0NYuRC2JFma_x5NYmQ'}, attempt #1 08:58:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bGyK0NYuRC2JFma_x5NYmQ'}, attempt #1 08:58:32 INFO - Task dependencies: I1PELWSkTSyEA_5hYT6m6Q 08:58:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I1PELWSkTSyEA_5hYT6m6Q'}, attempt #1 08:58:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/I1PELWSkTSyEA_5hYT6m6Q/artifacts/public/build/target.tar.bz2 08:58:32 INFO - Set test_url: https://queue.taskcluster.net/v1/task/I1PELWSkTSyEA_5hYT6m6Q/artifacts/public/build/test_packages.json 08:58:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/I1PELWSkTSyEA_5hYT6m6Q/artifacts/public/build/target.crashreporter-symbols.zip 08:58:32 INFO - Running post-action listener: _resource_record_post_action 08:58:32 INFO - [mozharness: 2017-03-04 16:58:32.726988Z] Finished read-buildbot-config step (success) 08:58:32 INFO - [mozharness: 2017-03-04 16:58:32.727205Z] Running download-and-extract step. 08:58:32 INFO - Running pre-action listener: _resource_record_pre_action 08:58:32 INFO - Running main action method: download_and_extract 08:58:32 INFO - mkdir: /builds/slave/test/build/tests 08:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:58:32 INFO - trying https://queue.taskcluster.net/v1/task/I1PELWSkTSyEA_5hYT6m6Q/artifacts/public/build/target.test_packages.json 08:58:32 INFO - Downloading https://queue.taskcluster.net/v1/task/I1PELWSkTSyEA_5hYT6m6Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:58:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I1PELWSkTSyEA_5hYT6m6Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:58:33 INFO - Downloaded 896 bytes. 08:58:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:58:33 INFO - Using the following test package requirements: 08:58:33 INFO - {u'common': [u'target.common.tests.zip'], 08:58:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:58:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:58:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:58:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:58:33 INFO - u'mozbase': [u'target.common.tests.zip'], 08:58:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:58:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:58:33 INFO - u'web-platform': [u'target.common.tests.zip', 08:58:33 INFO - u'target.web-platform.tests.zip'], 08:58:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:58:33 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:58:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I1PELWSkTSyEA_5hYT6m6Q/artifacts/public/build/target.common.tests.zip 08:58:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I1PELWSkTSyEA_5hYT6m6Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:58:33 INFO - Fetch https://queue.taskcluster.net/v1/task/I1PELWSkTSyEA_5hYT6m6Q/artifacts/public/build/target.common.tests.zip into memory 08:58:34 INFO - Expected file size: 21861613 08:58:34 INFO - Obtained file size: 21861613 08:58:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:58:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I1PELWSkTSyEA_5hYT6m6Q/artifacts/public/build/target.common.tests.zip 08:58:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I1PELWSkTSyEA_5hYT6m6Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:58:38 INFO - Fetch https://queue.taskcluster.net/v1/task/I1PELWSkTSyEA_5hYT6m6Q/artifacts/public/build/target.common.tests.zip into memory 08:58:38 INFO - Expected file size: 21861613 08:58:38 INFO - Obtained file size: 21861613 08:58:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I1PELWSkTSyEA_5hYT6m6Q/artifacts/public/build/target.talos.tests.zip 08:58:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I1PELWSkTSyEA_5hYT6m6Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:58:43 INFO - Fetch https://queue.taskcluster.net/v1/task/I1PELWSkTSyEA_5hYT6m6Q/artifacts/public/build/target.talos.tests.zip into memory 08:58:44 INFO - Expected file size: 14403650 08:58:44 INFO - Obtained file size: 14403650 08:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:58:44 INFO - trying https://queue.taskcluster.net/v1/task/I1PELWSkTSyEA_5hYT6m6Q/artifacts/public/build/target.tar.bz2 08:58:44 INFO - Downloading https://queue.taskcluster.net/v1/task/I1PELWSkTSyEA_5hYT6m6Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:58:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I1PELWSkTSyEA_5hYT6m6Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:58:45 INFO - Downloaded 66140956 bytes. 08:58:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I1PELWSkTSyEA_5hYT6m6Q/artifacts/public/build/target.tar.bz2 08:58:45 INFO - mkdir: /builds/slave/test/properties 08:58:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:58:45 INFO - Writing to file /builds/slave/test/properties/build_url 08:58:45 INFO - Contents: 08:58:45 INFO - build_url:https://queue.taskcluster.net/v1/task/I1PELWSkTSyEA_5hYT6m6Q/artifacts/public/build/target.tar.bz2 08:58:45 INFO - Running post-action listener: _resource_record_post_action 08:58:45 INFO - Running post-action listener: set_extra_try_arguments 08:58:45 INFO - [mozharness: 2017-03-04 16:58:45.626574Z] Finished download-and-extract step (success) 08:58:45 INFO - [mozharness: 2017-03-04 16:58:45.626671Z] Running populate-webroot step. 08:58:45 INFO - Running pre-action listener: _resource_record_pre_action 08:58:45 INFO - Running main action method: populate_webroot 08:58:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:58:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:58:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:58:45 INFO - '--tppagecycles', 08:58:45 INFO - '7'], 08:58:45 INFO - 'tests': ['tsvgm']}}, 08:58:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:58:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:58:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:58:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:58:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:58:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:58:45 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:58:45 INFO - 'talos_options': ['--disable-e10s'], 08:58:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:58:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:58:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:58:45 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:58:45 INFO - 'talos_options': ['--disable-e10s'], 08:58:45 INFO - 'tests': ['damp', 'tps']}, 08:58:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:58:45 INFO - 'tests': ['damp', 'tps']}, 08:58:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:58:45 INFO - 'tests': ['dromaeo_dom']}, 08:58:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:58:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:58:45 INFO - 'tests': ['basic_compositor_video']}, 08:58:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:58:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:58:45 INFO - 'tests': ['a11yr', 08:58:45 INFO - 'ts_paint', 08:58:45 INFO - 'tpaint', 08:58:45 INFO - 'sessionrestore', 08:58:45 INFO - 'sessionrestore_no_auto_restore', 08:58:45 INFO - 'tabpaint']}, 08:58:45 INFO - 'other-e10s': {'tests': ['a11yr', 08:58:45 INFO - 'ts_paint', 08:58:45 INFO - 'tpaint', 08:58:45 INFO - 'sessionrestore', 08:58:45 INFO - 'sessionrestore_no_auto_restore', 08:58:45 INFO - 'tabpaint']}, 08:58:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:58:45 INFO - 'ts_paint', 08:58:45 INFO - 'tpaint', 08:58:45 INFO - 'sessionrestore', 08:58:45 INFO - 'sessionrestore_no_auto_restore', 08:58:45 INFO - 'tabpaint']}, 08:58:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:58:45 INFO - 'ts_paint', 08:58:45 INFO - 'tpaint', 08:58:45 INFO - 'sessionrestore', 08:58:45 INFO - 'sessionrestore_no_auto_restore', 08:58:45 INFO - 'tabpaint']}, 08:58:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:58:45 INFO - 'tests': ['a11yr', 08:58:45 INFO - 'ts_paint', 08:58:45 INFO - 'tpaint', 08:58:45 INFO - 'sessionrestore', 08:58:45 INFO - 'sessionrestore_no_auto_restore', 08:58:45 INFO - 'tabpaint']}, 08:58:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:58:45 INFO - 'tests': ['a11yr', 08:58:45 INFO - 'ts_paint', 08:58:45 INFO - 'tpaint', 08:58:45 INFO - 'sessionrestore', 08:58:45 INFO - 'sessionrestore_no_auto_restore', 08:58:45 INFO - 'tabpaint']}, 08:58:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:58:45 INFO - 'tests': ['tsvgx', 08:58:45 INFO - 'tsvgr_opacity', 08:58:45 INFO - 'tart', 08:58:45 INFO - 'tscrollx', 08:58:45 INFO - 'cart', 08:58:45 INFO - 'tsvg_static']}, 08:58:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:58:45 INFO - 'tsvgr_opacity', 08:58:45 INFO - 'tart', 08:58:45 INFO - 'tscrollx', 08:58:45 INFO - 'cart', 08:58:45 INFO - 'tsvg_static']}, 08:58:45 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:58:45 INFO - 'talos_options': ['--disable-e10s'], 08:58:45 INFO - 'tests': ['tp5o']}, 08:58:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:58:45 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:58:45 INFO - 'talos_options': ['--disable-e10s', 08:58:45 INFO - '--xperf_path', 08:58:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:58:45 INFO - 'tests': ['tp5n']}, 08:58:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:58:45 INFO - 'talos_options': ['--xperf_path', 08:58:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:58:45 INFO - 'tests': ['tp5n']}}, 08:58:45 INFO - 'talos.zip': {'path': '', 08:58:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:58:45 INFO - Running post-action listener: _resource_record_post_action 08:58:45 INFO - [mozharness: 2017-03-04 16:58:45.639771Z] Finished populate-webroot step (success) 08:58:45 INFO - [mozharness: 2017-03-04 16:58:45.639862Z] Running create-virtualenv step. 08:58:45 INFO - Running pre-action listener: _resource_record_pre_action 08:58:45 INFO - Running main action method: create_virtualenv 08:58:45 INFO - Creating virtualenv /builds/slave/test/build/venv 08:58:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:58:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:58:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:58:45 INFO - Using real prefix '/usr' 08:58:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:58:46 INFO - Installing distribute.............................................................................................................................................................................................done. 08:58:48 INFO - Installing pip.................done. 08:58:48 INFO - Return code: 0 08:58:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:58:48 INFO - Reading from file tmpfile_stdout 08:58:48 INFO - Output received: 08:58:48 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:58:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:58:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xaee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbfea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe60630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee9850>, '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 0xe5e6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5eb60>, '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': '523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576', '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 08:58:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:58:48 INFO - Using env: {'DISPLAY': ':0', 08:58:48 INFO - 'HOME': '/home/cltbld', 08:58:48 INFO - 'LANG': 'en_US.UTF-8', 08:58:48 INFO - 'LANGUAGE': 'en_US:en', 08:58:48 INFO - 'LOGNAME': 'cltbld', 08:58:48 INFO - 'MAIL': '/var/mail/cltbld', 08:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:48 INFO - 'MOZ_NO_REMOTE': '1', 08:58:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:48 INFO - 'NO_EM_RESTART': '1', 08:58:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:48 INFO - 'PWD': '/builds/slave/test', 08:58:48 INFO - 'SHELL': '/bin/bash', 08:58:48 INFO - 'SHLVL': '1', 08:58:48 INFO - 'TERM': 'linux', 08:58:48 INFO - 'TMOUT': '86400', 08:58:48 INFO - 'USER': 'cltbld', 08:58:48 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576', 08:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:48 INFO - '_': '/tools/buildbot/bin/python'} 08:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:58:48 INFO - Cleaning up... 08:58:48 INFO - Return code: 0 08:58:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:58:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xaee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbfea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe60630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee9850>, '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 0xe5e6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5eb60>, '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': '523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576', '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 08:58:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:58:48 INFO - Using env: {'DISPLAY': ':0', 08:58:48 INFO - 'HOME': '/home/cltbld', 08:58:48 INFO - 'LANG': 'en_US.UTF-8', 08:58:48 INFO - 'LANGUAGE': 'en_US:en', 08:58:48 INFO - 'LOGNAME': 'cltbld', 08:58:48 INFO - 'MAIL': '/var/mail/cltbld', 08:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:48 INFO - 'MOZ_NO_REMOTE': '1', 08:58:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:48 INFO - 'NO_EM_RESTART': '1', 08:58:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:48 INFO - 'PWD': '/builds/slave/test', 08:58:48 INFO - 'SHELL': '/bin/bash', 08:58:48 INFO - 'SHLVL': '1', 08:58:48 INFO - 'TERM': 'linux', 08:58:48 INFO - 'TMOUT': '86400', 08:58:48 INFO - 'USER': 'cltbld', 08:58:48 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576', 08:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:48 INFO - '_': '/tools/buildbot/bin/python'} 08:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:48 INFO - Downloading/unpacking psutil>=3.1.1 08:58:48 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 08:58:48 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 08:58:48 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 08:58:48 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 08:58:48 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 08:58:48 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 08:58:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:58:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:58:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:58:51 INFO - Installing collected packages: psutil 08:58:51 INFO - Running setup.py install for psutil 08:58:51 INFO - building 'psutil._psutil_linux' extension 08:58:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:58:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:58:51 INFO - building 'psutil._psutil_posix' extension 08:58:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:58:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:58:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:58:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:58:51 INFO - Successfully installed psutil 08:58:51 INFO - Cleaning up... 08:58:51 INFO - Return code: 0 08:58:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:58:51 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')]} 08:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:51 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')]} 08:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:51 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 0xaee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbfea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe60630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee9850>, '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 0xe5e6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5eb60>, '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': '523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576', '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 08:58:51 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 08:58:51 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 08:58:51 INFO - Using env: {'DISPLAY': ':0', 08:58:51 INFO - 'HOME': '/home/cltbld', 08:58:51 INFO - 'LANG': 'en_US.UTF-8', 08:58:51 INFO - 'LANGUAGE': 'en_US:en', 08:58:51 INFO - 'LOGNAME': 'cltbld', 08:58:51 INFO - 'MAIL': '/var/mail/cltbld', 08:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:51 INFO - 'MOZ_NO_REMOTE': '1', 08:58:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:51 INFO - 'NO_EM_RESTART': '1', 08:58:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:51 INFO - 'PWD': '/builds/slave/test', 08:58:51 INFO - 'SHELL': '/bin/bash', 08:58:51 INFO - 'SHLVL': '1', 08:58:51 INFO - 'TERM': 'linux', 08:58:51 INFO - 'TMOUT': '86400', 08:58:51 INFO - 'USER': 'cltbld', 08:58:51 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576', 08:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:51 INFO - '_': '/tools/buildbot/bin/python'} 08:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:58:51 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 08:58:51 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 08:58:51 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 08:58:51 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 08:58:51 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 08:58:51 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 08:58:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:58:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:58:53 INFO - Installing collected packages: mozsystemmonitor 08:58:53 INFO - Running setup.py install for mozsystemmonitor 08:58:53 INFO - Successfully installed mozsystemmonitor 08:58:53 INFO - Cleaning up... 08:58:54 INFO - Return code: 0 08:58:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xaee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbfea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe60630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee9850>, '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 0xe5e6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5eb60>, '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': '523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576', '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 08:58:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:58:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:58:54 INFO - Using env: {'DISPLAY': ':0', 08:58:54 INFO - 'HOME': '/home/cltbld', 08:58:54 INFO - 'LANG': 'en_US.UTF-8', 08:58:54 INFO - 'LANGUAGE': 'en_US:en', 08:58:54 INFO - 'LOGNAME': 'cltbld', 08:58:54 INFO - 'MAIL': '/var/mail/cltbld', 08:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:54 INFO - 'MOZ_NO_REMOTE': '1', 08:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:54 INFO - 'NO_EM_RESTART': '1', 08:58:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:54 INFO - 'PWD': '/builds/slave/test', 08:58:54 INFO - 'SHELL': '/bin/bash', 08:58:54 INFO - 'SHLVL': '1', 08:58:54 INFO - 'TERM': 'linux', 08:58:54 INFO - 'TMOUT': '86400', 08:58:54 INFO - 'USER': 'cltbld', 08:58:54 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576', 08:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:54 INFO - '_': '/tools/buildbot/bin/python'} 08:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:54 INFO - Downloading/unpacking jsonschema==2.5.1 08:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:58:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:56 INFO - Downloading functools32-3.2.3-2.tar.gz 08:58:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:58:56 INFO - warning: no files found matching '*.txt' 08:58:56 INFO - no previously-included directories found matching 'build' 08:58:56 INFO - no previously-included directories found matching 'dist' 08:58:56 INFO - no previously-included directories found matching '.git*' 08:58:56 INFO - Installing collected packages: jsonschema, functools32 08:58:56 INFO - Running setup.py install for functools32 08:58:56 INFO - warning: no files found matching '*.txt' 08:58:56 INFO - no previously-included directories found matching 'build' 08:58:56 INFO - no previously-included directories found matching 'dist' 08:58:56 INFO - no previously-included directories found matching '.git*' 08:58:56 INFO - Successfully installed jsonschema functools32 08:58:56 INFO - Cleaning up... 08:58:56 INFO - Return code: 0 08:58:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:58:56 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')]} 08:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:56 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')]} 08:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:56 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 0xaee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbfea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe60630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee9850>, '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 0xe5e6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5eb60>, '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': '523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576', '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 08:58:56 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 08:58:56 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 08:58:56 INFO - Using env: {'DISPLAY': ':0', 08:58:56 INFO - 'HOME': '/home/cltbld', 08:58:56 INFO - 'LANG': 'en_US.UTF-8', 08:58:56 INFO - 'LANGUAGE': 'en_US:en', 08:58:56 INFO - 'LOGNAME': 'cltbld', 08:58:56 INFO - 'MAIL': '/var/mail/cltbld', 08:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:56 INFO - 'MOZ_NO_REMOTE': '1', 08:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:56 INFO - 'NO_EM_RESTART': '1', 08:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:56 INFO - 'PWD': '/builds/slave/test', 08:58:56 INFO - 'SHELL': '/bin/bash', 08:58:56 INFO - 'SHLVL': '1', 08:58:56 INFO - 'TERM': 'linux', 08:58:56 INFO - 'TMOUT': '86400', 08:58:56 INFO - 'USER': 'cltbld', 08:58:56 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576', 08:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:56 INFO - '_': '/tools/buildbot/bin/python'} 08:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:58:56 INFO - Cleaning up... 08:58:56 INFO - Return code: 0 08:58:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:58:56 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')]} 08:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:56 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')]} 08:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:56 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 0xaee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbfea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe60630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee9850>, '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 0xe5e6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5eb60>, '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': '523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576', '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 08:58:56 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 08:58:56 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 08:58:56 INFO - Using env: {'DISPLAY': ':0', 08:58:56 INFO - 'HOME': '/home/cltbld', 08:58:56 INFO - 'LANG': 'en_US.UTF-8', 08:58:56 INFO - 'LANGUAGE': 'en_US:en', 08:58:56 INFO - 'LOGNAME': 'cltbld', 08:58:56 INFO - 'MAIL': '/var/mail/cltbld', 08:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:56 INFO - 'MOZ_NO_REMOTE': '1', 08:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:56 INFO - 'NO_EM_RESTART': '1', 08:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:56 INFO - 'PWD': '/builds/slave/test', 08:58:56 INFO - 'SHELL': '/bin/bash', 08:58:56 INFO - 'SHLVL': '1', 08:58:56 INFO - 'TERM': 'linux', 08:58:56 INFO - 'TMOUT': '86400', 08:58:56 INFO - 'USER': 'cltbld', 08:58:56 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576', 08:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:56 INFO - '_': '/tools/buildbot/bin/python'} 08:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:57 INFO - Downloading/unpacking blobuploader==1.2.4 08:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:59 INFO - Downloading blobuploader-1.2.4.tar.gz 08:58:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:58:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:58:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:59 INFO - Downloading docopt-0.6.1.tar.gz 08:58:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:58:59 INFO - Installing collected packages: blobuploader, requests, docopt 08:58:59 INFO - Running setup.py install for blobuploader 08:59:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:59:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:59:00 INFO - Running setup.py install for requests 08:59:00 INFO - Running setup.py install for docopt 08:59:00 INFO - Successfully installed blobuploader requests docopt 08:59:00 INFO - Cleaning up... 08:59:00 INFO - Return code: 0 08:59:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59:00 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')]} 08:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:00 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')]} 08:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:00 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 0xaee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbfea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe60630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee9850>, '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 0xe5e6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5eb60>, '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': '523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576', '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 08:59:00 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 08:59:00 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 08:59:00 INFO - Using env: {'DISPLAY': ':0', 08:59:00 INFO - 'HOME': '/home/cltbld', 08:59:00 INFO - 'LANG': 'en_US.UTF-8', 08:59:00 INFO - 'LANGUAGE': 'en_US:en', 08:59:00 INFO - 'LOGNAME': 'cltbld', 08:59:00 INFO - 'MAIL': '/var/mail/cltbld', 08:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:00 INFO - 'MOZ_NO_REMOTE': '1', 08:59:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:00 INFO - 'NO_EM_RESTART': '1', 08:59:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:00 INFO - 'PWD': '/builds/slave/test', 08:59:00 INFO - 'SHELL': '/bin/bash', 08:59:00 INFO - 'SHLVL': '1', 08:59:00 INFO - 'TERM': 'linux', 08:59:00 INFO - 'TMOUT': '86400', 08:59:00 INFO - 'USER': 'cltbld', 08:59:00 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576', 08:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:00 INFO - '_': '/tools/buildbot/bin/python'} 08:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:59:00 INFO - Running setup.py (path:/tmp/pip-GvRZvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:59:00 INFO - Running setup.py (path:/tmp/pip-RKxI0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:59:00 INFO - Running setup.py (path:/tmp/pip-IY5JTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:59:01 INFO - Running setup.py (path:/tmp/pip-Lx7rTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:59:01 INFO - Running setup.py (path:/tmp/pip-RFEn7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:59:01 INFO - Running setup.py (path:/tmp/pip-hvkifU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:59:01 INFO - Running setup.py (path:/tmp/pip-YoXsgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:59:01 INFO - Running setup.py (path:/tmp/pip-RfdRcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:59:01 INFO - Running setup.py (path:/tmp/pip-Z2bBdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:59:01 INFO - Running setup.py (path:/tmp/pip-6_Leo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:59:01 INFO - Running setup.py (path:/tmp/pip-xml2KP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:59:01 INFO - Running setup.py (path:/tmp/pip-h8nAPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:59:01 INFO - Running setup.py (path:/tmp/pip-Pf8BwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:59:01 INFO - Running setup.py (path:/tmp/pip-5vLZqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:01 INFO - Running setup.py (path:/tmp/pip-AH4W7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:59:01 INFO - Running setup.py (path:/tmp/pip-XiQ6og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:59:01 INFO - Running setup.py (path:/tmp/pip-QvFkSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:59:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:59:02 INFO - Running setup.py install for manifestparser 08:59:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:59:02 INFO - Running setup.py install for mozcrash 08:59:02 INFO - Running setup.py install for mozdebug 08:59:02 INFO - Running setup.py install for mozdevice 08:59:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:59:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:59:02 INFO - Running setup.py install for mozfile 08:59:02 INFO - Running setup.py install for mozhttpd 08:59:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:59:02 INFO - Running setup.py install for mozinfo 08:59:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:59:02 INFO - Running setup.py install for mozInstall 08:59:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:59:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:59:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:59:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:59:02 INFO - Running setup.py install for mozleak 08:59:02 INFO - Running setup.py install for mozlog 08:59:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:59:03 INFO - Running setup.py install for moznetwork 08:59:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:59:03 INFO - Running setup.py install for mozprocess 08:59:03 INFO - Running setup.py install for mozprofile 08:59:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:59:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:59:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:59:03 INFO - Running setup.py install for mozrunner 08:59:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:59:03 INFO - Running setup.py install for mozscreenshot 08:59:03 INFO - Running setup.py install for moztest 08:59:03 INFO - Running setup.py install for mozversion 08:59:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:59:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:59:03 INFO - Cleaning up... 08:59:03 INFO - Return code: 0 08:59:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59: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')]} 08:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59: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')]} 08:59:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:03 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 0xaee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbfea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe60630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee9850>, '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 0xe5e6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5eb60>, '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': '523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576', '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 08:59:03 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 08:59:03 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 08:59:03 INFO - Using env: {'DISPLAY': ':0', 08:59:03 INFO - 'HOME': '/home/cltbld', 08:59:03 INFO - 'LANG': 'en_US.UTF-8', 08:59:03 INFO - 'LANGUAGE': 'en_US:en', 08:59:03 INFO - 'LOGNAME': 'cltbld', 08:59:03 INFO - 'MAIL': '/var/mail/cltbld', 08:59:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:03 INFO - 'MOZ_NO_REMOTE': '1', 08:59:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:03 INFO - 'NO_EM_RESTART': '1', 08:59:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:03 INFO - 'PWD': '/builds/slave/test', 08:59:03 INFO - 'SHELL': '/bin/bash', 08:59:03 INFO - 'SHLVL': '1', 08:59:03 INFO - 'TERM': 'linux', 08:59:03 INFO - 'TMOUT': '86400', 08:59:03 INFO - 'USER': 'cltbld', 08:59:03 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576', 08:59:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:03 INFO - '_': '/tools/buildbot/bin/python'} 08:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:59:04 INFO - Running setup.py (path:/tmp/pip-ySSBgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:59:04 INFO - Running setup.py (path:/tmp/pip-fAgfCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:59:04 INFO - Running setup.py (path:/tmp/pip-gPFwSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:59:04 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)) 08:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:59:04 INFO - Running setup.py (path:/tmp/pip-0MBd4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:59:04 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)) 08:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:59:04 INFO - Running setup.py (path:/tmp/pip-WmDhrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:59:04 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)) 08:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:59:04 INFO - Running setup.py (path:/tmp/pip-gvlzgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:59:04 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)) 08:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:59:04 INFO - Running setup.py (path:/tmp/pip-IR_2e2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:59:04 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)) 08:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:59:04 INFO - Running setup.py (path:/tmp/pip-WLyoN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:59:04 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)) 08:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:59:04 INFO - Running setup.py (path:/tmp/pip-S7Bnoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:59:04 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)) 08:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:59:04 INFO - Running setup.py (path:/tmp/pip-jYYBR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:59:04 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)) 08:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:59:04 INFO - Running setup.py (path:/tmp/pip-vVzSR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:59:04 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)) 08:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:59:04 INFO - Running setup.py (path:/tmp/pip-t7qOeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 08:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:59:04 INFO - Running setup.py (path:/tmp/pip-rR2duA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:59:05 INFO - Running setup.py (path:/tmp/pip-ZZb4J2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:05 INFO - Running setup.py (path:/tmp/pip-l9Tfuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:59:05 INFO - Running setup.py (path:/tmp/pip-RH00pG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:59:05 INFO - Running setup.py (path:/tmp/pip-fdJAdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:59:05 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)) 08:59:05 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)) 08:59:05 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)) 08:59:05 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)) 08:59:05 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)) 08:59:05 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)) 08:59:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:59:05 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 08:59:05 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 08:59:05 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 08:59:05 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 08:59:05 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 08:59:05 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 08:59:07 INFO - Downloading blessings-1.6.tar.gz 08:59:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:59:07 INFO - Installing collected packages: blessings 08:59:07 INFO - Running setup.py install for blessings 08:59:07 INFO - Successfully installed blessings 08:59:07 INFO - Cleaning up... 08:59:07 INFO - Return code: 0 08:59:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:59:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:59:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:59:07 INFO - Reading from file tmpfile_stdout 08:59:07 INFO - Current package versions: 08:59:07 INFO - argparse == 1.2.1 08:59:07 INFO - blessings == 1.6 08:59:07 INFO - blobuploader == 1.2.4 08:59:07 INFO - docopt == 0.6.1 08:59:07 INFO - functools32 == 3.2.3-2 08:59:07 INFO - jsonschema == 2.5.1 08:59:07 INFO - manifestparser == 1.1 08:59:07 INFO - mozInstall == 1.12 08:59:07 INFO - mozcrash == 1.0 08:59:07 INFO - mozdebug == 0.1 08:59:07 INFO - mozdevice == 0.49 08:59:07 INFO - mozfile == 1.2 08:59:07 INFO - mozhttpd == 0.7 08:59:07 INFO - mozinfo == 0.9 08:59:07 INFO - mozleak == 0.1 08:59:07 INFO - mozlog == 3.4 08:59:07 INFO - moznetwork == 0.27 08:59:07 INFO - mozprocess == 0.24 08:59:07 INFO - mozprofile == 0.28 08:59:07 INFO - mozrunner == 6.13 08:59:07 INFO - mozscreenshot == 0.1 08:59:07 INFO - mozsystemmonitor == 0.3 08:59:07 INFO - moztest == 0.8 08:59:07 INFO - mozversion == 1.4 08:59:07 INFO - psutil == 3.1.1 08:59:07 INFO - requests == 1.2.3 08:59:07 INFO - wsgiref == 0.1.2 08:59:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59:07 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')]} 08:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:07 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')]} 08:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:07 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 0xaee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbfea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe60630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee9850>, '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 0xe5e6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5eb60>, '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': '523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576', '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 08:59:07 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 08:59:07 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 08:59:07 INFO - Using env: {'DISPLAY': ':0', 08:59:07 INFO - 'HOME': '/home/cltbld', 08:59:07 INFO - 'LANG': 'en_US.UTF-8', 08:59:07 INFO - 'LANGUAGE': 'en_US:en', 08:59:07 INFO - 'LOGNAME': 'cltbld', 08:59:07 INFO - 'MAIL': '/var/mail/cltbld', 08:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:07 INFO - 'MOZ_NO_REMOTE': '1', 08:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:07 INFO - 'NO_EM_RESTART': '1', 08:59:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:07 INFO - 'PWD': '/builds/slave/test', 08:59:07 INFO - 'SHELL': '/bin/bash', 08:59:07 INFO - 'SHLVL': '1', 08:59:07 INFO - 'TERM': 'linux', 08:59:07 INFO - 'TMOUT': '86400', 08:59:07 INFO - 'USER': 'cltbld', 08:59:07 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576', 08:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:07 INFO - '_': '/tools/buildbot/bin/python'} 08:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:07 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)) 08:59:07 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)) 08:59:07 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)) 08:59:07 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)) 08:59:07 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)) 08:59:07 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)) 08:59:07 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)) 08:59:07 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)) 08:59:07 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)) 08:59:07 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)) 08:59:07 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)) 08:59:07 INFO - Cleaning up... 08:59:07 INFO - Return code: 0 08:59:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:59:07 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')]} 08:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:07 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')]} 08:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xaee1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbfea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe60630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee9850>, '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 0xe5e6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5eb60>, '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': '523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576', '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 08:59:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:59:08 INFO - Using env: {'DISPLAY': ':0', 08:59:08 INFO - 'HOME': '/home/cltbld', 08:59:08 INFO - 'LANG': 'en_US.UTF-8', 08:59:08 INFO - 'LANGUAGE': 'en_US:en', 08:59:08 INFO - 'LOGNAME': 'cltbld', 08:59:08 INFO - 'MAIL': '/var/mail/cltbld', 08:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:08 INFO - 'MOZ_NO_REMOTE': '1', 08:59:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:08 INFO - 'NO_EM_RESTART': '1', 08:59:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:08 INFO - 'PWD': '/builds/slave/test', 08:59:08 INFO - 'SHELL': '/bin/bash', 08:59:08 INFO - 'SHLVL': '1', 08:59:08 INFO - 'TERM': 'linux', 08:59:08 INFO - 'TMOUT': '86400', 08:59:08 INFO - 'USER': 'cltbld', 08:59:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576', 08:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:08 INFO - '_': '/tools/buildbot/bin/python'} 08:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:59:08 INFO - Cleaning up... 08:59:08 INFO - Return code: 0 08:59:08 INFO - Running post-action listener: _resource_record_post_action 08:59:08 INFO - Running post-action listener: _start_resource_monitoring 08:59:08 INFO - Starting resource monitoring. 08:59:08 INFO - [mozharness: 2017-03-04 16:59:08.263449Z] Finished create-virtualenv step (success) 08:59:08 INFO - [mozharness: 2017-03-04 16:59:08.263949Z] Running install step. 08:59:08 INFO - Running pre-action listener: _resource_record_pre_action 08:59:08 INFO - Running main action method: install 08:59:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:59:08 INFO - Reading from file tmpfile_stdout 08:59:08 INFO - Detecting whether we're running mozinstall >=1.0... 08:59:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:59:08 INFO - Reading from file tmpfile_stdout 08:59:08 INFO - Output received: 08:59:08 INFO - Usage: mozinstall [options] installer 08:59:08 INFO - Options: 08:59:08 INFO - -h, --help show this help message and exit 08:59:08 INFO - -d DEST, --destination=DEST 08:59:08 INFO - Directory to install application into. [default: 08:59:08 INFO - "/builds/slave/test"] 08:59:08 INFO - --app=APP Application being installed. [default: firefox] 08:59:08 INFO - mkdir: /builds/slave/test/build/application 08:59:08 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'] 08:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:59:25 INFO - Reading from file tmpfile_stdout 08:59:25 INFO - Output received: 08:59:25 INFO - /builds/slave/test/build/application/firefox/firefox 08:59:25 INFO - Running post-action listener: _resource_record_post_action 08:59:25 INFO - [mozharness: 2017-03-04 16:59:25.036715Z] Finished install step (success) 08:59:25 INFO - [mozharness: 2017-03-04 16:59:25.036856Z] Running run-tests step. 08:59:25 INFO - Running pre-action listener: _resource_record_pre_action 08:59:25 INFO - Running main action method: run_tests 08:59:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:59:25 INFO - Python 2.7.3 08:59:25 INFO - Return code: 0 08:59:25 INFO - grabbing minidump binary from tooltool 08:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee9850>, '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 0xe5e6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5eb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:59:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:59:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:59:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:59:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:59:25 INFO - Return code: 0 08:59:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:59:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:59:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:59:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:59:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:59:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I1PELWSkTSyEA_5hYT6m6Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 08:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I1PELWSkTSyEA_5hYT6m6Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 08:59:25 INFO - Using env: {'DISPLAY': ':0', 08:59:25 INFO - 'HOME': '/home/cltbld', 08:59:25 INFO - 'LANG': 'en_US.UTF-8', 08:59:25 INFO - 'LANGUAGE': 'en_US:en', 08:59:25 INFO - 'LOGNAME': 'cltbld', 08:59:25 INFO - 'MAIL': '/var/mail/cltbld', 08:59:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:59:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:25 INFO - 'MOZ_NO_REMOTE': '1', 08:59:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:59:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:25 INFO - 'NO_EM_RESTART': '1', 08:59:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:25 INFO - 'PWD': '/builds/slave/test', 08:59:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:59:25 INFO - 'SHELL': '/bin/bash', 08:59:25 INFO - 'SHLVL': '1', 08:59:25 INFO - 'TERM': 'linux', 08:59:25 INFO - 'TMOUT': '86400', 08:59:25 INFO - 'USER': 'cltbld', 08:59:25 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576', 08:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:25 INFO - '_': '/tools/buildbot/bin/python'} 08:59:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I1PELWSkTSyEA_5hYT6m6Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 08:59:25 INFO - mozversion application_buildid: 20170304160019 08:59:25 INFO - mozversion application_changeset: 14cf0c8a70e142e1416aa091f11b94619de1dcba 08:59:25 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:59:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:59:25 INFO - mozversion application_name: Firefox 08:59:25 INFO - mozversion application_remotingname: firefox-dev 08:59:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:59:25 INFO - mozversion application_vendor: Mozilla 08:59:25 INFO - mozversion application_version: 53.0a2 08:59:25 INFO - mozversion platform_buildid: 20170304160019 08:59:25 INFO - mozversion platform_changeset: 14cf0c8a70e142e1416aa091f11b94619de1dcba 08:59:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:59:25 INFO - mozversion platform_version: 53.0a2 08:59:25 INFO - using testdate: 1488646765 08:59:25 INFO - actual date: 1488646765 08:59:25 INFO - starting webserver on 'localhost:49806' 08:59:25 INFO - SUITE-START | Running 2 tests 08:59:25 INFO - TEST-START | dromaeo_css 08:59:25 INFO - operating with platform_type : linux_ 08:59:25 INFO - Initialising browser for dromaeo_css test... 08:59:25 INFO - TEST-INFO | started process 28477 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbH6oG_/profile http://localhost:49806/getInfo.html) 08:59:29 INFO - PROCESS | 28477 | __metrics Screen width/height:1600/1200 08:59:29 INFO - PROCESS | 28477 | colorDepth:24 08:59:29 INFO - PROCESS | 28477 | Browser inner width/height: 1024/697 08:59:29 INFO - PROCESS | 28477 | __metrics 08:59:30 INFO - PROCESS | 28477 | 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" 08:59:30 INFO - PROCESS | 28477 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:59:30 INFO - PROCESS | 28477 | console.error: PushService: 08:59:30 INFO - PROCESS | 28477 | stateChangeProcessEnqueue: Error transitioning state 08:59:30 INFO - PROCESS | 28477 | UnknownError 08:59:31 INFO - TEST-INFO | 28477: exit 0 08:59:31 INFO - Browser initialized. 08:59:31 INFO - Running cycle 1/1 for dromaeo_css test... 08:59:31 INFO - TEST-INFO | started process 28568 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbH6oG_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:59:42 INFO - PROCESS | 28568 | RSS: Main: 138076160 08:59:42 INFO - PROCESS | 28568 | 09:02:43 INFO - PROCESS | 28568 | Cycle 1(1): loaded http://localhost:49806/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49806/tests/dromaeo/cssquery-ext.html) 09:02:44 INFO - PROCESS | 28568 | RSS: Main: 239194112 09:02:44 INFO - PROCESS | 28568 | 09:04:33 INFO - PROCESS | 28568 | ************************* 09:04:33 INFO - PROCESS | 28568 | A coding exception was thrown and uncaught in a Task. 09:04:33 INFO - PROCESS | 28568 | 09:04:33 ERROR - PROCESS | 28568 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:04:33 INFO - PROCESS | 28568 | Full stack: 09:04:33 INFO - PROCESS | 28568 | ************************* 09:05:46 INFO - PROCESS | 28568 | Cycle 1(1): loaded http://localhost:49806/tests/dromaeo/cssquery-ext.html (next: http://localhost:49806/tests/dromaeo/cssquery-jquery.html) 09:05:47 INFO - PROCESS | 28568 | RSS: Main: 227794944 09:05:47 INFO - PROCESS | 28568 | 09:08:49 INFO - PROCESS | 28568 | Cycle 1(1): loaded http://localhost:49806/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49806/tests/dromaeo/cssquery-mootools.html) 09:08:49 INFO - PROCESS | 28568 | RSS: Main: 188166144 09:08:49 INFO - PROCESS | 28568 | 09:11:51 INFO - PROCESS | 28568 | Cycle 1(1): loaded http://localhost:49806/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49806/tests/dromaeo/cssquery-prototype.html) 09:11:52 INFO - PROCESS | 28568 | RSS: Main: 171216896 09:11:52 INFO - PROCESS | 28568 | 09:14:55 INFO - PROCESS | 28568 | Cycle 1(1): loaded http://localhost:49806/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49806/tests/dromaeo/cssquery-yui.html) 09:14:55 INFO - PROCESS | 28568 | RSS: Main: 171110400 09:14:55 INFO - PROCESS | 28568 | 09:17:58 INFO - PROCESS | 28568 | Cycle 1(1): loaded http://localhost:49806/tests/dromaeo/cssquery-yui.html (next: http://localhost:49806/tests/dromaeo/cssquery-dojo.html) 09:17:58 INFO - PROCESS | 28568 | RSS: Main: 262991872 09:17:58 INFO - PROCESS | 28568 | 09:17:58 INFO - PROCESS | 28568 | __start_tp_report 09:17:58 INFO - PROCESS | 28568 | _x_x_mozilla_page_load 09:17:58 INFO - PROCESS | 28568 | _x_x_mozilla_page_load_details 09:17:58 INFO - PROCESS | 28568 | |i|pagename|runs| 09:17:58 INFO - PROCESS | 28568 | |0;dojo.html;3233.3371658809942;3282.5404443377947;3309.2554175310574;3310.337932413518;3320.63473017968;5350;5407.486288802567;5422.837314880555;5441.91837122443;5443.564514838813;5512.448755124486;5573.386927437979;5580.972095139518;5587.273654424929;5589.329280486337;5023.7236951967625;5046.041252162077;5077.314562534066;5106.5659418949435;5140.0490909181735;4971.453140154598;5105.157648987913;5143.562797162245;5150.2532132840715;5154.994776018678;4952.380952380952;4982.377202849644;5037.823676171335;5045.596352291808;5135.35808023997;5100.617453690969;5128.538431541179;5130.102232109384;5131.7434128293435;5136.04983078128;4982.451930287665;5039;5098.5411312982005;5106.08090543702;5133.614978876599;5345.037893179227;5383.676979381211;5391.353037635469;5444.128939369682;5468.507834294893;5863.677497737623;5912.231409916683;5914.408559144094;5919.5560332974765;5939.049752039696;5949.286085669704;5954.583179177459;5959.642421454727;5967.910481342783;5972.790952316648;5369.677819330814;5404.540614047772;5487.6981766002455;5546.389897111315;5572.749226284827;5995.310539288038;6001.969990150022;6006.399360064046;6030.216071910623;6042.667653279112;5745.8563535911935;5792.4497172768515;5798.333191682926;5803.390643982406;5808.535317174616;5735.741891614887;5767.163761254595;5800.4489573490455;5865.912011319833;5873.530117590582;5818.301803783573;5853.356130825606;5895.086261629454;5926.259217597801;5935.317438494629;5904.0553511437965;5908.113782932594;5909.409059094056;5912.320083190402;5913.704314784243;4409.4488188976375;4430.18041662287;4537.228671125917;4549.408576884984;4563.1101935123;3947.4473573699706;3994.72036957416;4014.3777714454304;4021.3364794809113;4070.5929407059057;5657.773689052392;5657.773689052392;5659.151127330851;5660.943390566124;5682.488576028178;5641.069223578145;5737.540996720252;5813.186153938452;5911.261092363455;5916.822495325147;5599.132134519156;5679.091345384719;5701.914471282934;5707.800226992035;5713.971430142823;5027.296178535008;5029.698218106925;5034.748262586856;5035.395752509722;5059.772310246048;5913.556483263858;6077.756889724362;6126.203593532812;6143.56995010345;6144.631322120687;5747.48272655463;5852.795152169653;5890.64656120617;5902.822915312548;5995.160677505066;6163.3836616338;6163.84590385244;6168.414000669929;6171.074338849208;6172.660503672341;5810.738516766671;5868.2077919480325;5870.442307980735;5871.060630299132;5876;5740.655560666373;5776.913346299725;5886.558508111823;5917;5934.465898069195;5822.912656310244;5866.472017518444;5868.38381969887;5871.559633027626;5896.557758168069;5836.678982655825;5846.707664616837;5850.6782126981725;5853.736581853912;5857.209276747755;5609.5512359012;5613.438656134354;5634.802781902614;5645.604807663424;5834.03738383162;5743.62666426681;5747.798827041033;5762.567807414377;5775.393583673654;5787.392323806108;5636.4927156556105;5640.689762063126;5640.887182256414;5646.830595082154;5647.971760141173 09:17:58 INFO - PROCESS | 28568 | |1;ext.html;574.8016934157714;610.3103493052851;612.9724162412691;637.9681015949203;645.7772068636319;38417.807910960444;38976.610233897656;38995;38998.220035599305;39039;47420;48334.27498587524;48614.02771944559;53925.1911221332;54384.184237236375;9178.265738740902;9334.71995840126;9355.906440935605;9359.578818953163;9363.6722714705;8576.828463430727;8675.219230269275;9239.168474837263;9242.214411775007;9246.121618446237;10994.450277486134;11319.660410187666;11334.036606888425;11780.116491263147;11780.823287650692;11245.943770281137;11320;11337.206395552274;11341.659750207507;11353.148513861493;11203.607873724462;11300.717482062932;11311.377874216998;11315.321080735182;11321.20751547392;47758;48069.75965120152;48146.11123332611;48168.518314816756;48190.51809481895;4436.9556304436865;4448.399466072071;4485.34962430449;4578.038611891507;4628.537146285378;34805.30389392198;35264.823675881715;35405;36013.45979810305;37189;4467.553244675539;4537.568930951555;4555.202839503074;4573.794179261941;4574.5425457453985;372655;373224;373501.99999999726;373944;374066;63710.6814465934;63860.68069659622;64109.679451602446;64131;64176.358236417036;68693.65653171802;68740;68801.3119868805;68946;68974;16702.49892503227;17011.744823827652;17052;17078.23147958345;17088.060156691503;13934.860651393356;13953.232572208626;13955.651108722363;13955.79066314006;13967.161970281815;16050.357985680443;16231.837681623269;17350.219240134225;17929.37247196342;17974.820251797315;6410.903836442457;6481.578697384655;6517.446017088506;6561.737530498822;6763.797086087426;974.3666616699202;978.6672531339378;979.5885727994117;995.581855620641;1012.6253286284121;33625.83187084049;33976.32047359039;34010.14974625654;34387.312253755284;34595.30809383849;1110.5890820396344;1185.8043422835135;1190.3691043746828;1209.5041033176356;1209.6915286601861;18082.186301616457;18169.7274540882;18300.542486437946;18306.359277425494;18317.17572709231;541160;543462;544584;546806;549483;61022;61851.38148618546;66029;66639.66680166568;66643.66678166675;1518.2257048905137;1528.824185218714;1547.048565132458;1559.7114533811055;1561.7423125184218;33791.662083378855;34522;35242.29515409626;35795.46306805452;36309.27381452409;57006;57516;57859.1321130175;57888.13167802402;58020.70989645025;461662;462910;464902;466210;467777;44166;44781.32828007518;44835.77582112069;45040.54959450364;45104.548954510035;46391.304130438744;51289.48710512847;51291.743541282056;56532.152017718945;56866;43348.83349233057;44579.77710111429;45151.32273015973;45244.54755452403;46980.53019469762;43984.560154398045;44719.329210062526;45176.32235516536;45760.313595296764;46004.309935351666;44007;44186.779066104464;44231.55768442275;44352.778236108614;44388;36865.44701829421;39021.80489097536;39068;39431.21137577175;39744;28676.638672166344;28762;29056.854715726287;29460.705392946653;29508.409831802815 09:17:58 INFO - PROCESS | 28568 | |2;jquery.html;440.79282737113544;444.4666400319615;452.71931402530424;453.13451308001726;465.8742139622302;19862.304819331326;20522.17911283549;21664;21846.563068738637;21868.671969920462;21656.350309490703;22104.22635207768;22331.44171395716;22484.887575562097;22819.973101210442;5901.203337549418;5952.285725712921;6120.387961203888;6130.080487926824;6131.87736245277;6125.356837532062;6154.876902461948;6155.938440615604;6179.258488981329;6195.969020154893;5904.084866845646;5994.430529099728;6226;6230.190075290206;6232.158658581079;5985.700714964256;5987.970060149715;6007.579469437142;6019.699015049252;6023.036314189731;5382.461753824626;5402.8919421611345;5443.374011988632;5448.45515448456;5448.536874365644;25867.74132258672;25953.22140335793;25964.480710385877;26036.73963260381;26313.210603681728;2502.8998840046374;2547.8598677072755;2564.9358766030814;2574.858382788946;2621.9606705899428;15124.470643527533;15433.691326173526;15682;15894.364225430969;16435.424760133337;2035.8574899757023;2053.37372101509;2068.214078650118;2109.1985045682695;2212.61279276126;97104.51447742716;97362.51318743361;97649.51175244078;98848.50575747147;99216;12248.142630015813;12386.81419778704;12703.555375561811;12709.809352859715;12844.678883027813;18157.09214539268;18171.273149074153;18175.45473635793;18209.362672306404;18222.27110915575;7212.2427145149;7215.927840721631;7227.060482137288;7962.964814574184;8979.326550508738;8696.304295656459;8789.208971192624;8808.515531645693;8885.42244754089;8955.149260820212;5008.924866127011;5119.539241468286;5141.794328226829;5185.974070129625;5430.782768689208;2139.4437446263773;2145.463634091477;2172.0894002037344;2214.2360885494477;2265.7054582904116;939.6476321379482;955.7419496735981;956.6030097509595;974.8440249560036;976.1605019683067;19997;21378.14487420517;21386.144554217968;21387.3691722168;21405.67891481629;955.2214944819949;961.3174646001418;970.4779802921355;981.3326937682302;990.4997976022207;11508.367039812723;11660.30038197711;11807.169888667271;11907.583234586747;12081.758364832654;591794;605077;649369;677725;680543;102912.48543757384;105671.47164264283;109146.45426772816;110741;113587.43206284082;1057.9314891959177;1073.431081526792;1081.6106201767357;1082.767205050918;1094.4363652718855;17953.551161220552;18070.909645451688;18331.26674933041;18381.908090459463;18701.71947420817;44854.3271850929;44929.55070449254;45359.77320113379;45620.54379456296;46814.063718726116;63328;63559.364406355344;64139;64313.67843160941;64917.35082649113;8400.705975290835;8591.269742071994;8645.52449615252;8648.913510864812;9280.95359523198;10647.574097036031;14084.718305634035;14281.500147494788;14526.346314415665;14785.11289322644;11971.700707482034;11991.280523168638;12246.938765306117;12309.75380492403;12364.938175309066;11837.704057398634;12187;12304.692382690504;12521.812172817234;12690.555830546256;12591.87408125907;12754.61736147917;12862.163959342613;12950.093493455368;12950.222986620833;8686.869696954423;8831.955840220759;8925.464472131693;8935.865962010705;9020.323475739215;12414.379281036092;12638.178518396275;12711.80932286035;12712.6821829455;12737.93631031839 09:17:58 INFO - PROCESS | 28568 | |3;mootools.html;1334.1528129637677;1456.5193486149572;1472.6392033951684;1476.8449312822156;1491.060631801965;7405.444591655621;8001.9197408349855;8294.253517183452;8297.377696672744;8523;8304.377171712116;8370.623321950512;8371.958140209306;8383.706570270042;8389.454685445442;2117.587070521249;2187.639039558471;2395.1616934073068;2437.524682686877;2438.1344622658967;2374.7031621047367;2438.2685194441683;2442.584760590695;2443.621238707994;2448.3879030242438;2181.1929586053184;2202.6365649667787;2211.1708109458955;2213.4798322394226;2217.36805010572;2358.9174378896655;2367.254314890804;2387.367347652882;2391.091385273602;2393.5811233034237;2324.6048171810835;2337.1936681844736;2337.415646088478;2340.9531809363716;2342.1919437793936;8206.876896846552;8418.368622353348;8423.747287581382;8426.83146337076;8431.325493960469;5097.617678674114;5228.973855130738;5235.083860324428;5235.685858848481;5236.842894713165;3172.6510083890753;3300.2574420755377;3403.2002479417315;3456.6888979991922;3477.8261086945804;1382.4815694114707;1402.964925876851;1433.1114708880561;1444.5738507140313;1514.8863835212403;11110.666679999613;11155.665330040112;11158;11158.553657853676;11160.218784685076;4534.251848445036;4626.930596041062;4653.092646933816;4676.368690226844;4681.64887633422;9682.273829462678;9682.515874206261;9683.951580242054;9691.9030809691;9694.854577181348;5347.705876176769;5349.384820745586;5351.063563876306;5352.785888564414;5354.143337066051;4258.957410425918;4747.620190384761;4856.053069651384;4870.001649661811;4938.209886418156;3975.6223158799867;4065.288574499451;4096.651784598283;4117.135401565645;4144.254034273859;1244.6079484962208;1249.2816630437535;1249.5688987299368;1252.2549083295426;1254.4793910527212;1035.3115178406276;1039.948002599882;1046.7121541575975;1048.826943554305;1057.6932689520106;5845.181674565564;5931.436513531207;5940.613860099166;6040.268456375895;6043;656.1994366872408;657.2572992518424;662.3343539742527;671.1878626861454;673.182083768224;4052;4069.206504731608;4083.97958010214;4103.753774773523;4105.774182419996;9754.414735115915;10046.949765251273;10091.142252908585;10107.898921010843;10118;9931.751706207402;9997.300188986701;10024.248181386425;10031.047050530187;10032.64885728996;7327.5969821659255;7634.847303054019;7902;7960.721374751972;7975.04299484054;5702.486776190163;5885.117232415172;5891.23413956183;6007.189029480965;6011.789587364421;8506.447080939719;8698.434601750865;8860.468371897707;8890.24432923183;8906.153915378029;8859.335549833659;8909.73270801877;8952.194302512806;8971.910280897107;8973.551322433983;6725.260221375743;6888.931110689029;6945.20130185015;7172.426205903619;7300.45246606496;7614.6954121836725;7847.254510821463;7847.8038049046945;7848.097468790934;7850.882236766567;6935.3411425914455;7036.788896333118;7050.894236586558;7102.644867756695;7194.496385252982;7037.577745335297;7045.647717614202;7058.71765129389;7167;7306.0502134724275;6376.52176086786;6466.450351719968;6501.08984742127;6514.6416947068365;6515.185601799775;5143.699117415094;5191.610629202901;5246.868828279324;5367.677939323653;5430.266913966564;5129.769160387867;5137.255098010843;5144.562712169358;5264.420913699413;5361.490658387447 09:17:58 INFO - PROCESS | 28568 | |4;prototype.html;405.1026975249821;413.3980824305815;416.1323640210161;430.3634290247408;432.21984318305465;5122.718250496221;5246.449122842104;5323.520883120518;5437.564994800417;5444.183372494128;5148.433672296044;5259.948010397926;5262.158054711237;5275.894482110355;5297.761600727967;4145.419641250227;4277.721948073366;4286.314189729644;4298.26929421999;4303.376010478479;4252.9149417011795;4267.871963841089;4301.677374196932;4303.591158839921;4330.765731766447;4255.212785634652;4274.893127671802;4289.2922667759785;4290.806913688876;4294.592013758688;4228.957710422918;4311.913761724763;4318.244307246219;4322.2220000400075;4327.32926396409;3914.745541539791;3929.2730844793805;3933.6656384207377;3941.7043721720697;3948.8420463181437;5185.55922746567;5192.818251361185;5198.2722418861385;5203.427622961509;5209.296744939423;4816.397950256218;4896.485868983741;4905.8282960096585;4906.730129842857;4918;5517.034518959166;5536.252605898233;5537.335519737617;5577.972110139423;5582.665040097607;4277.230098582254;4278.914421711579;4286.849960251377;4299.591538803808;4300.677449191323;5508.889822203533;5758.481736643722;5769.596128271022;5783;5790.218320526759;4270.188664153801;4283.201055556674;4293.506246781598;4308.289132293199;4329.783510824446;4331.025519258142;4364.8472303469225;4366.759828209479;4409.691321607456;4435.556444355539;4887.853364399074;4907.828226012072;4911.533404326583;4927;4930.1865192243595;5439;5449.237106805051;5510.448955104538;5522.171674248895;5663.801766938137;1505.7741338799267;1511.871490923262;1515.181801827023;1516.1736853414916;1516.8255650600322;1073.3291692692067;1103.2718405852258;1112.8831472695413;1122.960696375623;1128.785530749155;5324.4675532446445;5333.146696528537;5346.385165705916;5350.8662283442445;5357.571394288448;5534.280543529316;5546.805861794818;5575.526080283222;5606.243816642777;5612.410696876851;5254.553362964114;5371.462853714597;5391.353037635509;5539.667619942736;5550.777968881281;2953.675095739467;2970.985145074261;2974.2861713188677;3004.4591973444553;3012.8493575321145;5629.324481062217;5856.238688970407;5862.325832529314;5868.149118377897;5880.911786323209;5718.771249149988;5724.398938111522;5725.255716756795;5731.770729170787;5755.482006619424;5743.798967036218;5757;5783.681897495594;5804.303483581997;5830.329512106077;5326.813561525328;5564.860878478071;5566.22072909801;5589.496945274945;5626.409227031103;5549.972250138723;5554.250176226319;5566.856760147291;5576.553875690016;5582.8325150245555;5805.448482394335;5811.430913653206;5828.329742079545;5837.6497410155525;5840.591158618856;4016.979915100406;4200.075983283673;4219.514755802999;4229.513605935357;4244.38456423823;5501;5613.831585052455;5632.380438151718;5846.970765146147;5855.180274761622;5616.971915140398;5619.494245517923;5622.7750889963945;5641.548676105984;5642.294713160855;5619.634723743107;5624.831255062355;5635.8591035224445;5639.971800140973;5642.407547207484;5308.6283960123965;5546.251256080377;5549.639273447375;5570.5543556516195;5575.303087114111;5623.3533143689;5631.436856314336;5635.492805647511;5637.661740295595;5656.6888821115235;5239.738013099406;5446.264754258124;5533.280673512418;5537.833864984057;5552.3892371839875 09:17:58 INFO - PROCESS | 28568 | |5;yui.html;723.2044750774146;724.492855001499;762.1616222155629;797.5015615240475;845.2899564365931;15519.61200969975;16275.511734647966;16288.918555407206;16437.506874793744;16462.670746585078;14904.701905961874;14908.701825963475;14956;14961;14966.102033877947;812.5043723328765;829.618375547249;835.1398059998212;836.1513064239801;837.7863644770605;717.2110678253931;737.0160835284901;822.153182222312;842.1914961636836;850.421713235;903.7469508537587;905.995470022649;906.3021473465427;906.3927168796889;907.0657223060225;901.7970956534792;902.1880307723069;902.2195800632471;902.6524787956619;904.1817155474306;546.7867531662655;559.4740943513125;630.571211576128;644;649.3149727037973;16595.751063734053;16626.085565293903;16639.50081497557;16645.167741612993;16645.66708665832;15161;15352.155631440266;15686.177109050172;15953.760693589606;16326.836731632651;12961.22232666043;13321.200727956353;13523.797143042862;13545.39045742944;13647.799054220995;4112.321466957948;4119.97940010301;4136.110736191733;4179.519355274152;4201.936970945439;80183.59908200422;80760;81461.59269203675;83096.99999999939;83341.58329208376;12294;12385.752284954251;12389.380530973416;12427.502899884084;12636.178648387826;23473.178438754563;23864.761352386602;24010.51978960411;24069.879650601986;24255.272341829772;8920.152585504367;8994.28045756338;9074.546272686339;9170.220531254785;9284.907150928539;4721.95278047222;4888.486708895586;4891.437484689235;4917.213245880642;4935.654504184745;3987.2623564640053;4013.2776100302226;4112.588741125864;4119.691023173274;4132.421460995463;739.474972769329;742.0464702856804;746.6826598695533;753.6909866954632;756.837279984806;779.5907148746953;786.2569871471519;787.4999375396665;806.3468590441761;809.7368355284556;10688.412137332365;10876.817899316346;10999.780004399867;11056.944715276533;11177.720556985978;764.4916130773084;775.9418043646749;776.3595034096893;791.3392317414908;803.3733687723585;5373.2208829719475;5386.730663466811;5766.654000759968;5811.564132690065;5903.3801450847905;81433;84492.57753711315;85347.57326213329;87244.56377718071;87468;74594.62702686452;76879;77316;77633;80371.59814200892;66655.66672166609;68715;69635;70173.64913175402;70276.94584581236;11429.885701142883;11516.445279887108;11644.41777911118;11824.881751182722;12049.879501205227;40000.1999960005;41101;42582.36126458044;43357.34963975606;44450.77774611106;49624.50375496199;51260.74369628128;55388.16917746156;57005.42994570167;57462.425375745705;13567.38946747379;13799.172049677052;13808.1024733392;14079.859201407855;14403.135811851322;14107.435702571782;14745.92627036858;15066.09603423798;15766.763498547301;16813.747793783346;15242.161681107646;15257.237138142826;15514;15917.204139793195;16437.67124657524;14122.576322710334;14174.858251417354;14479.276036198358;15022.774658379914;15207.467738629095;15049.028418509099;15086;15256.23718814077;15299.158546280061;15309.923450382677;12159.452824622736;12903.483860645469;12979.221246725227;13250.668733281746;13331;12013.159078864395;12017.339046352534;12135.150539462506;12414.751704965669;12461.501539938663 09:17:58 INFO - PROCESS | 28568 | __end_tp_report 09:17:58 INFO - PROCESS | 28568 | __start_cc_report 09:17:58 INFO - PROCESS | 28568 | _x_x_mozilla_cycle_collect,895 09:17:58 INFO - PROCESS | 28568 | __end_cc_report 09:17:58 INFO - PROCESS | 28568 | __startTimestamp1488647878360__endTimestamp 09:17:58 INFO - PROCESS | 28568 | 09:17:58 INFO - PROCESS | 28568 | ------- Summary: start ------- 09:17:58 INFO - PROCESS | 28568 | Number of tests: 6 09:17:58 INFO - PROCESS | 28568 | 09:17:58 INFO - PROCESS | 28568 | [#0] dojo.html Cycles:165 Average:5489.84 Median:5701.91 stddev:608.30 (10.7%) stddev-sans-first:583.84 09:17:58 INFO - PROCESS | 28568 | Values: 3233.3 3282.5 3309.3 3310.3 3320.6 5350.0 5407.5 5422.8 5441.9 5443.6 5512.4 5573.4 5581.0 5587.3 5589.3 5023.7 5046.0 5077.3 5106.6 5140.0 4971.5 5105.2 5143.6 5150.3 5155.0 4952.4 4982.4 5037.8 5045.6 5135.4 5100.6 5128.5 5130.1 5131.7 5136.0 4982.5 5039.0 5098.5 5106.1 5133.6 5345.0 5383.7 5391.4 5444.1 5468.5 5863.7 5912.2 5914.4 5919.6 5939.0 5949.3 5954.6 5959.6 5967.9 5972.8 5369.7 5404.5 5487.7 5546.4 5572.7 5995.3 6002.0 6006.4 6030.2 6042.7 5745.9 5792.4 5798.3 5803.4 5808.5 5735.7 5767.2 5800.4 5865.9 5873.5 5818.3 5853.4 5895.1 5926.3 5935.3 5904.1 5908.1 5909.4 5912.3 5913.7 4409.4 4430.2 4537.2 4549.4 4563.1 3947.4 3994.7 4014.4 4021.3 4070.6 5657.8 5657.8 5659.2 5660.9 5682.5 5641.1 5737.5 5813.2 5911.3 5916.8 5599.1 5679.1 5701.9 5707.8 5714.0 5027.3 5029.7 5034.7 5035.4 5059.8 5913.6 6077.8 6126.2 6143.6 6144.6 5747.5 5852.8 5890.6 5902.8 5995.2 6163.4 6163.8 6168.4 6171.1 6172.7 5810.7 5868.2 5870.4 5871.1 5876.0 5740.7 5776.9 5886.6 5917.0 5934.5 5822.9 5866.5 5868.4 5871.6 5896.6 5836.7 5846.7 5850.7 5853.7 5857.2 5609.6 5613.4 5634.8 5645.6 5834.0 5743.6 5747.8 5762.6 5775.4 5787.4 5636.5 5640.7 5640.9 5646.8 5648.0 09:17:58 INFO - PROCESS | 28568 | 09:17:58 INFO - PROCESS | 28568 | [#1] ext.html Cycles:180 Average:64412.53 Median:24514.09 stddev:123326.14 (503.1%) stddev-sans-first:123578.96 09:17:58 INFO - PROCESS | 28568 | Values: 574.8 610.3 613.0 638.0 645.8 38417.8 38976.6 38995.0 38998.2 39039.0 47420.0 48334.3 48614.0 53925.2 54384.2 9178.3 9334.7 9355.9 9359.6 9363.7 8576.8 8675.2 9239.2 9242.2 9246.1 10994.5 11319.7 11334.0 11780.1 11780.8 11245.9 11320.0 11337.2 11341.7 11353.1 11203.6 11300.7 11311.4 11315.3 11321.2 47758.0 48069.8 48146.1 48168.5 48190.5 4437.0 4448.4 4485.3 4578.0 4628.5 34805.3 35264.8 35405.0 36013.5 37189.0 4467.6 4537.6 4555.2 4573.8 4574.5 372655.0 373224.0 373502.0 373944.0 374066.0 63710.7 63860.7 64109.7 64131.0 64176.4 68693.7 68740.0 68801.3 68946.0 68974.0 16702.5 17011.7 17052.0 17078.2 17088.1 13934.9 13953.2 13955.7 13955.8 13967.2 16050.4 16231.8 17350.2 17929.4 17974.8 6410.9 6481.6 6517.4 6561.7 6763.8 974.4 978.7 979.6 995.6 1012.6 33625.8 33976.3 34010.1 34387.3 34595.3 1110.6 1185.8 1190.4 1209.5 1209.7 18082.2 18169.7 18300.5 18306.4 18317.2 541160.0 543462.0 544584.0 546806.0 549483.0 61022.0 61851.4 66029.0 66639.7 66643.7 1518.2 1528.8 1547.0 1559.7 1561.7 33791.7 34522.0 35242.3 35795.5 36309.3 57006.0 57516.0 57859.1 57888.1 58020.7 461662.0 462910.0 464902.0 466210.0 467777.0 44166.0 44781.3 44835.8 45040.5 45104.5 46391.3 51289.5 51291.7 56532.2 56866.0 43348.8 44579.8 45151.3 45244.5 46980.5 43984.6 44719.3 45176.3 45760.3 46004.3 44007.0 44186.8 44231.6 44352.8 44388.0 36865.4 39021.8 39068.0 39431.2 39744.0 28676.6 28762.0 29056.9 29460.7 29508.4 09:17:58 INFO - PROCESS | 28568 | 09:17:58 INFO - PROCESS | 28568 | [#2] jquery.html Cycles:180 Average:35195.67 Median:25958.85 stddev:105658.42 (407.0%) stddev-sans-first:105922.59 09:17:58 INFO - PROCESS | 28568 | Values: 440.8 444.5 452.7 453.1 465.9 19862.3 20522.2 21664.0 21846.6 21868.7 21656.4 22104.2 22331.4 22484.9 22820.0 5901.2 5952.3 6120.4 6130.1 6131.9 6125.4 6154.9 6155.9 6179.3 6196.0 5904.1 5994.4 6226.0 6230.2 6232.2 5985.7 5988.0 6007.6 6019.7 6023.0 5382.5 5402.9 5443.4 5448.5 5448.5 25867.7 25953.2 25964.5 26036.7 26313.2 2502.9 2547.9 2564.9 2574.9 2622.0 15124.5 15433.7 15682.0 15894.4 16435.4 2035.9 2053.4 2068.2 2109.2 2212.6 97104.5 97362.5 97649.5 98848.5 99216.0 12248.1 12386.8 12703.6 12709.8 12844.7 18157.1 18171.3 18175.5 18209.4 18222.3 7212.2 7215.9 7227.1 7963.0 8979.3 8696.3 8789.2 8808.5 8885.4 8955.1 5008.9 5119.5 5141.8 5186.0 5430.8 2139.4 2145.5 2172.1 2214.2 2265.7 939.6 955.7 956.6 974.8 976.2 19997.0 21378.1 21386.1 21387.4 21405.7 955.2 961.3 970.5 981.3 990.5 11508.4 11660.3 11807.2 11907.6 12081.8 591794.0 605077.0 649369.0 677725.0 680543.0 102912.5 105671.5 109146.5 110741.0 113587.4 1057.9 1073.4 1081.6 1082.8 1094.4 17953.6 18070.9 18331.3 18381.9 18701.7 44854.3 44929.6 45359.8 45620.5 46814.1 63328.0 63559.4 64139.0 64313.7 64917.4 8400.7 8591.3 8645.5 8648.9 9281.0 10647.6 14084.7 14281.5 14526.3 14785.1 11971.7 11991.3 12246.9 12309.8 12364.9 11837.7 12187.0 12304.7 12521.8 12690.6 12591.9 12754.6 12862.2 12950.1 12950.2 8686.9 8832.0 8925.5 8935.9 9020.3 12414.4 12638.2 12711.8 12712.7 12737.9 09:17:58 INFO - PROCESS | 28568 | 09:17:58 INFO - PROCESS | 28568 | [#3] mootools.html Cycles:180 Average:5498.63 Median:5236.26 stddev:2943.20 (56.2%) stddev-sans-first:2934.81 09:17:58 INFO - PROCESS | 28568 | Values: 1334.2 1456.5 1472.6 1476.8 1491.1 7405.4 8001.9 8294.3 8297.4 8523.0 8304.4 8370.6 8372.0 8383.7 8389.5 2117.6 2187.6 2395.2 2437.5 2438.1 2374.7 2438.3 2442.6 2443.6 2448.4 2181.2 2202.6 2211.2 2213.5 2217.4 2358.9 2367.3 2387.4 2391.1 2393.6 2324.6 2337.2 2337.4 2341.0 2342.2 8206.9 8418.4 8423.7 8426.8 8431.3 5097.6 5229.0 5235.1 5235.7 5236.8 3172.7 3300.3 3403.2 3456.7 3477.8 1382.5 1403.0 1433.1 1444.6 1514.9 11110.7 11155.7 11158.0 11158.6 11160.2 4534.3 4626.9 4653.1 4676.4 4681.6 9682.3 9682.5 9684.0 9691.9 9694.9 5347.7 5349.4 5351.1 5352.8 5354.1 4259.0 4747.6 4856.1 4870.0 4938.2 3975.6 4065.3 4096.7 4117.1 4144.3 1244.6 1249.3 1249.6 1252.3 1254.5 1035.3 1039.9 1046.7 1048.8 1057.7 5845.2 5931.4 5940.6 6040.3 6043.0 656.2 657.3 662.3 671.2 673.2 4052.0 4069.2 4084.0 4103.8 4105.8 9754.4 10046.9 10091.1 10107.9 10118.0 9931.8 9997.3 10024.2 10031.0 10032.6 7327.6 7634.8 7902.0 7960.7 7975.0 5702.5 5885.1 5891.2 6007.2 6011.8 8506.4 8698.4 8860.5 8890.2 8906.2 8859.3 8909.7 8952.2 8971.9 8973.6 6725.3 6888.9 6945.2 7172.4 7300.5 7614.7 7847.3 7847.8 7848.1 7850.9 6935.3 7036.8 7050.9 7102.6 7194.5 7037.6 7045.6 7058.7 7167.0 7306.1 6376.5 6466.5 6501.1 6514.6 6515.2 5143.7 5191.6 5246.9 5367.7 5430.3 5129.8 5137.3 5144.6 5264.4 5361.5 09:17:58 INFO - PROCESS | 28568 | 09:17:58 INFO - PROCESS | 28568 | [#4] prototype.html Cycles:180 Average:4743.19 Median:5323.99 stddev:1321.77 (24.8%) stddev-sans-first:1284.75 09:17:58 INFO - PROCESS | 28568 | Values: 405.1 413.4 416.1 430.4 432.2 5122.7 5246.4 5323.5 5437.6 5444.2 5148.4 5259.9 5262.2 5275.9 5297.8 4145.4 4277.7 4286.3 4298.3 4303.4 4252.9 4267.9 4301.7 4303.6 4330.8 4255.2 4274.9 4289.3 4290.8 4294.6 4229.0 4311.9 4318.2 4322.2 4327.3 3914.7 3929.3 3933.7 3941.7 3948.8 5185.6 5192.8 5198.3 5203.4 5209.3 4816.4 4896.5 4905.8 4906.7 4918.0 5517.0 5536.3 5537.3 5578.0 5582.7 4277.2 4278.9 4286.8 4299.6 4300.7 5508.9 5758.5 5769.6 5783.0 5790.2 4270.2 4283.2 4293.5 4308.3 4329.8 4331.0 4364.8 4366.8 4409.7 4435.6 4887.9 4907.8 4911.5 4927.0 4930.2 5439.0 5449.2 5510.4 5522.2 5663.8 1505.8 1511.9 1515.2 1516.2 1516.8 1073.3 1103.3 1112.9 1123.0 1128.8 5324.5 5333.1 5346.4 5350.9 5357.6 5534.3 5546.8 5575.5 5606.2 5612.4 5254.6 5371.5 5391.4 5539.7 5550.8 2953.7 2971.0 2974.3 3004.5 3012.8 5629.3 5856.2 5862.3 5868.1 5880.9 5718.8 5724.4 5725.3 5731.8 5755.5 5743.8 5757.0 5783.7 5804.3 5830.3 5326.8 5564.9 5566.2 5589.5 5626.4 5550.0 5554.3 5566.9 5576.6 5582.8 5805.4 5811.4 5828.3 5837.6 5840.6 4017.0 4200.1 4219.5 4229.5 4244.4 5501.0 5613.8 5632.4 5847.0 5855.2 5617.0 5619.5 5622.8 5641.5 5642.3 5619.6 5624.8 5635.9 5640.0 5642.4 5308.6 5546.3 5549.6 5570.6 5575.3 5623.4 5631.4 5635.5 5637.7 5656.7 5239.7 5446.3 5533.3 5537.8 5552.4 09:17:58 INFO - PROCESS | 28568 | 09:17:58 INFO - PROCESS | 28568 | [#5] yui.html Cycles:180 Average:18903.98 Median:4190.73 stddev:23853.09 (569.2%) stddev-sans-first:23880.93 09:17:58 INFO - PROCESS | 28568 | Values: 723.2 724.5 762.2 797.5 845.3 15519.6 16275.5 16288.9 16437.5 16462.7 14904.7 14908.7 14956.0 14961.0 14966.1 812.5 829.6 835.1 836.2 837.8 717.2 737.0 822.2 842.2 850.4 903.7 906.0 906.3 906.4 907.1 901.8 902.2 902.2 902.7 904.2 546.8 559.5 630.6 644.0 649.3 16595.8 16626.1 16639.5 16645.2 16645.7 15161.0 15352.2 15686.2 15953.8 16326.8 12961.2 13321.2 13523.8 13545.4 13647.8 4112.3 4120.0 4136.1 4179.5 4201.9 80183.6 80760.0 81461.6 83097.0 83341.6 12294.0 12385.8 12389.4 12427.5 12636.2 23473.2 23864.8 24010.5 24069.9 24255.3 8920.2 8994.3 9074.5 9170.2 9284.9 4722.0 4888.5 4891.4 4917.2 4935.7 3987.3 4013.3 4112.6 4119.7 4132.4 739.5 742.0 746.7 753.7 756.8 779.6 786.3 787.5 806.3 809.7 10688.4 10876.8 10999.8 11056.9 11177.7 764.5 775.9 776.4 791.3 803.4 5373.2 5386.7 5766.7 5811.6 5903.4 81433.0 84492.6 85347.6 87244.6 87468.0 74594.6 76879.0 77316.0 77633.0 80371.6 66655.7 68715.0 69635.0 70173.6 70276.9 11429.9 11516.4 11644.4 11824.9 12049.9 40000.2 41101.0 42582.4 43357.3 44450.8 49624.5 51260.7 55388.2 57005.4 57462.4 13567.4 13799.2 13808.1 14079.9 14403.1 14107.4 14745.9 15066.1 15766.8 16813.7 15242.2 15257.2 15514.0 15917.2 16437.7 14122.6 14174.9 14479.3 15022.8 15207.5 15049.0 15086.0 15256.2 15299.2 15309.9 12159.5 12903.5 12979.2 13250.7 13331.0 12013.2 12017.3 12135.2 12414.8 12461.5 09:17:58 INFO - PROCESS | 28568 | -------- Summary: end -------- 09:17:58 INFO - PROCESS | 28568 | 09:17:59 INFO - TEST-INFO | 28568: exit 0 09:17:59 INFO - TEST-OK | dromaeo_css | took 1113837ms 09:17:59 INFO - TEST-START | kraken 09:17:59 INFO - operating with platform_type : linux_ 09:17:59 INFO - Initialising browser for kraken test... 09:17:59 INFO - TEST-INFO | started process 28887 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe3GtnH/profile http://localhost:49806/getInfo.html) 09:18:03 INFO - PROCESS | 28887 | __metrics Screen width/height:1600/1200 09:18:03 INFO - PROCESS | 28887 | colorDepth:24 09:18:03 INFO - PROCESS | 28887 | Browser inner width/height: 1024/697 09:18:03 INFO - PROCESS | 28887 | __metrics 09:18:03 INFO - PROCESS | 28887 | 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" 09:18:03 INFO - PROCESS | 28887 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:18:04 INFO - PROCESS | 28887 | console.error: PushService: 09:18:04 INFO - PROCESS | 28887 | stateChangeProcessEnqueue: Error transitioning state 09:18:04 INFO - PROCESS | 28887 | UnknownError 09:18:04 INFO - TEST-INFO | 28887: exit 0 09:18:04 INFO - Browser initialized. 09:18:04 INFO - Running cycle 1/1 for kraken test... 09:18:04 INFO - TEST-INFO | started process 28975 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe3GtnH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:18:16 INFO - PROCESS | 28975 | RSS: Main: 138186752 09:18:16 INFO - PROCESS | 28975 | 09:18:19 INFO - PROCESS | 28975 | Cycle 1(1): loaded http://localhost:49806/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49806/tests/kraken/driver.html?testName=audio-beat-detection) 09:18:20 INFO - PROCESS | 28975 | RSS: Main: 181485568 09:18:20 INFO - PROCESS | 28975 | 09:18:22 INFO - PROCESS | 28975 | Cycle 1(1): loaded http://localhost:49806/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49806/tests/kraken/driver.html?testName=audio-dft) 09:18:23 INFO - PROCESS | 28975 | RSS: Main: 171868160 09:18:23 INFO - PROCESS | 28975 | 09:18:26 INFO - PROCESS | 28975 | Cycle 1(1): loaded http://localhost:49806/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49806/tests/kraken/driver.html?testName=audio-fft) 09:18:26 INFO - PROCESS | 28975 | RSS: Main: 263806976 09:18:26 INFO - PROCESS | 28975 | 09:18:28 INFO - PROCESS | 28975 | Cycle 1(1): loaded http://localhost:49806/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49806/tests/kraken/driver.html?testName=audio-oscillator) 09:18:29 INFO - PROCESS | 28975 | RSS: Main: 170291200 09:18:29 INFO - PROCESS | 28975 | 09:18:31 INFO - PROCESS | 28975 | Cycle 1(1): loaded http://localhost:49806/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49806/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:18:31 INFO - PROCESS | 28975 | RSS: Main: 172404736 09:18:31 INFO - PROCESS | 28975 | 09:18:34 INFO - PROCESS | 28975 | Cycle 1(1): loaded http://localhost:49806/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49806/tests/kraken/driver.html?testName=imaging-darkroom) 09:18:35 INFO - PROCESS | 28975 | RSS: Main: 211144704 09:18:35 INFO - PROCESS | 28975 | 09:18:38 INFO - PROCESS | 28975 | Cycle 1(1): loaded http://localhost:49806/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49806/tests/kraken/driver.html?testName=imaging-desaturate) 09:18:39 INFO - PROCESS | 28975 | RSS: Main: 209526784 09:18:39 INFO - PROCESS | 28975 | 09:18:42 INFO - PROCESS | 28975 | Cycle 1(1): loaded http://localhost:49806/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49806/tests/kraken/driver.html?testName=json-parse-financial) 09:18:42 INFO - PROCESS | 28975 | RSS: Main: 208150528 09:18:42 INFO - PROCESS | 28975 | 09:18:44 INFO - PROCESS | 28975 | Cycle 1(1): loaded http://localhost:49806/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49806/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:18:44 INFO - PROCESS | 28975 | RSS: Main: 170287104 09:18:44 INFO - PROCESS | 28975 | 09:18:46 INFO - PROCESS | 28975 | Cycle 1(1): loaded http://localhost:49806/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49806/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:18:47 INFO - PROCESS | 28975 | RSS: Main: 177590272 09:18:47 INFO - PROCESS | 28975 | 09:18:49 INFO - PROCESS | 28975 | Cycle 1(1): loaded http://localhost:49806/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49806/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:18:49 INFO - PROCESS | 28975 | RSS: Main: 186736640 09:18:49 INFO - PROCESS | 28975 | 09:18:52 INFO - PROCESS | 28975 | Cycle 1(1): loaded http://localhost:49806/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49806/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:18:53 INFO - PROCESS | 28975 | RSS: Main: 196788224 09:18:53 INFO - PROCESS | 28975 | 09:18:55 INFO - PROCESS | 28975 | Cycle 1(1): loaded http://localhost:49806/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49806/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:18:56 INFO - PROCESS | 28975 | RSS: Main: 193265664 09:18:56 INFO - PROCESS | 28975 | 09:18:58 INFO - PROCESS | 28975 | Cycle 1(1): loaded http://localhost:49806/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49806/tests/kraken/driver.html?testName=ai-astar) 09:18:58 INFO - PROCESS | 28975 | RSS: Main: 241885184 09:18:58 INFO - PROCESS | 28975 | 09:18:58 INFO - PROCESS | 28975 | __start_tp_report 09:18:58 INFO - PROCESS | 28975 | _x_x_mozilla_page_load 09:18:58 INFO - PROCESS | 28975 | _x_x_mozilla_page_load_details 09:18:58 INFO - PROCESS | 28975 | |i|pagename|runs| 09:18:58 INFO - PROCESS | 28975 | |0;ai-astar;110;112;110;112;112;110;109;110;109;112 09:18:58 INFO - PROCESS | 28975 | |1;audio-beat-detection;141;117;121;151;120;119;117;121;144;117 09:18:58 INFO - PROCESS | 28975 | |2;audio-dft;160;161;163;160;159;160;161;161;160;160 09:18:58 INFO - PROCESS | 28975 | |3;audio-fft;74;74;75;112;75;75;76;76;90;75 09:18:58 INFO - PROCESS | 28975 | |4;audio-oscillator;83;83;108;82;82;84;99;82;81;99 09:18:58 INFO - PROCESS | 28975 | |5;imaging-gaussian-blur;116;117;117;116;117;117;116;117;117;117 09:18:58 INFO - PROCESS | 28975 | |6;imaging-darkroom;146;146;146;147;148;146;146;148;147;146 09:18:58 INFO - PROCESS | 28975 | |7;imaging-desaturate;96;95;96;96;96;95;96;95;96;96 09:18:58 INFO - PROCESS | 28975 | |8;json-parse-financial;47;48;48;48;48;50;48;52;49;48 09:18:58 INFO - PROCESS | 28975 | |9;json-stringify-tinderbox;64;65;64;64;64;64;64;63;64;65 09:18:58 INFO - PROCESS | 28975 | |10;stanford-crypto-aes;78;81;79;86;89;75;84;81;75;75 09:18:58 INFO - PROCESS | 28975 | |11;stanford-crypto-ccm;126;127;129;121;121;128;120;123;156;123 09:18:58 INFO - PROCESS | 28975 | |12;stanford-crypto-pbkdf2;157;154;156;155;157;156;154;156;155;154 09:18:58 INFO - PROCESS | 28975 | |13;stanford-crypto-sha256-iterative;61;61;61;62;62;61;60;60;60;59 09:18:58 INFO - PROCESS | 28975 | __end_tp_report 09:18:58 INFO - PROCESS | 28975 | __start_cc_report 09:18:58 INFO - PROCESS | 28975 | _x_x_mozilla_cycle_collect,1572 09:18:58 INFO - PROCESS | 28975 | __end_cc_report 09:18:58 INFO - PROCESS | 28975 | __startTimestamp1488647938297__endTimestamp 09:18:58 INFO - PROCESS | 28975 | 09:18:58 INFO - PROCESS | 28975 | ------- Summary: start ------- 09:18:58 INFO - PROCESS | 28975 | Number of tests: 14 09:18:58 INFO - PROCESS | 28975 | 09:18:58 INFO - PROCESS | 28975 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.26 (1.1%) stddev-sans-first:1.32 09:18:58 INFO - PROCESS | 28975 | Values: 110.0 112.0 110.0 112.0 112.0 110.0 109.0 110.0 109.0 112.0 09:18:58 INFO - PROCESS | 28975 | 09:18:58 INFO - PROCESS | 28975 | [#1] audio-beat-detection Cycles:10 Average:126.80 Median:121.00 stddev:13.10 (10.8%) stddev-sans-first:12.85 09:18:58 INFO - PROCESS | 28975 | Values: 141.0 117.0 121.0 151.0 120.0 119.0 117.0 121.0 144.0 117.0 09:18:58 INFO - PROCESS | 28975 | 09:18:58 INFO - PROCESS | 28975 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 09:18:58 INFO - PROCESS | 28975 | Values: 160.0 161.0 163.0 160.0 159.0 160.0 161.0 161.0 160.0 160.0 09:18:58 INFO - PROCESS | 28975 | 09:18:58 INFO - PROCESS | 28975 | [#3] audio-fft Cycles:10 Average:80.20 Median:75.00 stddev:12.15 (16.2%) stddev-sans-first:12.67 09:18:58 INFO - PROCESS | 28975 | Values: 74.0 74.0 75.0 112.0 75.0 75.0 76.0 76.0 90.0 75.0 09:18:58 INFO - PROCESS | 28975 | 09:18:58 INFO - PROCESS | 28975 | [#4] audio-oscillator Cycles:10 Average:88.30 Median:83.00 stddev:9.80 (11.8%) stddev-sans-first:10.20 09:18:58 INFO - PROCESS | 28975 | Values: 83.0 83.0 108.0 82.0 82.0 84.0 99.0 82.0 81.0 99.0 09:18:58 INFO - PROCESS | 28975 | 09:18:58 INFO - PROCESS | 28975 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 09:18:58 INFO - PROCESS | 28975 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 09:18:58 INFO - PROCESS | 28975 | 09:18:58 INFO - PROCESS | 28975 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 09:18:58 INFO - PROCESS | 28975 | Values: 146.0 146.0 146.0 147.0 148.0 146.0 146.0 148.0 147.0 146.0 09:18:58 INFO - PROCESS | 28975 | 09:18:58 INFO - PROCESS | 28975 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 09:18:58 INFO - PROCESS | 28975 | Values: 96.0 95.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 09:18:58 INFO - PROCESS | 28975 | 09:18:58 INFO - PROCESS | 28975 | [#8] json-parse-financial Cycles:10 Average:48.60 Median:48.00 stddev:1.43 (3.0%) stddev-sans-first:1.39 09:18:58 INFO - PROCESS | 28975 | Values: 47.0 48.0 48.0 48.0 48.0 50.0 48.0 52.0 49.0 48.0 09:18:58 INFO - PROCESS | 28975 | 09:18:58 INFO - PROCESS | 28975 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 09:18:58 INFO - PROCESS | 28975 | Values: 64.0 65.0 64.0 64.0 64.0 64.0 64.0 63.0 64.0 65.0 09:18:58 INFO - PROCESS | 28975 | 09:18:58 INFO - PROCESS | 28975 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:81.00 stddev:4.88 (6.0%) stddev-sans-first:5.10 09:18:58 INFO - PROCESS | 28975 | Values: 78.0 81.0 79.0 86.0 89.0 75.0 84.0 81.0 75.0 75.0 09:18:58 INFO - PROCESS | 28975 | 09:18:58 INFO - PROCESS | 28975 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:126.50 stddev:10.53 (8.3%) stddev-sans-first:11.16 09:18:58 INFO - PROCESS | 28975 | Values: 126.0 127.0 129.0 121.0 121.0 128.0 120.0 123.0 156.0 123.0 09:18:58 INFO - PROCESS | 28975 | 09:18:58 INFO - PROCESS | 28975 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.40 Median:156.00 stddev:1.17 (0.8%) stddev-sans-first:1.09 09:18:58 INFO - PROCESS | 28975 | Values: 157.0 154.0 156.0 155.0 157.0 156.0 154.0 156.0 155.0 154.0 09:18:58 INFO - PROCESS | 28975 | 09:18:58 INFO - PROCESS | 28975 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.70 Median:61.00 stddev:0.95 (1.6%) stddev-sans-first:1.00 09:18:58 INFO - PROCESS | 28975 | Values: 61.0 61.0 61.0 62.0 62.0 61.0 60.0 60.0 60.0 59.0 09:18:58 INFO - PROCESS | 28975 | -------- Summary: end -------- 09:18:58 INFO - PROCESS | 28975 | 09:18:59 INFO - TEST-INFO | 28975: exit 0 09:18:59 INFO - TEST-OK | kraken | took 60181ms 09:18:59 INFO - SUITE-END | took 1174s 09:18:59 INFO - Completed test suite (00:19:34) 09:18:59 INFO - javascript benchmark 09:18:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3233.3371658809942, 3282.5404443377947, 3309.2554175310574, 3310.337932413518, 3320.63473017968, 5350.0, 5407.486288802567, 5422.837314880555, 5441.91837122443, 5443.564514838813, 5512.448755124486, 5573.386927437979, 5580.972095139518, 5587.273654424929, 5589.329280486337, 5023.7236951967625, 5046.041252162077, 5077.314562534066, 5106.5659418949435, 5140.0490909181735, 4971.453140154598, 5105.157648987913, 5143.562797162245, 5150.2532132840715, 5154.994776018678, 4952.380952380952, 4982.377202849644, 5037.823676171335, 5045.596352291808, 5135.35808023997, 5100.617453690969, 5128.538431541179, 5130.102232109384, 5131.7434128293435, 5136.04983078128, 4982.451930287665, 5039.0, 5098.5411312982005, 5106.08090543702, 5133.614978876599, 5345.037893179227, 5383.676979381211, 5391.353037635469, 5444.128939369682, 5468.507834294893, 5863.677497737623, 5912.231409916683, 5914.408559144094, 5919.5560332974765, 5939.049752039696, 5949.286085669704, 5954.583179177459, 5959.642421454727, 5967.910481342783, 5972.790952316648, 5369.677819330814, 5404.540614047772, 5487.6981766002455, 5546.389897111315, 5572.749226284827, 5995.310539288038, 6001.969990150022, 6006.399360064046, 6030.216071910623, 6042.667653279112, 5745.8563535911935, 5792.4497172768515, 5798.333191682926, 5803.390643982406, 5808.535317174616, 5735.741891614887, 5767.163761254595, 5800.4489573490455, 5865.912011319833, 5873.530117590582, 5818.301803783573, 5853.356130825606, 5895.086261629454, 5926.259217597801, 5935.317438494629, 5904.0553511437965, 5908.113782932594, 5909.409059094056, 5912.320083190402, 5913.704314784243, 4409.4488188976375, 4430.18041662287, 4537.228671125917, 4549.408576884984, 4563.1101935123, 3947.4473573699706, 3994.72036957416, 4014.3777714454304, 4021.3364794809113, 4070.5929407059057, 5657.773689052392, 5657.773689052392, 5659.151127330851, 5660.943390566124, 5682.488576028178, 5641.069223578145, 5737.540996720252, 5813.186153938452, 5911.261092363455, 5916.822495325147, 5599.132134519156, 5679.091345384719, 5701.914471282934, 5707.800226992035, 5713.971430142823, 5027.296178535008, 5029.698218106925, 5034.748262586856, 5035.395752509722, 5059.772310246048, 5913.556483263858, 6077.756889724362, 6126.203593532812, 6143.56995010345, 6144.631322120687, 5747.48272655463, 5852.795152169653, 5890.64656120617, 5902.822915312548, 5995.160677505066, 6163.3836616338, 6163.84590385244, 6168.414000669929, 6171.074338849208, 6172.660503672341, 5810.738516766671, 5868.2077919480325, 5870.442307980735, 5871.060630299132, 5876.0, 5740.655560666373, 5776.913346299725, 5886.558508111823, 5917.0, 5934.465898069195, 5822.912656310244, 5866.472017518444, 5868.38381969887, 5871.559633027626, 5896.557758168069, 5836.678982655825, 5846.707664616837, 5850.6782126981725, 5853.736581853912, 5857.209276747755, 5609.5512359012, 5613.438656134354, 5634.802781902614, 5645.604807663424, 5834.03738383162, 5743.62666426681, 5747.798827041033, 5762.567807414377, 5775.393583673654, 5787.392323806108, 5636.4927156556105, 5640.689762063126, 5640.887182256414, 5646.830595082154, 5647.971760141173], "value": 5450.093486054524, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.8016934157714, 610.3103493052851, 612.9724162412691, 637.9681015949203, 645.7772068636319, 38417.807910960444, 38976.610233897656, 38995.0, 38998.220035599305, 39039.0, 47420.0, 48334.27498587524, 48614.02771944559, 53925.1911221332, 54384.184237236375, 9178.265738740902, 9334.71995840126, 9355.906440935605, 9359.578818953163, 9363.6722714705, 8576.828463430727, 8675.219230269275, 9239.168474837263, 9242.214411775007, 9246.121618446237, 10994.450277486134, 11319.660410187666, 11334.036606888425, 11780.116491263147, 11780.823287650692, 11245.943770281137, 11320.0, 11337.206395552274, 11341.659750207507, 11353.148513861493, 11203.607873724462, 11300.717482062932, 11311.377874216998, 11315.321080735182, 11321.20751547392, 47758.0, 48069.75965120152, 48146.11123332611, 48168.518314816756, 48190.51809481895, 4436.9556304436865, 4448.399466072071, 4485.34962430449, 4578.038611891507, 4628.537146285378, 34805.30389392198, 35264.823675881715, 35405.0, 36013.45979810305, 37189.0, 4467.553244675539, 4537.568930951555, 4555.202839503074, 4573.794179261941, 4574.5425457453985, 372655.0, 373224.0, 373501.99999999726, 373944.0, 374066.0, 63710.6814465934, 63860.68069659622, 64109.679451602446, 64131.0, 64176.358236417036, 68693.65653171802, 68740.0, 68801.3119868805, 68946.0, 68974.0, 16702.49892503227, 17011.744823827652, 17052.0, 17078.23147958345, 17088.060156691503, 13934.860651393356, 13953.232572208626, 13955.651108722363, 13955.79066314006, 13967.161970281815, 16050.357985680443, 16231.837681623269, 17350.219240134225, 17929.37247196342, 17974.820251797315, 6410.903836442457, 6481.578697384655, 6517.446017088506, 6561.737530498822, 6763.797086087426, 974.3666616699202, 978.6672531339378, 979.5885727994117, 995.581855620641, 1012.6253286284121, 33625.83187084049, 33976.32047359039, 34010.14974625654, 34387.312253755284, 34595.30809383849, 1110.5890820396344, 1185.8043422835135, 1190.3691043746828, 1209.5041033176356, 1209.6915286601861, 18082.186301616457, 18169.7274540882, 18300.542486437946, 18306.359277425494, 18317.17572709231, 541160.0, 543462.0, 544584.0, 546806.0, 549483.0, 61022.0, 61851.38148618546, 66029.0, 66639.66680166568, 66643.66678166675, 1518.2257048905137, 1528.824185218714, 1547.048565132458, 1559.7114533811055, 1561.7423125184218, 33791.662083378855, 34522.0, 35242.29515409626, 35795.46306805452, 36309.27381452409, 57006.0, 57516.0, 57859.1321130175, 57888.13167802402, 58020.70989645025, 461662.0, 462910.0, 464902.0, 466210.0, 467777.0, 44166.0, 44781.32828007518, 44835.77582112069, 45040.54959450364, 45104.548954510035, 46391.304130438744, 51289.48710512847, 51291.743541282056, 56532.152017718945, 56866.0, 43348.83349233057, 44579.77710111429, 45151.32273015973, 45244.54755452403, 46980.53019469762, 43984.560154398045, 44719.329210062526, 45176.32235516536, 45760.313595296764, 46004.309935351666, 44007.0, 44186.779066104464, 44231.55768442275, 44352.778236108614, 44388.0, 36865.44701829421, 39021.80489097536, 39068.0, 39431.21137577175, 39744.0, 28676.638672166344, 28762.0, 29056.854715726287, 29460.705392946653, 29508.409831802815], "value": 21972.07332003408, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [440.79282737113544, 444.4666400319615, 452.71931402530424, 453.13451308001726, 465.8742139622302, 19862.304819331326, 20522.17911283549, 21664.0, 21846.563068738637, 21868.671969920462, 21656.350309490703, 22104.22635207768, 22331.44171395716, 22484.887575562097, 22819.973101210442, 5901.203337549418, 5952.285725712921, 6120.387961203888, 6130.080487926824, 6131.87736245277, 6125.356837532062, 6154.876902461948, 6155.938440615604, 6179.258488981329, 6195.969020154893, 5904.084866845646, 5994.430529099728, 6226.0, 6230.190075290206, 6232.158658581079, 5985.700714964256, 5987.970060149715, 6007.579469437142, 6019.699015049252, 6023.036314189731, 5382.461753824626, 5402.8919421611345, 5443.374011988632, 5448.45515448456, 5448.536874365644, 25867.74132258672, 25953.22140335793, 25964.480710385877, 26036.73963260381, 26313.210603681728, 2502.8998840046374, 2547.8598677072755, 2564.9358766030814, 2574.858382788946, 2621.9606705899428, 15124.470643527533, 15433.691326173526, 15682.0, 15894.364225430969, 16435.424760133337, 2035.8574899757023, 2053.37372101509, 2068.214078650118, 2109.1985045682695, 2212.61279276126, 97104.51447742716, 97362.51318743361, 97649.51175244078, 98848.50575747147, 99216.0, 12248.142630015813, 12386.81419778704, 12703.555375561811, 12709.809352859715, 12844.678883027813, 18157.09214539268, 18171.273149074153, 18175.45473635793, 18209.362672306404, 18222.27110915575, 7212.2427145149, 7215.927840721631, 7227.060482137288, 7962.964814574184, 8979.326550508738, 8696.304295656459, 8789.208971192624, 8808.515531645693, 8885.42244754089, 8955.149260820212, 5008.924866127011, 5119.539241468286, 5141.794328226829, 5185.974070129625, 5430.782768689208, 2139.4437446263773, 2145.463634091477, 2172.0894002037344, 2214.2360885494477, 2265.7054582904116, 939.6476321379482, 955.7419496735981, 956.6030097509595, 974.8440249560036, 976.1605019683067, 19997.0, 21378.14487420517, 21386.144554217968, 21387.3691722168, 21405.67891481629, 955.2214944819949, 961.3174646001418, 970.4779802921355, 981.3326937682302, 990.4997976022207, 11508.367039812723, 11660.30038197711, 11807.169888667271, 11907.583234586747, 12081.758364832654, 591794.0, 605077.0, 649369.0, 677725.0, 680543.0, 102912.48543757384, 105671.47164264283, 109146.45426772816, 110741.0, 113587.43206284082, 1057.9314891959177, 1073.431081526792, 1081.6106201767357, 1082.767205050918, 1094.4363652718855, 17953.551161220552, 18070.909645451688, 18331.26674933041, 18381.908090459463, 18701.71947420817, 44854.3271850929, 44929.55070449254, 45359.77320113379, 45620.54379456296, 46814.063718726116, 63328.0, 63559.364406355344, 64139.0, 64313.67843160941, 64917.35082649113, 8400.705975290835, 8591.269742071994, 8645.52449615252, 8648.913510864812, 9280.95359523198, 10647.574097036031, 14084.718305634035, 14281.500147494788, 14526.346314415665, 14785.11289322644, 11971.700707482034, 11991.280523168638, 12246.938765306117, 12309.75380492403, 12364.938175309066, 11837.704057398634, 12187.0, 12304.692382690504, 12521.812172817234, 12690.555830546256, 12591.87408125907, 12754.61736147917, 12862.163959342613, 12950.093493455368, 12950.222986620833, 8686.869696954423, 8831.955840220759, 8925.464472131693, 8935.865962010705, 9020.323475739215, 12414.379281036092, 12638.178518396275, 12711.80932286035, 12712.6821829455, 12737.93631031839], "value": 10101.740540292827, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.1528129637677, 1456.5193486149572, 1472.6392033951684, 1476.8449312822156, 1491.060631801965, 7405.444591655621, 8001.9197408349855, 8294.253517183452, 8297.377696672744, 8523.0, 8304.377171712116, 8370.623321950512, 8371.958140209306, 8383.706570270042, 8389.454685445442, 2117.587070521249, 2187.639039558471, 2395.1616934073068, 2437.524682686877, 2438.1344622658967, 2374.7031621047367, 2438.2685194441683, 2442.584760590695, 2443.621238707994, 2448.3879030242438, 2181.1929586053184, 2202.6365649667787, 2211.1708109458955, 2213.4798322394226, 2217.36805010572, 2358.9174378896655, 2367.254314890804, 2387.367347652882, 2391.091385273602, 2393.5811233034237, 2324.6048171810835, 2337.1936681844736, 2337.415646088478, 2340.9531809363716, 2342.1919437793936, 8206.876896846552, 8418.368622353348, 8423.747287581382, 8426.83146337076, 8431.325493960469, 5097.617678674114, 5228.973855130738, 5235.083860324428, 5235.685858848481, 5236.842894713165, 3172.6510083890753, 3300.2574420755377, 3403.2002479417315, 3456.6888979991922, 3477.8261086945804, 1382.4815694114707, 1402.964925876851, 1433.1114708880561, 1444.5738507140313, 1514.8863835212403, 11110.666679999613, 11155.665330040112, 11158.0, 11158.553657853676, 11160.218784685076, 4534.251848445036, 4626.930596041062, 4653.092646933816, 4676.368690226844, 4681.64887633422, 9682.273829462678, 9682.515874206261, 9683.951580242054, 9691.9030809691, 9694.854577181348, 5347.705876176769, 5349.384820745586, 5351.063563876306, 5352.785888564414, 5354.143337066051, 4258.957410425918, 4747.620190384761, 4856.053069651384, 4870.001649661811, 4938.209886418156, 3975.6223158799867, 4065.288574499451, 4096.651784598283, 4117.135401565645, 4144.254034273859, 1244.6079484962208, 1249.2816630437535, 1249.5688987299368, 1252.2549083295426, 1254.4793910527212, 1035.3115178406276, 1039.948002599882, 1046.7121541575975, 1048.826943554305, 1057.6932689520106, 5845.181674565564, 5931.436513531207, 5940.613860099166, 6040.268456375895, 6043.0, 656.1994366872408, 657.2572992518424, 662.3343539742527, 671.1878626861454, 673.182083768224, 4052.0, 4069.206504731608, 4083.97958010214, 4103.753774773523, 4105.774182419996, 9754.414735115915, 10046.949765251273, 10091.142252908585, 10107.898921010843, 10118.0, 9931.751706207402, 9997.300188986701, 10024.248181386425, 10031.047050530187, 10032.64885728996, 7327.5969821659255, 7634.847303054019, 7902.0, 7960.721374751972, 7975.04299484054, 5702.486776190163, 5885.117232415172, 5891.23413956183, 6007.189029480965, 6011.789587364421, 8506.447080939719, 8698.434601750865, 8860.468371897707, 8890.24432923183, 8906.153915378029, 8859.335549833659, 8909.73270801877, 8952.194302512806, 8971.910280897107, 8973.551322433983, 6725.260221375743, 6888.931110689029, 6945.20130185015, 7172.426205903619, 7300.45246606496, 7614.6954121836725, 7847.254510821463, 7847.8038049046945, 7848.097468790934, 7850.882236766567, 6935.3411425914455, 7036.788896333118, 7050.894236586558, 7102.644867756695, 7194.496385252982, 7037.577745335297, 7045.647717614202, 7058.71765129389, 7167.0, 7306.0502134724275, 6376.52176086786, 6466.450351719968, 6501.08984742127, 6514.6416947068365, 6515.185601799775, 5143.699117415094, 5191.610629202901, 5246.868828279324, 5367.677939323653, 5430.266913966564, 5129.769160387867, 5137.255098010843, 5144.562712169358, 5264.420913699413, 5361.490658387447], "value": 4477.94271945024, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.1026975249821, 413.3980824305815, 416.1323640210161, 430.3634290247408, 432.21984318305465, 5122.718250496221, 5246.449122842104, 5323.520883120518, 5437.564994800417, 5444.183372494128, 5148.433672296044, 5259.948010397926, 5262.158054711237, 5275.894482110355, 5297.761600727967, 4145.419641250227, 4277.721948073366, 4286.314189729644, 4298.26929421999, 4303.376010478479, 4252.9149417011795, 4267.871963841089, 4301.677374196932, 4303.591158839921, 4330.765731766447, 4255.212785634652, 4274.893127671802, 4289.2922667759785, 4290.806913688876, 4294.592013758688, 4228.957710422918, 4311.913761724763, 4318.244307246219, 4322.2220000400075, 4327.32926396409, 3914.745541539791, 3929.2730844793805, 3933.6656384207377, 3941.7043721720697, 3948.8420463181437, 5185.55922746567, 5192.818251361185, 5198.2722418861385, 5203.427622961509, 5209.296744939423, 4816.397950256218, 4896.485868983741, 4905.8282960096585, 4906.730129842857, 4918.0, 5517.034518959166, 5536.252605898233, 5537.335519737617, 5577.972110139423, 5582.665040097607, 4277.230098582254, 4278.914421711579, 4286.849960251377, 4299.591538803808, 4300.677449191323, 5508.889822203533, 5758.481736643722, 5769.596128271022, 5783.0, 5790.218320526759, 4270.188664153801, 4283.201055556674, 4293.506246781598, 4308.289132293199, 4329.783510824446, 4331.025519258142, 4364.8472303469225, 4366.759828209479, 4409.691321607456, 4435.556444355539, 4887.853364399074, 4907.828226012072, 4911.533404326583, 4927.0, 4930.1865192243595, 5439.0, 5449.237106805051, 5510.448955104538, 5522.171674248895, 5663.801766938137, 1505.7741338799267, 1511.871490923262, 1515.181801827023, 1516.1736853414916, 1516.8255650600322, 1073.3291692692067, 1103.2718405852258, 1112.8831472695413, 1122.960696375623, 1128.785530749155, 5324.4675532446445, 5333.146696528537, 5346.385165705916, 5350.8662283442445, 5357.571394288448, 5534.280543529316, 5546.805861794818, 5575.526080283222, 5606.243816642777, 5612.410696876851, 5254.553362964114, 5371.462853714597, 5391.353037635509, 5539.667619942736, 5550.777968881281, 2953.675095739467, 2970.985145074261, 2974.2861713188677, 3004.4591973444553, 3012.8493575321145, 5629.324481062217, 5856.238688970407, 5862.325832529314, 5868.149118377897, 5880.911786323209, 5718.771249149988, 5724.398938111522, 5725.255716756795, 5731.770729170787, 5755.482006619424, 5743.798967036218, 5757.0, 5783.681897495594, 5804.303483581997, 5830.329512106077, 5326.813561525328, 5564.860878478071, 5566.22072909801, 5589.496945274945, 5626.409227031103, 5549.972250138723, 5554.250176226319, 5566.856760147291, 5576.553875690016, 5582.8325150245555, 5805.448482394335, 5811.430913653206, 5828.329742079545, 5837.6497410155525, 5840.591158618856, 4016.979915100406, 4200.075983283673, 4219.514755802999, 4229.513605935357, 4244.38456423823, 5501.0, 5613.831585052455, 5632.380438151718, 5846.970765146147, 5855.180274761622, 5616.971915140398, 5619.494245517923, 5622.7750889963945, 5641.548676105984, 5642.294713160855, 5619.634723743107, 5624.831255062355, 5635.8591035224445, 5639.971800140973, 5642.407547207484, 5308.6283960123965, 5546.251256080377, 5549.639273447375, 5570.5543556516195, 5575.303087114111, 5623.3533143689, 5631.436856314336, 5635.492805647511, 5637.661740295595, 5656.6888821115235, 5239.738013099406, 5446.264754258124, 5533.280673512418, 5537.833864984057, 5552.3892371839875], "value": 4351.836011223277, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.2044750774146, 724.492855001499, 762.1616222155629, 797.5015615240475, 845.2899564365931, 15519.61200969975, 16275.511734647966, 16288.918555407206, 16437.506874793744, 16462.670746585078, 14904.701905961874, 14908.701825963475, 14956.0, 14961.0, 14966.102033877947, 812.5043723328765, 829.618375547249, 835.1398059998212, 836.1513064239801, 837.7863644770605, 717.2110678253931, 737.0160835284901, 822.153182222312, 842.1914961636836, 850.421713235, 903.7469508537587, 905.995470022649, 906.3021473465427, 906.3927168796889, 907.0657223060225, 901.7970956534792, 902.1880307723069, 902.2195800632471, 902.6524787956619, 904.1817155474306, 546.7867531662655, 559.4740943513125, 630.571211576128, 644.0, 649.3149727037973, 16595.751063734053, 16626.085565293903, 16639.50081497557, 16645.167741612993, 16645.66708665832, 15161.0, 15352.155631440266, 15686.177109050172, 15953.760693589606, 16326.836731632651, 12961.22232666043, 13321.200727956353, 13523.797143042862, 13545.39045742944, 13647.799054220995, 4112.321466957948, 4119.97940010301, 4136.110736191733, 4179.519355274152, 4201.936970945439, 80183.59908200422, 80760.0, 81461.59269203675, 83096.99999999939, 83341.58329208376, 12294.0, 12385.752284954251, 12389.380530973416, 12427.502899884084, 12636.178648387826, 23473.178438754563, 23864.761352386602, 24010.51978960411, 24069.879650601986, 24255.272341829772, 8920.152585504367, 8994.28045756338, 9074.546272686339, 9170.220531254785, 9284.907150928539, 4721.95278047222, 4888.486708895586, 4891.437484689235, 4917.213245880642, 4935.654504184745, 3987.2623564640053, 4013.2776100302226, 4112.588741125864, 4119.691023173274, 4132.421460995463, 739.474972769329, 742.0464702856804, 746.6826598695533, 753.6909866954632, 756.837279984806, 779.5907148746953, 786.2569871471519, 787.4999375396665, 806.3468590441761, 809.7368355284556, 10688.412137332365, 10876.817899316346, 10999.780004399867, 11056.944715276533, 11177.720556985978, 764.4916130773084, 775.9418043646749, 776.3595034096893, 791.3392317414908, 803.3733687723585, 5373.2208829719475, 5386.730663466811, 5766.654000759968, 5811.564132690065, 5903.3801450847905, 81433.0, 84492.57753711315, 85347.57326213329, 87244.56377718071, 87468.0, 74594.62702686452, 76879.0, 77316.0, 77633.0, 80371.59814200892, 66655.66672166609, 68715.0, 69635.0, 70173.64913175402, 70276.94584581236, 11429.885701142883, 11516.445279887108, 11644.41777911118, 11824.881751182722, 12049.879501205227, 40000.1999960005, 41101.0, 42582.36126458044, 43357.34963975606, 44450.77774611106, 49624.50375496199, 51260.74369628128, 55388.16917746156, 57005.42994570167, 57462.425375745705, 13567.38946747379, 13799.172049677052, 13808.1024733392, 14079.859201407855, 14403.135811851322, 14107.435702571782, 14745.92627036858, 15066.09603423798, 15766.763498547301, 16813.747793783346, 15242.161681107646, 15257.237138142826, 15514.0, 15917.204139793195, 16437.67124657524, 14122.576322710334, 14174.858251417354, 14479.276036198358, 15022.774658379914, 15207.467738629095, 15049.028418509099, 15086.0, 15256.23718814077, 15299.158546280061, 15309.923450382677, 12159.452824622736, 12903.483860645469, 12979.221246725227, 13250.668733281746, 13331.0, 12013.159078864395, 12017.339046352534, 12135.150539462506, 12414.751704965669, 12461.501539938663], "value": 7844.988691460997, "unit": "score"}], "name": "dromaeo_css", "value": 7548.210253704098, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 110.0, 112.0, 112.0, 110.0, 109.0, 110.0, 109.0, 112.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 117.0, 121.0, 151.0, 120.0, 119.0, 117.0, 121.0, 144.0, 117.0], "value": 126.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 163.0, 160.0, 159.0, 160.0, 161.0, 161.0, 160.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 112.0, 75.0, 75.0, 76.0, 76.0, 90.0, 75.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 108.0, 82.0, 82.0, 84.0, 99.0, 82.0, 81.0, 99.0], "value": 88.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 148.0, 146.0, 146.0, 148.0, 147.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 48.0, 48.0, 48.0, 48.0, 50.0, 48.0, 52.0, 49.0, 48.0], "value": 48.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0, 65.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 79.0, 86.0, 89.0, 75.0, 84.0, 81.0, 75.0, 75.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 127.0, 129.0, 121.0, 121.0, 128.0, 120.0, 123.0, 156.0, 123.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 154.0, 156.0, 155.0, 157.0, 156.0, 154.0, 156.0, 155.0, 154.0], "value": 155.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 62.0, 61.0, 60.0, 60.0, 60.0, 59.0], "value": 60.7, "unit": "score"}], "name": "kraken", "value": 1461.9000000000003, "alertThreshold": 2.0}]} 09:18:59 INFO - Return code: 0 09:18:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:18:59 ERROR - # TBPL SUCCESS # 09:18:59 INFO - Running post-action listener: _resource_record_post_action 09:18:59 INFO - [mozharness: 2017-03-04 17:18:59.630550Z] Finished run-tests step (success) 09:18:59 INFO - Running post-run listener: _resource_record_post_run 09:18:59 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 274432; Write bytes: 364740608; Read time: 392; Write time: 244992 09:18:59 INFO - TinderboxPrint: CPU usage
13.0% 09:18:59 INFO - TinderboxPrint: I/O read bytes / time
274,432 / 392 09:18:59 INFO - TinderboxPrint: I/O write bytes / time
364,740,608 / 244,992 09:18:59 INFO - TinderboxPrint: CPU idle
8,266.8 (87.0%) 09:18:59 INFO - TinderboxPrint: CPU user
1,192.3 (12.5%) 09:18:59 INFO - TinderboxPrint: Swap in / out
0 / 0 09:18:59 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 110223360; Read time: 184; Write time: 98708 09:18:59 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 270336; Write bytes: 254517248; Read time: 208; Write time: 146284 09:19:00 INFO - Running post-run listener: _upload_blobber_files 09:19:00 INFO - Blob upload gear active. 09:19:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:19:00 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 09:19:00 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:19:00 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:19:00 INFO - (blobuploader) - INFO - Open directory for files ... 09:19:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:19:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:19:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:19:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:19:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:19:01 INFO - (blobuploader) - INFO - Done attempting. 09:19:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:19:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:19:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:19:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:19:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:19:04 INFO - (blobuploader) - INFO - Done attempting. 09:19:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:19:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:19:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:19:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:19:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:19:05 INFO - (blobuploader) - INFO - Done attempting. 09:19:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:19:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:19:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:19:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:19:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:19:06 INFO - (blobuploader) - INFO - Done attempting. 09:19:06 INFO - (blobuploader) - INFO - Iteration through files over. 09:19:06 INFO - Return code: 0 09:19:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:19:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:19:06 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3184f27ca59bd071f250fd732152116fb9ddc637a751c68f2584a59e8e81c5bd61051d3d0421014c7d7919e552ebfbdf7f6228abb5780c64ae7164a2323e9446", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b853a20618657e0e73eec4b8d52ad1e67b4ed3b549c330c051dbbfae198dd7cc1fb2a5a6c90b8bede8cc4df541bbad60841793a32600184d9470e1e6b391e2f", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6ef7a2c8b3ca68c6acb3036ad0a43a0a3dccf21c668d86d460594e38d4e81f2933d7727a88be65bf9eccdd93b2a2e08a81beb55cac1055773635f972f61b8db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/166d0e102854e0d52d0a01d6cd8f01bdbc7e6d58232b83fddf8f3593936d86fd9b7b07663fd641a64056d695347d4624d86f8aa0a33ce6d3043ffc78584e0887"} 09:19:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:19:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:19:06 INFO - Contents: 09:19:06 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3184f27ca59bd071f250fd732152116fb9ddc637a751c68f2584a59e8e81c5bd61051d3d0421014c7d7919e552ebfbdf7f6228abb5780c64ae7164a2323e9446", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b853a20618657e0e73eec4b8d52ad1e67b4ed3b549c330c051dbbfae198dd7cc1fb2a5a6c90b8bede8cc4df541bbad60841793a32600184d9470e1e6b391e2f", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6ef7a2c8b3ca68c6acb3036ad0a43a0a3dccf21c668d86d460594e38d4e81f2933d7727a88be65bf9eccdd93b2a2e08a81beb55cac1055773635f972f61b8db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/166d0e102854e0d52d0a01d6cd8f01bdbc7e6d58232b83fddf8f3593936d86fd9b7b07663fd641a64056d695347d4624d86f8aa0a33ce6d3043ffc78584e0887"} 09:19:06 INFO - Running post-run listener: copy_logs_to_upload_dir 09:19:06 INFO - Copying logs to upload dir... 09:19:06 INFO - mkdir: /builds/slave/test/build/upload/logs 09:19:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.139354 ========= master_lag: 0.42 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-03-04 09:19:05.148777) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-04 09:19:05.151830) ========= 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=523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3184f27ca59bd071f250fd732152116fb9ddc637a751c68f2584a59e8e81c5bd61051d3d0421014c7d7919e552ebfbdf7f6228abb5780c64ae7164a2323e9446", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b853a20618657e0e73eec4b8d52ad1e67b4ed3b549c330c051dbbfae198dd7cc1fb2a5a6c90b8bede8cc4df541bbad60841793a32600184d9470e1e6b391e2f", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6ef7a2c8b3ca68c6acb3036ad0a43a0a3dccf21c668d86d460594e38d4e81f2933d7727a88be65bf9eccdd93b2a2e08a81beb55cac1055773635f972f61b8db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/166d0e102854e0d52d0a01d6cd8f01bdbc7e6d58232b83fddf8f3593936d86fd9b7b07663fd641a64056d695347d4624d86f8aa0a33ce6d3043ffc78584e0887"} build_url:https://queue.taskcluster.net/v1/task/I1PELWSkTSyEA_5hYT6m6Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011243 build_url: 'https://queue.taskcluster.net/v1/task/I1PELWSkTSyEA_5hYT6m6Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3184f27ca59bd071f250fd732152116fb9ddc637a751c68f2584a59e8e81c5bd61051d3d0421014c7d7919e552ebfbdf7f6228abb5780c64ae7164a2323e9446", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b853a20618657e0e73eec4b8d52ad1e67b4ed3b549c330c051dbbfae198dd7cc1fb2a5a6c90b8bede8cc4df541bbad60841793a32600184d9470e1e6b391e2f", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6ef7a2c8b3ca68c6acb3036ad0a43a0a3dccf21c668d86d460594e38d4e81f2933d7727a88be65bf9eccdd93b2a2e08a81beb55cac1055773635f972f61b8db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/166d0e102854e0d52d0a01d6cd8f01bdbc7e6d58232b83fddf8f3593936d86fd9b7b07663fd641a64056d695347d4624d86f8aa0a33ce6d3043ffc78584e0887"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-04 09:19:05.176882) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-04 09:19:05.177212) ========= 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=523ca41ca1e0623de333ad52000001bf-1488632462.160112-826592576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004554 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-04 09:19:05.227906) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-04 09:19:05.228522) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-04 09:19:05.229024) ========= ========= Total master_lag: 0.55 =========