builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs slave: talos-linux64-ix-084 starttime: 1491582510.1 results: success (0) revision: 22df0c5cfbf8a2aa2822bf9c763e6c1c5a3f69de ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-07 09:28:30.101799) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-07 09:28:30.102566) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-07 09:28:30.103016) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-07 09:28:30.119147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 09:28:30.119519) ========= 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=ea65d483da93c827905c2090000001f5-1491582509.690638-893653871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-07 09:28:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-04-07 09:28:30 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.106252 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 09:28:30.239938) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 09:28:30.240253) ========= 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=ea65d483da93c827905c2090000001f5-1491582509.690638-893653871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015604 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 09:28:30.291359) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-07 09:28:30.291954) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 22df0c5cfbf8a2aa2822bf9c763e6c1c5a3f69de --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 22df0c5cfbf8a2aa2822bf9c763e6c1c5a3f69de --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=ea65d483da93c827905c2090000001f5-1491582509.690638-893653871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-07 09:28:30,981 truncating revision to first 12 chars 2017-04-07 09:28:30,981 Setting DEBUG logging. 2017-04-07 09:28:30,981 attempt 1/10 2017-04-07 09:28:30,981 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/22df0c5cfbf8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-07 09:28:32,223 unpacking tar archive at: mozilla-central-22df0c5cfbf8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.546265 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-07 09:28:31.852738) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-07 09:28:31.853087) ========= script_repo_revision: 22df0c5cfbf8a2aa2822bf9c763e6c1c5a3f69de ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-07 09:28:31.853454) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-07 09:28:31.853711) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-07 09:28:31.863436) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-04-07 09:28:31.863833) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ea65d483da93c827905c2090000001f5-1491582509.690638-893653871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:28:32 INFO - MultiFileLogger online at 20170407 09:28:32 in /builds/slave/test 09:28:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:28:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:28:32 INFO - {'append_to_log': False, 09:28:32 INFO - 'base_work_dir': '/builds/slave/test', 09:28:32 INFO - 'blob_upload_branch': 'Firefox', 09:28:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:28:32 INFO - 'branch': 'Firefox', 09:28:32 INFO - 'buildbot_json_path': 'buildprops.json', 09:28:32 INFO - 'config_files': ('talos/linux_config.py',), 09:28:32 INFO - 'default_actions': ('clobber', 09:28:32 INFO - 'read-buildbot-config', 09:28:32 INFO - 'download-and-extract', 09:28:32 INFO - 'populate-webroot', 09:28:32 INFO - 'create-virtualenv', 09:28:32 INFO - 'install', 09:28:32 INFO - 'run-tests'), 09:28:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:28:32 INFO - 'download_minidump_stackwalk': True, 09:28:32 INFO - 'download_symbols': 'ondemand', 09:28:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:28:32 INFO - 'tooltool.py': '/tools/tooltool.py', 09:28:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:28:32 INFO - '/tools/misc-python/virtualenv.py')}, 09:28:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:28:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:28:32 INFO - 'gecko_profile': False, 09:28:32 INFO - 'gecko_profile_interval': 0, 09:28:32 INFO - 'installer_path': 'installer.exe', 09:28:32 INFO - 'log_level': 'info', 09:28:32 INFO - 'log_name': 'talos', 09:28:32 INFO - 'log_to_console': True, 09:28:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:28:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:28:32 INFO - 'opt_config_files': (), 09:28:32 INFO - 'pip_index': False, 09:28:32 INFO - 'suite': 'dromaeojs', 09:28:32 INFO - 'system_bits': '32', 09:28:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:28:32 INFO - 'title': 'talos-linux64-ix-084', 09:28:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:28:32 INFO - 'use_talos_json': True, 09:28:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:28:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:28:32 INFO - 'work_dir': 'build'} 09:28:32 INFO - [mozharness: 2017-04-07 16:28:32.648549Z] Running clobber step. 09:28:32 INFO - Running pre-action listener: _resource_record_pre_action 09:28:32 INFO - Running main action method: clobber 09:28:32 INFO - rmtree: /builds/slave/test/build 09:28:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:28:34 INFO - Running post-action listener: _resource_record_post_action 09:28:34 INFO - [mozharness: 2017-04-07 16:28:34.103059Z] Finished clobber step (success) 09:28:34 INFO - [mozharness: 2017-04-07 16:28:34.103158Z] Running read-buildbot-config step. 09:28:34 INFO - Running pre-action listener: _resource_record_pre_action 09:28:34 INFO - Running main action method: read_buildbot_config 09:28:34 INFO - Using buildbot properties: 09:28:34 INFO - { 09:28:34 INFO - "project": "", 09:28:34 INFO - "product": "firefox", 09:28:34 INFO - "who": "ffxbld@noreply.mozilla.org", 09:28:34 INFO - "installer_path": "public/build/target.tar.bz2", 09:28:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs", 09:28:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:28:34 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs", 09:28:34 INFO - "stage_platform": "linux64-stylo", 09:28:34 INFO - "basedir": "/builds/slave/test", 09:28:34 INFO - "buildnumber": 21, 09:28:34 INFO - "platform": "ubuntu64_hw_stylo", 09:28:34 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:28:34 INFO - "slavebuilddir": "test", 09:28:34 INFO - "taskId": "YqUDobt7TY6nqLgfQJ-t0Q", 09:28:34 INFO - "branch": "mozilla-central", 09:28:34 INFO - "script_repo_revision": "production", 09:28:34 INFO - "revision": "22df0c5cfbf8a2aa2822bf9c763e6c1c5a3f69de", 09:28:34 INFO - "slavename": "talos-linux64-ix-084", 09:28:34 INFO - "repo_path": "mozilla-central" 09:28:34 INFO - } 09:28:34 INFO - Finding installer, test and symbols from parent task. 09:28:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YqUDobt7TY6nqLgfQJ-t0Q'}, attempt #1 09:28:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YqUDobt7TY6nqLgfQJ-t0Q'}, attempt #1 09:28:36 INFO - Task dependencies: LYmRvCjzReSChL0lkNv9sw 09:28:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw'}, attempt #1 09:28:37 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.tar.bz2 09:28:37 INFO - Set test_url: https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/test_packages.json 09:28:37 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.crashreporter-symbols.zip 09:28:37 INFO - Running post-action listener: _resource_record_post_action 09:28:37 INFO - [mozharness: 2017-04-07 16:28:37.353886Z] Finished read-buildbot-config step (success) 09:28:37 INFO - [mozharness: 2017-04-07 16:28:37.354104Z] Running download-and-extract step. 09:28:37 INFO - Running pre-action listener: _resource_record_pre_action 09:28:37 INFO - Running main action method: download_and_extract 09:28:37 INFO - mkdir: /builds/slave/test/build/tests 09:28:37 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')]} 09:28:37 INFO - trying https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.test_packages.json 09:28:37 INFO - Downloading https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:28:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:28:38 INFO - Downloaded 986 bytes. 09:28:38 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:28:38 INFO - Using the following test package requirements: 09:28:38 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:28:38 INFO - u'common': [u'target.common.tests.zip'], 09:28:38 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:28:38 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:28:38 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:28:38 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:28:38 INFO - u'mozbase': [u'target.common.tests.zip'], 09:28:38 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:28:38 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:28:38 INFO - u'web-platform': [u'target.common.tests.zip', 09:28:38 INFO - u'target.web-platform.tests.zip'], 09:28:38 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:28:38 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:28:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.common.tests.zip 09:28:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:28:38 INFO - Fetch https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.common.tests.zip into memory 09:28:39 INFO - Expected file size: 58243878 09:28:39 INFO - Obtained file size: 58243878 09:28:49 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:28:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.common.tests.zip 09:28:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:28:49 INFO - Fetch https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.common.tests.zip into memory 09:28:50 INFO - Expected file size: 58243878 09:28:50 INFO - Obtained file size: 58243878 09:29:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.talos.tests.zip 09:29:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:29:01 INFO - Fetch https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.talos.tests.zip into memory 09:29:01 INFO - Expected file size: 14404138 09:29:01 INFO - Obtained file size: 14404138 09:29:02 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')]} 09:29:02 INFO - trying https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.tar.bz2 09:29:02 INFO - Downloading https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:29:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:29:03 INFO - Downloaded 59058192 bytes. 09:29:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.tar.bz2 09:29:03 INFO - mkdir: /builds/slave/test/properties 09:29:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:29:03 INFO - Writing to file /builds/slave/test/properties/build_url 09:29:03 INFO - Contents: 09:29:03 INFO - build_url:https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.tar.bz2 09:29:03 INFO - Running post-action listener: _resource_record_post_action 09:29:03 INFO - Running post-action listener: set_extra_try_arguments 09:29:03 INFO - [mozharness: 2017-04-07 16:29:03.416406Z] Finished download-and-extract step (success) 09:29:03 INFO - [mozharness: 2017-04-07 16:29:03.416503Z] Running populate-webroot step. 09:29:03 INFO - Running pre-action listener: _resource_record_pre_action 09:29:03 INFO - Running main action method: populate_webroot 09:29:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:29:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:29:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:29:03 INFO - '--tppagecycles', 09:29:03 INFO - '7'], 09:29:03 INFO - 'tests': ['tsvgm']}}, 09:29:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:29:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:29:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:29:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:29:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:29:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:29:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:29:03 INFO - 'talos_options': ['--disable-e10s'], 09:29:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:29:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:29:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:29:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:29:03 INFO - 'talos_options': ['--disable-e10s'], 09:29:03 INFO - 'tests': ['damp', 'tps']}, 09:29:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:29:03 INFO - 'tests': ['damp', 'tps']}, 09:29:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:29:03 INFO - 'tests': ['dromaeo_dom']}, 09:29:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:29:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:29:03 INFO - 'tests': ['basic_compositor_video']}, 09:29:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:29:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:29:03 INFO - 'tests': ['a11yr', 09:29:03 INFO - 'ts_paint', 09:29:03 INFO - 'tpaint', 09:29:03 INFO - 'sessionrestore', 09:29:03 INFO - 'sessionrestore_no_auto_restore', 09:29:03 INFO - 'tabpaint']}, 09:29:03 INFO - 'other-e10s': {'tests': ['a11yr', 09:29:03 INFO - 'ts_paint', 09:29:03 INFO - 'tpaint', 09:29:03 INFO - 'sessionrestore', 09:29:03 INFO - 'sessionrestore_no_auto_restore', 09:29:03 INFO - 'tabpaint']}, 09:29:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:29:03 INFO - 'ts_paint', 09:29:03 INFO - 'tpaint', 09:29:03 INFO - 'sessionrestore', 09:29:03 INFO - 'sessionrestore_no_auto_restore', 09:29:03 INFO - 'tabpaint']}, 09:29:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:29:03 INFO - 'ts_paint', 09:29:03 INFO - 'tpaint', 09:29:03 INFO - 'sessionrestore', 09:29:03 INFO - 'sessionrestore_no_auto_restore', 09:29:03 INFO - 'tabpaint']}, 09:29:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:29:03 INFO - 'tests': ['a11yr', 09:29:03 INFO - 'ts_paint', 09:29:03 INFO - 'tpaint', 09:29:03 INFO - 'sessionrestore', 09:29:03 INFO - 'sessionrestore_no_auto_restore', 09:29:03 INFO - 'tabpaint']}, 09:29:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:29:03 INFO - 'tests': ['a11yr', 09:29:03 INFO - 'ts_paint', 09:29:03 INFO - 'tpaint', 09:29:03 INFO - 'sessionrestore', 09:29:03 INFO - 'sessionrestore_no_auto_restore', 09:29:03 INFO - 'tabpaint']}, 09:29:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:29:03 INFO - 'tests': ['tsvgx', 09:29:03 INFO - 'tsvgr_opacity', 09:29:03 INFO - 'tart', 09:29:03 INFO - 'tscrollx', 09:29:03 INFO - 'cart', 09:29:03 INFO - 'tsvg_static']}, 09:29:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:29:03 INFO - 'tsvgr_opacity', 09:29:03 INFO - 'tart', 09:29:03 INFO - 'tscrollx', 09:29:03 INFO - 'cart', 09:29:03 INFO - 'tsvg_static']}, 09:29:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:29:03 INFO - 'talos_options': ['--disable-e10s'], 09:29:03 INFO - 'tests': ['tp5o']}, 09:29:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:29:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:29:03 INFO - 'talos_options': ['--disable-e10s', 09:29:03 INFO - '--xperf_path', 09:29:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:29:03 INFO - 'tests': ['tp5n']}, 09:29:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:29:03 INFO - 'talos_options': ['--xperf_path', 09:29:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:29:03 INFO - 'tests': ['tp5n']}}, 09:29:03 INFO - 'talos.zip': {'path': '', 09:29:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:29:03 INFO - Running post-action listener: _resource_record_post_action 09:29:03 INFO - [mozharness: 2017-04-07 16:29:03.434677Z] Finished populate-webroot step (success) 09:29:03 INFO - [mozharness: 2017-04-07 16:29:03.434766Z] Running create-virtualenv step. 09:29:03 INFO - Running pre-action listener: _resource_record_pre_action 09:29:03 INFO - Running main action method: create_virtualenv 09:29:03 INFO - Creating virtualenv /builds/slave/test/build/venv 09:29:03 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 09:29:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:29:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:29:03 INFO - Using real prefix '/usr' 09:29:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:29:04 INFO - Installing distribute.............................................................................................................................................................................................done. 09:29:05 INFO - Installing pip.................done. 09:29:06 INFO - Return code: 0 09:29:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:29:06 INFO - Reading from file tmpfile_stdout 09:29:06 INFO - Output received: 09:29:06 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) 09:29:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x204b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2048400>, '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 0x20493b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2049840>, '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': 'ea65d483da93c827905c2090000001f5-1491582509.690638-893653871', '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 09:29:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:29:06 INFO - Using env: {'DISPLAY': ':0', 09:29:06 INFO - 'HOME': '/home/cltbld', 09:29:06 INFO - 'LANG': 'en_US.UTF-8', 09:29:06 INFO - 'LANGUAGE': 'en_US:en', 09:29:06 INFO - 'LOGNAME': 'cltbld', 09:29:06 INFO - 'MAIL': '/var/mail/cltbld', 09:29:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:06 INFO - 'MOZ_NO_REMOTE': '1', 09:29:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:06 INFO - 'NO_EM_RESTART': '1', 09:29:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:06 INFO - 'PWD': '/builds/slave/test', 09:29:06 INFO - 'SHELL': '/bin/bash', 09:29:06 INFO - 'SHLVL': '1', 09:29:06 INFO - 'TERM': 'linux', 09:29:06 INFO - 'TMOUT': '86400', 09:29:06 INFO - 'USER': 'cltbld', 09:29:06 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1491582509.690638-893653871', 09:29:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:06 INFO - '_': '/tools/buildbot/bin/python'} 09:29:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:06 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 09:29:06 INFO - Cleaning up... 09:29:06 INFO - Return code: 0 09:29:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1dad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x204b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2048400>, '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 0x20493b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2049840>, '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': 'ea65d483da93c827905c2090000001f5-1491582509.690638-893653871', '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 09:29:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:29:06 INFO - Using env: {'DISPLAY': ':0', 09:29:06 INFO - 'HOME': '/home/cltbld', 09:29:06 INFO - 'LANG': 'en_US.UTF-8', 09:29:06 INFO - 'LANGUAGE': 'en_US:en', 09:29:06 INFO - 'LOGNAME': 'cltbld', 09:29:06 INFO - 'MAIL': '/var/mail/cltbld', 09:29:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:06 INFO - 'MOZ_NO_REMOTE': '1', 09:29:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:06 INFO - 'NO_EM_RESTART': '1', 09:29:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:06 INFO - 'PWD': '/builds/slave/test', 09:29:06 INFO - 'SHELL': '/bin/bash', 09:29:06 INFO - 'SHLVL': '1', 09:29:06 INFO - 'TERM': 'linux', 09:29:06 INFO - 'TMOUT': '86400', 09:29:06 INFO - 'USER': 'cltbld', 09:29:06 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1491582509.690638-893653871', 09:29:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:06 INFO - '_': '/tools/buildbot/bin/python'} 09:29:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:06 INFO - Downloading/unpacking psutil>=3.1.1 09:29:06 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 09:29:06 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 09:29:06 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 09:29:06 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 09:29:06 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 09:29:06 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 09:29:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:29:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:29:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:29:08 INFO - Installing collected packages: psutil 09:29:08 INFO - Running setup.py install for psutil 09:29:08 INFO - building 'psutil._psutil_linux' extension 09:29:08 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 09:29:09 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 09:29:09 INFO - building 'psutil._psutil_posix' extension 09:29:09 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 09:29:09 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 09:29:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:29:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:29:09 INFO - Successfully installed psutil 09:29:09 INFO - Cleaning up... 09:29:09 INFO - Return code: 0 09:29:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:29:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x204b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2048400>, '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 0x20493b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2049840>, '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': 'ea65d483da93c827905c2090000001f5-1491582509.690638-893653871', '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 09:29:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:29:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:29:09 INFO - Using env: {'DISPLAY': ':0', 09:29:09 INFO - 'HOME': '/home/cltbld', 09:29:09 INFO - 'LANG': 'en_US.UTF-8', 09:29:09 INFO - 'LANGUAGE': 'en_US:en', 09:29:09 INFO - 'LOGNAME': 'cltbld', 09:29:09 INFO - 'MAIL': '/var/mail/cltbld', 09:29:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:09 INFO - 'MOZ_NO_REMOTE': '1', 09:29:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:09 INFO - 'NO_EM_RESTART': '1', 09:29:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:09 INFO - 'PWD': '/builds/slave/test', 09:29:09 INFO - 'SHELL': '/bin/bash', 09:29:09 INFO - 'SHLVL': '1', 09:29:09 INFO - 'TERM': 'linux', 09:29:09 INFO - 'TMOUT': '86400', 09:29:09 INFO - 'USER': 'cltbld', 09:29:09 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1491582509.690638-893653871', 09:29:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:09 INFO - '_': '/tools/buildbot/bin/python'} 09:29:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:29:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:29:11 INFO - Installing collected packages: mozsystemmonitor 09:29:11 INFO - Running setup.py install for mozsystemmonitor 09:29:11 INFO - Successfully installed mozsystemmonitor 09:29:11 INFO - Cleaning up... 09:29:11 INFO - Return code: 0 09:29:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:29:11 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')]} 09:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:11 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')]} 09:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:11 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 0x1dad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x204b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2048400>, '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 0x20493b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2049840>, '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': 'ea65d483da93c827905c2090000001f5-1491582509.690638-893653871', '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 09:29:11 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 09:29:11 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 09:29:11 INFO - Using env: {'DISPLAY': ':0', 09:29:11 INFO - 'HOME': '/home/cltbld', 09:29:11 INFO - 'LANG': 'en_US.UTF-8', 09:29:11 INFO - 'LANGUAGE': 'en_US:en', 09:29:11 INFO - 'LOGNAME': 'cltbld', 09:29:11 INFO - 'MAIL': '/var/mail/cltbld', 09:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:11 INFO - 'MOZ_NO_REMOTE': '1', 09:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:11 INFO - 'NO_EM_RESTART': '1', 09:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:11 INFO - 'PWD': '/builds/slave/test', 09:29:11 INFO - 'SHELL': '/bin/bash', 09:29:11 INFO - 'SHLVL': '1', 09:29:11 INFO - 'TERM': 'linux', 09:29:11 INFO - 'TMOUT': '86400', 09:29:11 INFO - 'USER': 'cltbld', 09:29:11 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1491582509.690638-893653871', 09:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:11 INFO - '_': '/tools/buildbot/bin/python'} 09:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:12 INFO - Downloading/unpacking jsonschema==2.5.1 09:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:29:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:14 INFO - Downloading functools32-3.2.3-2.tar.gz 09:29:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:29:14 INFO - warning: no files found matching '*.txt' 09:29:14 INFO - no previously-included directories found matching 'build' 09:29:14 INFO - no previously-included directories found matching 'dist' 09:29:14 INFO - no previously-included directories found matching '.git*' 09:29:14 INFO - Installing collected packages: jsonschema, functools32 09:29:14 INFO - Running setup.py install for functools32 09:29:14 INFO - warning: no files found matching '*.txt' 09:29:14 INFO - no previously-included directories found matching 'build' 09:29:14 INFO - no previously-included directories found matching 'dist' 09:29:14 INFO - no previously-included directories found matching '.git*' 09:29:14 INFO - Successfully installed jsonschema functools32 09:29:14 INFO - Cleaning up... 09:29:14 INFO - Return code: 0 09:29:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:29:14 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')]} 09:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:14 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')]} 09:29:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:14 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 0x1dad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x204b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2048400>, '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 0x20493b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2049840>, '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': 'ea65d483da93c827905c2090000001f5-1491582509.690638-893653871', '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 09:29:14 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 09:29:14 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 09:29:14 INFO - Using env: {'DISPLAY': ':0', 09:29:14 INFO - 'HOME': '/home/cltbld', 09:29:14 INFO - 'LANG': 'en_US.UTF-8', 09:29:14 INFO - 'LANGUAGE': 'en_US:en', 09:29:14 INFO - 'LOGNAME': 'cltbld', 09:29:14 INFO - 'MAIL': '/var/mail/cltbld', 09:29:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:14 INFO - 'MOZ_NO_REMOTE': '1', 09:29:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:14 INFO - 'NO_EM_RESTART': '1', 09:29:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:14 INFO - 'PWD': '/builds/slave/test', 09:29:14 INFO - 'SHELL': '/bin/bash', 09:29:14 INFO - 'SHLVL': '1', 09:29:14 INFO - 'TERM': 'linux', 09:29:14 INFO - 'TMOUT': '86400', 09:29:14 INFO - 'USER': 'cltbld', 09:29:14 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1491582509.690638-893653871', 09:29:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:14 INFO - '_': '/tools/buildbot/bin/python'} 09:29:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:29:14 INFO - Cleaning up... 09:29:14 INFO - Return code: 0 09:29:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:29:14 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')]} 09:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:14 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')]} 09:29:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:14 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 0x1dad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x204b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2048400>, '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 0x20493b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2049840>, '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': 'ea65d483da93c827905c2090000001f5-1491582509.690638-893653871', '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 09:29:14 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 09:29:14 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 09:29:14 INFO - Using env: {'DISPLAY': ':0', 09:29:14 INFO - 'HOME': '/home/cltbld', 09:29:14 INFO - 'LANG': 'en_US.UTF-8', 09:29:14 INFO - 'LANGUAGE': 'en_US:en', 09:29:14 INFO - 'LOGNAME': 'cltbld', 09:29:14 INFO - 'MAIL': '/var/mail/cltbld', 09:29:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:14 INFO - 'MOZ_NO_REMOTE': '1', 09:29:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:14 INFO - 'NO_EM_RESTART': '1', 09:29:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:14 INFO - 'PWD': '/builds/slave/test', 09:29:14 INFO - 'SHELL': '/bin/bash', 09:29:14 INFO - 'SHLVL': '1', 09:29:14 INFO - 'TERM': 'linux', 09:29:14 INFO - 'TMOUT': '86400', 09:29:14 INFO - 'USER': 'cltbld', 09:29:14 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1491582509.690638-893653871', 09:29:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:14 INFO - '_': '/tools/buildbot/bin/python'} 09:29:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:15 INFO - Downloading/unpacking blobuploader==1.2.4 09:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:17 INFO - Downloading blobuploader-1.2.4.tar.gz 09:29:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:29:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:29:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:17 INFO - Downloading docopt-0.6.1.tar.gz 09:29:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:29:17 INFO - Installing collected packages: blobuploader, requests, docopt 09:29:17 INFO - Running setup.py install for blobuploader 09:29:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:29:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:29:17 INFO - Running setup.py install for requests 09:29:18 INFO - Running setup.py install for docopt 09:29:18 INFO - Successfully installed blobuploader requests docopt 09:29:18 INFO - Cleaning up... 09:29:18 INFO - Return code: 0 09:29:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:29:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:18 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 0x1dad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x204b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2048400>, '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 0x20493b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2049840>, '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': 'ea65d483da93c827905c2090000001f5-1491582509.690638-893653871', '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 09:29:18 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 09:29:18 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 09:29:18 INFO - Using env: {'DISPLAY': ':0', 09:29:18 INFO - 'HOME': '/home/cltbld', 09:29:18 INFO - 'LANG': 'en_US.UTF-8', 09:29:18 INFO - 'LANGUAGE': 'en_US:en', 09:29:18 INFO - 'LOGNAME': 'cltbld', 09:29:18 INFO - 'MAIL': '/var/mail/cltbld', 09:29:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:18 INFO - 'MOZ_NO_REMOTE': '1', 09:29:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:18 INFO - 'NO_EM_RESTART': '1', 09:29:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:18 INFO - 'PWD': '/builds/slave/test', 09:29:18 INFO - 'SHELL': '/bin/bash', 09:29:18 INFO - 'SHLVL': '1', 09:29:18 INFO - 'TERM': 'linux', 09:29:18 INFO - 'TMOUT': '86400', 09:29:18 INFO - 'USER': 'cltbld', 09:29:18 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1491582509.690638-893653871', 09:29:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:18 INFO - '_': '/tools/buildbot/bin/python'} 09:29:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:29:18 INFO - Running setup.py (path:/tmp/pip-LkHe62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:29:18 INFO - Running setup.py (path:/tmp/pip-5nZnwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:29:18 INFO - Running setup.py (path:/tmp/pip-Z5p8c5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:29:18 INFO - Running setup.py (path:/tmp/pip-xfexB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:29:19 INFO - Running setup.py (path:/tmp/pip-cO7MO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:29:19 INFO - Running setup.py (path:/tmp/pip-alenbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:29:19 INFO - Running setup.py (path:/tmp/pip-xK5S35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:29:19 INFO - Running setup.py (path:/tmp/pip-MD8jpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:29:19 INFO - Running setup.py (path:/tmp/pip-5lwYa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:29:19 INFO - Running setup.py (path:/tmp/pip-G5B5Ku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:29:19 INFO - Running setup.py (path:/tmp/pip-kqNBmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:29:19 INFO - Running setup.py (path:/tmp/pip-gXJS3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:29:19 INFO - Running setup.py (path:/tmp/pip-V8AR6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:29:19 INFO - Running setup.py (path:/tmp/pip-daJcsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:29:19 INFO - Running setup.py (path:/tmp/pip-AWkF2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:29:19 INFO - Running setup.py (path:/tmp/pip-aD2cR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:29:19 INFO - Running setup.py (path:/tmp/pip-IUbYaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:29:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:29:19 INFO - Running setup.py install for manifestparser 09:29:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:29:20 INFO - Running setup.py install for mozcrash 09:29:20 INFO - Running setup.py install for mozdebug 09:29:20 INFO - Running setup.py install for mozdevice 09:29:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:29:20 INFO - Running setup.py install for mozfile 09:29:20 INFO - Running setup.py install for mozhttpd 09:29:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:29:20 INFO - Running setup.py install for mozinfo 09:29:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:29:20 INFO - Running setup.py install for mozInstall 09:29:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:29:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:29:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:29:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:29:20 INFO - Running setup.py install for mozleak 09:29:20 INFO - Running setup.py install for mozlog 09:29:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:29:20 INFO - Running setup.py install for moznetwork 09:29:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:29:21 INFO - Running setup.py install for mozprocess 09:29:21 INFO - Running setup.py install for mozprofile 09:29:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:29:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:29:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:29:21 INFO - Running setup.py install for mozrunner 09:29:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:29:21 INFO - Running setup.py install for mozscreenshot 09:29:21 INFO - Running setup.py install for moztest 09:29:21 INFO - Running setup.py install for mozversion 09:29:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:29:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:29:21 INFO - Cleaning up... 09:29:21 INFO - Return code: 0 09:29:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:29:21 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')]} 09:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:21 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')]} 09:29:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:21 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 0x1dad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x204b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2048400>, '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 0x20493b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2049840>, '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': 'ea65d483da93c827905c2090000001f5-1491582509.690638-893653871', '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 09:29:21 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 09:29:21 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 09:29:21 INFO - Using env: {'DISPLAY': ':0', 09:29:21 INFO - 'HOME': '/home/cltbld', 09:29:21 INFO - 'LANG': 'en_US.UTF-8', 09:29:21 INFO - 'LANGUAGE': 'en_US:en', 09:29:21 INFO - 'LOGNAME': 'cltbld', 09:29:21 INFO - 'MAIL': '/var/mail/cltbld', 09:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:21 INFO - 'MOZ_NO_REMOTE': '1', 09:29:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:21 INFO - 'NO_EM_RESTART': '1', 09:29:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:21 INFO - 'PWD': '/builds/slave/test', 09:29:21 INFO - 'SHELL': '/bin/bash', 09:29:21 INFO - 'SHLVL': '1', 09:29:21 INFO - 'TERM': 'linux', 09:29:21 INFO - 'TMOUT': '86400', 09:29:21 INFO - 'USER': 'cltbld', 09:29:21 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1491582509.690638-893653871', 09:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:21 INFO - '_': '/tools/buildbot/bin/python'} 09:29:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:29:22 INFO - Running setup.py (path:/tmp/pip-dOO1NB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:29:22 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)) 09:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:29:22 INFO - Running setup.py (path:/tmp/pip-7DzhGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:29:22 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)) 09:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:29:22 INFO - Running setup.py (path:/tmp/pip-gjiNbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:29:22 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)) 09:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:29:22 INFO - Running setup.py (path:/tmp/pip-IYfTYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:29:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:29:22 INFO - Running setup.py (path:/tmp/pip-ZdJJmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:29:22 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)) 09:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:29:22 INFO - Running setup.py (path:/tmp/pip-TqBog8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:29:22 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)) 09:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:29:22 INFO - Running setup.py (path:/tmp/pip-pj8RI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:29:22 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)) 09:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:29:22 INFO - Running setup.py (path:/tmp/pip-yNzxjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:29:22 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)) 09:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:29:22 INFO - Running setup.py (path:/tmp/pip-CQeA0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:29:22 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)) 09:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:29:22 INFO - Running setup.py (path:/tmp/pip-qPbVu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:29:22 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)) 09:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:29:22 INFO - Running setup.py (path:/tmp/pip-_RulFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:29:22 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)) 09:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:29:22 INFO - Running setup.py (path:/tmp/pip-hsn7Ta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:29:23 INFO - Running setup.py (path:/tmp/pip-k_dAsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:29:23 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)) 09:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:29:23 INFO - Running setup.py (path:/tmp/pip-zddFSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:29:23 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)) 09:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:29:23 INFO - Running setup.py (path:/tmp/pip-vUe6m4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:29:23 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)) 09:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:29:23 INFO - Running setup.py (path:/tmp/pip-yLPsE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:29:23 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)) 09:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:29:23 INFO - Running setup.py (path:/tmp/pip-u6yirh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:29:23 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)) 09:29:23 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)) 09:29:23 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)) 09:29:23 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)) 09:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:29:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:29:23 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 09:29:23 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 09:29:23 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 09:29:23 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 09:29:23 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 09:29:23 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 09:29:26 INFO - Downloading blessings-1.6.tar.gz 09:29:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:29:26 INFO - Installing collected packages: blessings 09:29:26 INFO - Running setup.py install for blessings 09:29:26 INFO - Successfully installed blessings 09:29:26 INFO - Cleaning up... 09:29:26 INFO - Return code: 0 09:29:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:29:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:29:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:29:26 INFO - Reading from file tmpfile_stdout 09:29:26 INFO - Current package versions: 09:29:26 INFO - argparse == 1.2.1 09:29:26 INFO - blessings == 1.6 09:29:26 INFO - blobuploader == 1.2.4 09:29:26 INFO - docopt == 0.6.1 09:29:26 INFO - functools32 == 3.2.3-2 09:29:26 INFO - jsonschema == 2.5.1 09:29:26 INFO - manifestparser == 1.1 09:29:26 INFO - mozInstall == 1.12 09:29:26 INFO - mozcrash == 1.0 09:29:26 INFO - mozdebug == 0.1 09:29:26 INFO - mozdevice == 0.50 09:29:26 INFO - mozfile == 1.2 09:29:26 INFO - mozhttpd == 0.7 09:29:26 INFO - mozinfo == 0.9 09:29:26 INFO - mozleak == 0.1 09:29:26 INFO - mozlog == 3.4 09:29:26 INFO - moznetwork == 0.27 09:29:26 INFO - mozprocess == 0.25 09:29:26 INFO - mozprofile == 0.28 09:29:26 INFO - mozrunner == 6.13 09:29:26 INFO - mozscreenshot == 0.1 09:29:26 INFO - mozsystemmonitor == 0.3 09:29:26 INFO - moztest == 0.8 09:29:26 INFO - mozversion == 1.4 09:29:26 INFO - psutil == 3.1.1 09:29:26 INFO - requests == 1.2.3 09:29:26 INFO - wsgiref == 0.1.2 09:29:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:29:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:26 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 0x1dad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x204b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2048400>, '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 0x20493b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2049840>, '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': 'ea65d483da93c827905c2090000001f5-1491582509.690638-893653871', '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 09:29:26 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 09:29:26 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 09:29:26 INFO - Using env: {'DISPLAY': ':0', 09:29:26 INFO - 'HOME': '/home/cltbld', 09:29:26 INFO - 'LANG': 'en_US.UTF-8', 09:29:26 INFO - 'LANGUAGE': 'en_US:en', 09:29:26 INFO - 'LOGNAME': 'cltbld', 09:29:26 INFO - 'MAIL': '/var/mail/cltbld', 09:29:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:26 INFO - 'MOZ_NO_REMOTE': '1', 09:29:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:26 INFO - 'NO_EM_RESTART': '1', 09:29:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:26 INFO - 'PWD': '/builds/slave/test', 09:29:26 INFO - 'SHELL': '/bin/bash', 09:29:26 INFO - 'SHLVL': '1', 09:29:26 INFO - 'TERM': 'linux', 09:29:26 INFO - 'TMOUT': '86400', 09:29:26 INFO - 'USER': 'cltbld', 09:29:26 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1491582509.690638-893653871', 09:29:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:26 INFO - '_': '/tools/buildbot/bin/python'} 09:29:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:27 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)) 09:29:27 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)) 09:29:27 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)) 09:29:27 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)) 09:29:27 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)) 09:29:27 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)) 09:29:27 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)) 09:29:27 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)) 09:29:27 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)) 09:29:27 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)) 09:29:27 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)) 09:29:27 INFO - Cleaning up... 09:29:27 INFO - Return code: 0 09:29:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x204b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2048400>, '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 0x20493b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2049840>, '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': 'ea65d483da93c827905c2090000001f5-1491582509.690638-893653871', '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 09:29:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:29:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:29:27 INFO - Using env: {'DISPLAY': ':0', 09:29:27 INFO - 'HOME': '/home/cltbld', 09:29:27 INFO - 'LANG': 'en_US.UTF-8', 09:29:27 INFO - 'LANGUAGE': 'en_US:en', 09:29:27 INFO - 'LOGNAME': 'cltbld', 09:29:27 INFO - 'MAIL': '/var/mail/cltbld', 09:29:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:27 INFO - 'MOZ_NO_REMOTE': '1', 09:29:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:27 INFO - 'NO_EM_RESTART': '1', 09:29:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:27 INFO - 'PWD': '/builds/slave/test', 09:29:27 INFO - 'SHELL': '/bin/bash', 09:29:27 INFO - 'SHLVL': '1', 09:29:27 INFO - 'TERM': 'linux', 09:29:27 INFO - 'TMOUT': '86400', 09:29:27 INFO - 'USER': 'cltbld', 09:29:27 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1491582509.690638-893653871', 09:29:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:27 INFO - '_': '/tools/buildbot/bin/python'} 09:29:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:29:27 INFO - Cleaning up... 09:29:27 INFO - Return code: 0 09:29:27 INFO - Running post-action listener: _resource_record_post_action 09:29:27 INFO - Running post-action listener: _start_resource_monitoring 09:29:27 INFO - Starting resource monitoring. 09:29:27 INFO - [mozharness: 2017-04-07 16:29:27.452419Z] Finished create-virtualenv step (success) 09:29:27 INFO - [mozharness: 2017-04-07 16:29:27.452929Z] Running install step. 09:29:27 INFO - Running pre-action listener: _resource_record_pre_action 09:29:27 INFO - Running main action method: install 09:29:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:29:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:29:27 INFO - Reading from file tmpfile_stdout 09:29:27 INFO - Detecting whether we're running mozinstall >=1.0... 09:29:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:29:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:29:27 INFO - Reading from file tmpfile_stdout 09:29:27 INFO - Output received: 09:29:27 INFO - Usage: mozinstall [options] installer 09:29:27 INFO - Options: 09:29:27 INFO - -h, --help show this help message and exit 09:29:27 INFO - -d DEST, --destination=DEST 09:29:27 INFO - Directory to install application into. [default: 09:29:27 INFO - "/builds/slave/test"] 09:29:27 INFO - --app=APP Application being installed. [default: firefox] 09:29:27 INFO - mkdir: /builds/slave/test/build/application 09:29:27 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'] 09:29:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:29:42 INFO - Reading from file tmpfile_stdout 09:29:42 INFO - Output received: 09:29:42 INFO - /builds/slave/test/build/application/firefox/firefox 09:29:42 INFO - Running post-action listener: _resource_record_post_action 09:29:42 INFO - [mozharness: 2017-04-07 16:29:42.901179Z] Finished install step (success) 09:29:42 INFO - [mozharness: 2017-04-07 16:29:42.901481Z] Running run-tests step. 09:29:42 INFO - Running pre-action listener: _resource_record_pre_action 09:29:42 INFO - Running main action method: run_tests 09:29:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:29:42 INFO - Python 2.7.3 09:29:42 INFO - Return code: 0 09:29:42 INFO - grabbing minidump binary from tooltool 09:29:42 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')]} 09:29:42 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 0x2048400>, '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 0x20493b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2049840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:29:42 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 09:29:42 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 09:29:42 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 09:29:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:29:42 INFO - Return code: 0 09:29:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:29:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:29:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:29:42 INFO - ENV: RUST_BACKTRACE is now 1 09:29:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:29:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:29:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--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 09:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-084 --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 09:29:42 INFO - Using env: {'DISPLAY': ':0', 09:29:42 INFO - 'HOME': '/home/cltbld', 09:29:42 INFO - 'LANG': 'en_US.UTF-8', 09:29:42 INFO - 'LANGUAGE': 'en_US:en', 09:29:42 INFO - 'LOGNAME': 'cltbld', 09:29:42 INFO - 'MAIL': '/var/mail/cltbld', 09:29:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:29:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:42 INFO - 'MOZ_NO_REMOTE': '1', 09:29:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:42 INFO - 'NO_EM_RESTART': '1', 09:29:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:42 INFO - 'PWD': '/builds/slave/test', 09:29:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:29:42 INFO - 'RUST_BACKTRACE': '1', 09:29:42 INFO - 'SHELL': '/bin/bash', 09:29:42 INFO - 'SHLVL': '1', 09:29:42 INFO - 'TERM': 'linux', 09:29:42 INFO - 'TMOUT': '86400', 09:29:42 INFO - 'USER': 'cltbld', 09:29:42 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1491582509.690638-893653871', 09:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:42 INFO - '_': '/tools/buildbot/bin/python'} 09:29:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--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 09:29:43 INFO - mozversion application_buildid: 20170407155236 09:29:43 INFO - mozversion application_changeset: 22df0c5cfbf8a2aa2822bf9c763e6c1c5a3f69de 09:29:43 INFO - mozversion application_display_name: Nightly 09:29:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:29:43 INFO - mozversion application_name: Firefox 09:29:43 INFO - mozversion application_remotingname: firefox 09:29:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:29:43 INFO - mozversion application_vendor: Mozilla 09:29:43 INFO - mozversion application_version: 55.0a1 09:29:43 INFO - mozversion platform_buildid: 20170407155236 09:29:43 INFO - mozversion platform_changeset: 22df0c5cfbf8a2aa2822bf9c763e6c1c5a3f69de 09:29:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:29:43 INFO - mozversion platform_version: 55.0a1 09:29:43 INFO - using testdate: 1491582583 09:29:43 INFO - actual date: 1491582583 09:29:43 INFO - starting webserver on 'localhost:42258' 09:29:43 INFO - SUITE-START | Running 2 tests 09:29:43 INFO - TEST-START | dromaeo_css 09:29:43 INFO - operating with platform_type : linux_ 09:29:43 INFO - Initialising browser for dromaeo_css test... 09:29:43 INFO - TEST-INFO | started process 534 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuzqBhz/profile http://localhost:42258/getInfo.html) 09:29:47 INFO - PID 534 | __metrics Screen width/height:1600/1200 09:29:47 INFO - PID 534 | colorDepth:24 09:29:47 INFO - PID 534 | Browser inner width/height: 1024/697 09:29:47 INFO - PID 534 | __metrics 09:29:48 INFO - PID 534 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:29:48 INFO - PID 534 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:29:49 INFO - TEST-INFO | 534: exit 0 09:29:49 INFO - Browser initialized. 09:29:49 INFO - Running cycle 1/1 for dromaeo_css test... 09:29:49 INFO - TEST-INFO | started process 639 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuzqBhz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:30:02 INFO - PID 639 | RSS: Main: 171229184 09:30:02 INFO - PID 639 | 09:33:09 INFO - PID 639 | Cycle 1(1): loaded http://localhost:42258/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42258/tests/dromaeo/cssquery-ext.html) 09:33:11 INFO - PID 639 | RSS: Main: 334950400 09:33:11 INFO - PID 639 | 09:34:52 INFO - PID 639 | ************************* 09:34:52 INFO - PID 639 | A coding exception was thrown and uncaught in a Task. 09:34:52 INFO - PID 639 | 09:34:52 ERROR - PID 639 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:34:52 INFO - PID 639 | Full stack: 09:34:52 INFO - PID 639 | ************************* 09:34:52 INFO - PID 639 | ************************* 09:34:52 INFO - PID 639 | A coding exception was thrown and uncaught in a Task. 09:34:52 INFO - PID 639 | 09:34:52 ERROR - PID 639 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:34:52 INFO - PID 639 | Full stack: 09:34:52 INFO - PID 639 | ************************* 09:34:52 INFO - PID 639 | ************************* 09:34:52 INFO - PID 639 | A coding exception was thrown and uncaught in a Task. 09:34:52 INFO - PID 639 | 09:34:52 ERROR - PID 639 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:34:52 INFO - PID 639 | Full stack: 09:34:52 INFO - PID 639 | ************************* 09:34:52 INFO - PID 639 | ************************* 09:34:52 INFO - PID 639 | A coding exception was thrown and uncaught in a Task. 09:34:52 INFO - PID 639 | 09:34:52 ERROR - PID 639 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:34:52 INFO - PID 639 | Full stack: 09:34:52 INFO - PID 639 | ************************* 09:36:14 INFO - PID 639 | Cycle 1(1): loaded http://localhost:42258/tests/dromaeo/cssquery-ext.html (next: http://localhost:42258/tests/dromaeo/cssquery-jquery.html) 09:36:14 INFO - PID 639 | RSS: Main: 263254016 09:36:14 INFO - PID 639 | 09:39:16 INFO - PID 639 | Cycle 1(1): loaded http://localhost:42258/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42258/tests/dromaeo/cssquery-mootools.html) 09:39:17 INFO - PID 639 | RSS: Main: 204812288 09:39:17 INFO - PID 639 | 09:42:19 INFO - PID 639 | Cycle 1(1): loaded http://localhost:42258/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42258/tests/dromaeo/cssquery-prototype.html) 09:42:20 INFO - PID 639 | RSS: Main: 233172992 09:42:20 INFO - PID 639 | 09:45:23 INFO - PID 639 | Cycle 1(1): loaded http://localhost:42258/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42258/tests/dromaeo/cssquery-yui.html) 09:45:24 INFO - PID 639 | RSS: Main: 216219648 09:45:24 INFO - PID 639 | 09:48:27 INFO - PID 639 | Cycle 1(1): loaded http://localhost:42258/tests/dromaeo/cssquery-yui.html (next: http://localhost:42258/tests/dromaeo/cssquery-dojo.html) 09:48:27 INFO - PID 639 | RSS: Main: 292823040 09:48:27 INFO - PID 639 | 09:48:27 INFO - PID 639 | __start_tp_report 09:48:27 INFO - PID 639 | _x_x_mozilla_page_load 09:48:27 INFO - PID 639 | _x_x_mozilla_page_load_details 09:48:27 INFO - PID 639 | |i|pagename|runs| 09:48:27 INFO - PID 639 | |0;dojo.html;2722.264988453118;2751.9724802751966;2787.7212278772126;2788.1356779398375;2801.915942521724;5142.382914050309;5254.080535906211;5286.365636123665;5306.044911915858;5358.169483730018;5263.0000299942985;5306.018386598473;5313.070212712779;5363.007843548937;5370.355557333116;4595.264757638778;4645.001324715194;4663.65022623303;4723.976380118094;4759.095771803363;4661.930071048937;4676.275177347499;4687.90624187516;4738.076075165344;4789.616830653539;4595.609373203281;4657.371254880582;4662.254039353687;4668.276417155313;4671.182543054952;4691.741954192552;4693.7653117344;4695.530446955311;4698.812047518095;4703.905921881543;4605.447346318463;4642.442906851165;4656.045510670305;4659.254519276899;4667.673262871566;5150.48495150482;5214.322138122057;5228.08508511009;5230.215467679878;5232.790688372461;5724.284464441945;5732.226149469851;5732.31212254528;5734.512566431858;5736.2256095427;5674.375818659944;5726.742296596663;5764.365919748824;5779.479846813765;5785.913211301834;5332.626716129911;5337;5354.518093371616;5401.7299135043095;5407.324084489439;5962.612430192024;5974.671393073336;5977.342492325841;5978.372270911578;5987.072003839412;5525.944740552623;5588.776448942078;5593.216949627055;5595.38450770415;5597.160425936142;5730;5737.627054241461;5804.419558044162;5809.8547536311935;5818.389069147678;5716.142578613241;5732.398098199712;5741.25363702716;5767.221425107557;5780.768769249267;5513.669179849222;5565.526930210896;5567.972160139255;5706.514946229617;5706.71466426677;4874.634402419832;4906.215005599087;4929.433115191727;4945.975270123627;4948.158813001798;4117.032497363177;4125.793710314472;4129.566395528486;4148.253314403376;4169.45797046382;4809.470958194595;4817.108834865491;4818.349522814446;4821.156297647897;4852.0295940811975;5652.293463317085;5666.9716651416475;5711.257536520226;5720.8283751487525;5727.713614319267;4701.271302948048;4750.192467280571;4752.453467851172;4758.405199350082;4766.547178018082;5039.118154323052;5086.92369614456;5090.465501122403;5092.668976516515;5094.541491265803;5244.134717771525;5245.868853278698;5246.973765131303;5247.055530004636;5249.055170069424;5591;5646.463585959327;5703.258576385209;5704.258446401941;5706.258186435737;5192.247124166899;5235.267062611314;5302.257683924331;5352.919706204488;5371.4897084776885;5677.858053548694;5689.886202276014;5694.17434471991;5702.030654788613;5707.514861236676;5767;5770.942290577208;5777.191193233035;5781.682007489629;5784.884302313846;5443.101888188405;5492.890142197213;5505.504504594605;5517.475839795213;5524.8342549723575;5522.0336441123445;5536.833894983157;5567.805126820542;5577.776888924398;5589.385167631476;5434.429384914685;5449.400565937664;5451.400345962021;5451.563874890078;5461.808836690697;5501.174823776466;5558.555315574825;5577.9442205577425;5578.330600327987;5618.971905140448;5354.518093371616;5427.782888684408;5461.836144915659;5468.371137319259;5469.945300546943 09:48:27 INFO - PID 639 | |1;ext.html;667.4293479075391;736.7053178728509;756.928091831276;1086.7772106718119;1103.5089385223578;25906.222813315584;26597;26604.201873943788;26604.733952660466;26605.201843944666;31687.68312316876;32509.83745081277;32523.349533009387;32582.511262331085;32618;7064.434845212397;7188.388986936116;7192.676329565182;7197.568145911262;7209.351158395743;5442.673439593637;5608.5793565482545;7085.2206257311655;7207.24323945986;7225.7470988515415;6989.16130064393;7190.209077001526;7192.604406757626;7194.640267986606;7198.3881370083345;7194.352508274254;7240.493165478419;7241.348278654947;7250.3112204340505;7253.564786112824;5474.233607294982;5638.04153293941;6833.077534532874;6875.278095799919;6948.235694073648;29905.551416728766;30174.69825301741;30191.47127930806;30207.546886796717;30239.697603024128;2943.7203465670727;2977.330100727319;2981.3142977115167;2984.1942675477717;2984.7761417893526;23349.76650233493;23369.532609347887;23370;23391.76608233913;23461;3083.5066389377816;3107.0368185862453;3109.1449851291077;3125.7811953163286;3155.4635711929027;129362.35318823345;129835;130372.3481382587;130417;130431;40726.18547629031;40838.1832363357;40847;40857.1828563433;40909.1818163641;42094.78952605279;42140.78929605394;42187.624990000724;42236.36645450321;42293.78853105715;12007.939960300142;12065.276083435023;12066.129749888782;12069.517219311305;12079.758404831855;9654.903450965541;9656.22750179984;9663;9668.9033109668;9669.516524173763;9870.802583948282;10026.348287361297;11403.828942565868;11494.827577586342;11868.88131118695;4967.40391153064;4997.350344455198;5016.272640467112;5067.569256613156;5096.674864535174;859.8581234096304;891.5364010714392;893.1202765276198;901.170623634024;923.0953665407937;19205.423837284903;19854.10656520431;19859.30492432787;20121.798782011992;20220.89889550572;966.7534778631403;967.2310513142069;972.6255391674256;975.1370037516707;1007.9344842585208;10130.189584833195;10369.325993810378;10481.842772358421;10511.789764204674;10670.25308228432;179323;179497;180041;180206;180266.09866950582;36995.815020924725;37029.25941481155;37101.44347834784;37115;37200.627993720256;1209.5282839692527;1242.1118899986552;1251.9374031298398;1257.6730050187018;1259.3766085787595;18458.907705461388;18822.623547529245;19269;19715.71126739598;19801.504962376057;28111.43777124405;28296.292592684524;28327.71672283333;28352.716472835007;28420.289492762848;176110;176259.11870440567;176376;177443;178089;26742.866285669224;26986;27037.86481067582;27154.1853744388;27196.592051118852;26619.866900665373;31983.36033279275;32562.674373255963;32805.03169809819;32925.50611740874;24279.757202428456;24801.379965501008;25024.874875625505;25858.35354116162;26022;24005;24612;25584.8720756395;25724.09965651193;25753.356166095997;27259.318517037234;27271.727282727712;27394.178174654793;27586.172414827586;28081.859590701915;24040;24302.392440189138;24532.632010520214;24585.385365366008;25422.364440889127;18859.811401885807;20368.28710995108;20394.28619998293;20422.69365959482;20500.077496512393 09:48:27 INFO - PID 639 | |2;jquery.html;392.9057026313682;422.6829877591806;436.4784083020791;439.76692353052886;445.08757048051484;14539;19017.239310427583;19059;20110.798892011077;20239.797602023977;18924.810751892477;19044.904775476138;19306.32427865025;19338.12978415971;19372.321968731096;5513.4210907854595;5703.8574035649235;5704.11586204139;5705.8573535661735;5706.7431965561445;3437.2781715839706;3637.8908632740927;3719.6466335698065;5594.440555944414;5767.769289228426;5706.115552089433;5711.7715291388295;5723.942760572382;5727.570432217601;5727.914081288784;5503.284573005523;5704.65772053676;5719.656820590736;5721.370649228582;5756.740946657411;5224.555912747421;5239.842804715865;5249.947500524984;5256.921146182772;5258.474152584749;23538.882305588533;24442.755572444225;24446.388840278956;24494.755052449604;24528.754712453003;1649.8432648898336;1683.4108062178261;1683.5791052236941;1685.401682402754;1686.6795308891271;13755.724885502234;14872.256387180598;15198;15201;15386.307616157188;1967.4687834284807;2026.9087891044792;2045.5295282085056;2071.6685330347223;2087.2277257414853;91104;91348.54325728395;91454.54272728594;91514.5424272881;91552.08447915569;9757.853632195523;11014.339139651647;11190.272632278877;11283.94358028221;11615.88384116148;14378.784318235235;34682;36196.638033619856;36261;36505.81747091247;9054.773630659154;9166.770830729285;9218.308626853013;9333.673321433716;9451.29115316354;6783.18601767791;6909.516333856582;7296.16094149169;7430.925690743024;7566.5460072394735;9643.566039528097;9646.517674116267;9775.951120244354;9817.263705222136;10064.245181611263;3556.893293201208;3811.8856434307013;3914.6868250539887;4047.251258517184;4121.9587804122175;811.3347055414504;841.5918279634373;860.2214995429147;868.5483548554716;880.0978996528481;16841.242144103544;16922;17399.652006960045;17651.911740441472;17855.464336069937;886.2555453419159;889.6797153024905;898.9460632362079;911.4030310146732;917.2111983694018;9193.218576420946;9368;9630.133288004114;9641.228701703847;9709.875164420648;489834;494347;511132;511167;511444;92671;93724;93884;94466.52766736122;94702.52648736713;1072.7961687279549;1082.4317233452343;1091.2961140064615;1095.687728997232;1099.142668718401;14265.714685706434;16900.66198675995;19157.425277241706;19168.424947251606;19271.444185477772;43798;44661.330080049476;45024.47145163998;45405.09189816119;45686.314705280114;52953.20570191527;53748.73125634503;53924;54147.458525414244;56150.71924640514;7265.491415600857;7319.890201646873;7379.3358597726465;7494.55032698018;7580.54516728998;11135.944320278346;11554.191206615793;11663.24188927717;11967;12084.45619947087;10037.5483103262;10403.479826008517;10535.736606584896;10648.627298044532;10875.891241087804;9514.096160864707;9582.137607615348;9805.558749856416;9865.704028879145;9979.10188083076;9748.317617766688;9751.219902407933;9841;9882.851757223503;9954.651587194703;7731.188225236269;7888.2506161914525;7965.641546130322;7966.1237263902085;8115.918840811516;10031.197504199501;10080.445575493124;10118.797624047626;10126.949365253127;10235.385876847413 09:48:27 INFO - PID 639 | |3;mootools.html;1292.9353532323382;1342.3355439057668;1368.466298143724;1368.7262547490502;1369.7671395862703;10096;10565.894341056588;10567.735806604838;10568.365898046122;10569.207309451802;9846.359986600866;10183.236257280696;10260.127889129433;10273.537690803912;10281.177505799536;2289.4390874235837;2324.5931961906686;2326.5928462519078;2327.325075728037;2329.1731435340466;1945.1344151852431;2181.5091604388963;2291.049214575949;2319.9420014499606;2327.429779703975;1914.176903931309;2224.855384400017;2294.472271377584;2308.676785250058;2311.537692461506;2199.8350123740784;2203.063697928382;2208.6355751301016;2209.9005544750526;2211.6461366181334;2064.7935206479383;2080.4798800299927;2081.344376521391;2081.8542702010864;2082.1983536338466;9742.902570974342;9881.110700037032;9920.206383489303;9926.156276716487;9939.155171810406;5725.914111288334;5910.940890591082;5913.438223368773;5917.615355001911;5929.940700592982;3169.144331030609;3341.097903566048;3422.3839708852397;3439.8280085995852;3504.176518518146;1049.6903413493037;1105.1435137768294;1154.8036833738286;1156.7570810129882;1157.4849192109514;15418.306176222097;15612.219389030502;15612.297446614815;15616.453424130215;15623.531294061197;4754.524547545287;4833.202521583899;5027.396712394536;5054.9241761373605;5075.467075956972;10954.287971281841;11007.669769906915;11012.779744405067;11017.944910275397;11036.944815275872;5726.513246374022;5733.655980641175;5735.655860648374;5742.081266997344;5744.425557444306;5241.344831896013;5283.445238250005;5334.759935802898;5340;5405;3842.366009608439;3925.8429662813737;3951.3677811550015;4005.559388467266;4060.147369052532;1169.181572898974;1174.365842445087;1174.3834486894448;1196.611101392051;1212.7938250497436;663.1577896071962;676.9086173366533;684.8732984397902;693.7918624412656;694.1704662927854;5459.2902922619805;5536.972315138399;5622.269105016322;6237.064440333896;6251.531135164881;804.103424681476;821.6179476543437;827.6772058897035;827.6813426830713;845.6110189312985;3493.475978603179;3604.711623070148;3611.5485564304463;3661.35926212917;3833.7316387852584;12701.174423662616;13575;13582.86417135816;13586.796198057036;13732.313384330942;13588.456461741618;13599.320033998261;13691.383887724876;13742.450301987808;13760.724785504433;9346.11211934865;9534.856977145348;9539.570719317648;9568.330216884751;9586.760330991641;5371.919421208763;5389.083855744454;5418.376886658085;5479.835604931858;5569.637973531708;11574.6527604172;11576.36330001858;11627.069834413396;11637.301761894314;11738.88261117412;11720.941395292968;12211.633650990485;12275.140740148105;12290.569830055905;12308.138430310151;7151.499395042505;7292.598907060163;7306.780796576111;7308.451866109956;7334.046573945353;9120.270378369582;9262.16640502358;9412.058794120534;9416.387934784218;9421.905780942103;7885;8065.9596702016115;8067.677292908218;8158.877616835871;8268.669253229804;7764.767056988299;7892.565908875067;7927.088384835587;7957.403194760301;7979.840403191787;7012.929870701228;7154.785356439315;7155.499115061895;7155.892661610184;7158.284171583008;4688.578027977362;4784.808607655655;4835.443923948791;4931.852044438672;4998.500149985118;4760.690555113906;4881.389826271716;4967;5028.170351891897;5032.874178145576 09:48:27 INFO - PID 639 | |4;prototype.html;366.6553439766621;381.4335711468469;405.0562190097074;406.43505527317035;409.26741133371274;5076.416212135606;5184.818531351399;5260.605454590902;5263.394709608397;5274.709890955995;5029.622778291634;5141.562967147797;5179.715115668637;5191.5327620514145;5242.501962313574;4130.3891482321915;4131.442255295527;4146.087860670663;4151.626353628173;4158.958410415888;3949.782761948092;4028.1540876415843;4060.878173654795;4136.689748268876;4145.9999999999845;4108.4864391951005;4122.4640796696385;4125.319322311815;4129.339305711087;4142.523609784883;4102.589741025903;4106.178764247133;4128.60778226068;4131.380292956081;4132.628063474302;3539.50446937429;3554.8044857532827;3737.5141231639986;3758.4926034985474;3766.8304926278383;5027.245913113025;5055.494450554952;5064.949350506521;5067.189249720027;5087.821926232564;4918.508149185089;4922.950770492285;4923.679960802572;4924;4935.259711043373;5408.242846001563;5586.050371436865;5590.105583106683;5614.214010038598;5621.156826476021;4201.159768046403;4224.471941007374;4225.514065882432;4247.978760106211;4249.277622804131;5773.364929857712;5793.725380416302;5796.478316951495;5821.370016395416;5822.272215973004;4275.486941567032;4287.142571485653;4323.740575565476;4356.477222733229;4357.586029327209;4121.567235440296;4213.873583792491;4408.845690400821;4417.851358646775;4440.7335559866515;4736.621070314367;4837.564619184291;4854.17479028566;4858.8785280367565;4871.683340582851;5556.111022236423;5556.805511807067;5576.804811831566;5581.944180558224;5588.161775733673;1496.1148952319938;1513.6896936128066;1520.0271826031349;1520.6806570620072;1536.1013806923074;1078.4607696151925;1098.2970898624887;1105.3699391347016;1106.43571778392;1108.6840250528721;4800.3279540864305;4814.277858321209;4818.445878723922;4818.71087734737;4836;5653.406392328829;5707.143928410688;5722.4277572242445;5740;5750.597458177971;4666.696664716783;4817.8313759018265;4837.637177211724;4838.371011768448;4839.661223714376;2998.310388610632;3029.681883402255;3030.8939187128785;3035.681253468354;3042.939141217163;5276.891852710897;5282.313299271147;5307.150855863043;5310.52205301517;5311.49540793624;5648.350439699487;5861.531077513789;5905.291365036223;5914.526837852962;5929.37741537141;5256.684598924;5288.947110528846;5290.391604965402;5302.1781623848365;5311.150215965427;5491.4492572712525;5737.110747834093;5738.110592858114;5745.224394706661;5758.1650660654805;5569.359523654832;5624.593851537115;5642.887142257214;5655.264815573949;5657.179708942263;5276.551493123127;5277.683338999673;5300.6024548158275;5308.814191503279;5311.601629877698;4235.322348424237;4353.129374125125;4354;4359.564043595742;4362.563743625612;5641.323041234914;5671.461211184931;5681.545476361964;5703.230063941315;5734.627249228787;5490;5492.890142197213;5498.917516237179;5508.752106155152;5514.889702206014;5365;5420.214068960057;5496.7526461308535;5533.557315414838;5548.750306236148;5428.290088622071;5449.891002180014;5453.590980676545;5468.2344471773185;5469.371022332482;5549.38956714753;5555.527780138572;5560.5551555876245;5576.888462230651;5577.510104365862;5217.713025783618;5446.564274858081;5485.862853428536;5487.5884308677805;5492.642978206404 09:48:27 INFO - PID 639 | |5;yui.html;671.4024518178819;694.5138403117812;739.944504162188;764.9961750191248;779.5322806316209;13035.217886926792;13109.67225819355;13438.5296514622;13612.387442565083;13623.863761362383;13040.478380864753;13129.803052954214;13284.402201900913;13285.468581256762;13312.40094195761;684.9931500685004;757.095271150972;900.918917297443;914.6935776514875;915.6337465013982;914.9359544831865;916.2532535983186;924.958376873039;931.9301052421062;938.1884669760642;964.2719746591314;967.5307475874196;967.970960871175;968.1770495079162;968.1915600473613;961.14458132262;968.1722127580888;968.4528241543576;968.7481254873749;971.0192705367594;714.5248409807472;718.7520305494596;718.823888147402;719.6186021408662;720.8594324106801;11771;11782.116341274354;11925.224860384047;11954.222975506564;12280.385980700928;9872.851907221397;9907;9984.600615975352;10300.484975751182;10353.844692329545;10413.114885234763;10530.15758739299;10534.47327633623;10637.840432393443;10715.196360272932;2696.298962269804;2733.316670832292;2733.740294672003;2734.2754170144926;2734.3847634282324;61243;62048;62224.68887655578;62302.37697623057;62740.37259627391;10149.492525373702;10153.441560714231;10204.795904081877;10258.692239232834;10504.789904201873;21047.78952210489;21068.367948961248;21068.473288167614;21170.89414552948;21297.467563311042;6709.530332876652;6709.630970296583;6763;6897.310268973062;6960.234374218832;3162.2094476380903;3286.5563148974584;3322.4684050551796;3323.850426730803;3334.3664703706218;3633.5094762206763;3772.660460558563;3787.507624008861;3789.3368660484307;3816.122291872885;716.1012928774355;717.7667258141125;717.9820504487429;718.9712411503585;724.6123324021623;535.4511625583808;568.2754488027798;586.6949186423121;587.9147523609053;590.9674967876722;7194.892076618855;8092.554909479917;9242.260619150451;9279.62881484733;9533.142017218344;552.2930648769582;574.6035235687445;589.1633879890566;589.339939268014;606.233115109387;4224.471941007374;4470.575295346936;4532.2243246346925;4534.387857639243;4598.770061496979;65332.673336633015;66955.3304466949;68259;69037.3096269031;69067.30932690609;55207.72396137994;55537.722311388185;56120;57127.42872571304;57281;33771.43560093492;39611.60388396079;39966.40050399247;50237;51485.48514514882;7922.445428819928;9039.638414463348;9183.576545635437;9284.814303713752;9320.207782338577;25857.741422585532;26204.475910481302;27413;28093.859530702215;28191.71808281973;42661;44623.553764463235;44962.3255651172;44968.55031449644;45238.321425177994;11695.473703683185;12038.75922481563;12040.11047799142;12177;12646.051546133893;10607.098396636373;11543.88456115428;11893.226940248856;12014.399280036137;12515.249085054926;10771.46142692878;10865.130789536975;10942;11325.71685707864;11401.983690102;11470.4264786762;11868;11951.282923024646;11993.880061199625;12147.574834880737;11290;11326.603568875049;11403.258788178742;11426.771464570827;11501.942490287494;8826.293896488138;8894.510801905957;8970.147835955573;8984.101589840964;9012.41419307743;9139.451632902048;9780.85328720084;9879.209663227068;9942.921920369268;9968.451735154345 09:48:27 INFO - PID 639 | __end_tp_report 09:48:27 INFO - PID 639 | __start_cc_report 09:48:27 INFO - PID 639 | _x_x_mozilla_cycle_collect,1782 09:48:27 INFO - PID 639 | __end_cc_report 09:48:27 INFO - PID 639 | __startTimestamp1491583707363__endTimestamp 09:48:27 INFO - PID 639 | 09:48:27 INFO - PID 639 | ------- Summary: start ------- 09:48:27 INFO - PID 639 | Number of tests: 6 09:48:27 INFO - PID 639 | 09:48:27 INFO - PID 639 | [#0] dojo.html Cycles:165 Average:5214.80 Median:5370.36 stddev:619.44 (11.5%) stddev-sans-first:589.67 09:48:27 INFO - PID 639 | Values: 2722.3 2752.0 2787.7 2788.1 2801.9 5142.4 5254.1 5286.4 5306.0 5358.2 5263.0 5306.0 5313.1 5363.0 5370.4 4595.3 4645.0 4663.7 4724.0 4759.1 4661.9 4676.3 4687.9 4738.1 4789.6 4595.6 4657.4 4662.3 4668.3 4671.2 4691.7 4693.8 4695.5 4698.8 4703.9 4605.4 4642.4 4656.0 4659.3 4667.7 5150.5 5214.3 5228.1 5230.2 5232.8 5724.3 5732.2 5732.3 5734.5 5736.2 5674.4 5726.7 5764.4 5779.5 5785.9 5332.6 5337.0 5354.5 5401.7 5407.3 5962.6 5974.7 5977.3 5978.4 5987.1 5525.9 5588.8 5593.2 5595.4 5597.2 5730.0 5737.6 5804.4 5809.9 5818.4 5716.1 5732.4 5741.3 5767.2 5780.8 5513.7 5565.5 5568.0 5706.5 5706.7 4874.6 4906.2 4929.4 4946.0 4948.2 4117.0 4125.8 4129.6 4148.3 4169.5 4809.5 4817.1 4818.3 4821.2 4852.0 5652.3 5667.0 5711.3 5720.8 5727.7 4701.3 4750.2 4752.5 4758.4 4766.5 5039.1 5086.9 5090.5 5092.7 5094.5 5244.1 5245.9 5247.0 5247.1 5249.1 5591.0 5646.5 5703.3 5704.3 5706.3 5192.2 5235.3 5302.3 5352.9 5371.5 5677.9 5689.9 5694.2 5702.0 5707.5 5767.0 5770.9 5777.2 5781.7 5784.9 5443.1 5492.9 5505.5 5517.5 5524.8 5522.0 5536.8 5567.8 5577.8 5589.4 5434.4 5449.4 5451.4 5451.6 5461.8 5501.2 5558.6 5577.9 5578.3 5619.0 5354.5 5427.8 5461.8 5468.4 5469.9 09:48:27 INFO - PID 639 | 09:48:27 INFO - PID 639 | [#1] ext.html Cycles:180 Average:29450.74 Median:28340.22 stddev:42423.16 (149.7%) stddev-sans-first:42487.12 09:48:27 INFO - PID 639 | Values: 667.4 736.7 756.9 1086.8 1103.5 25906.2 26597.0 26604.2 26604.7 26605.2 31687.7 32509.8 32523.3 32582.5 32618.0 7064.4 7188.4 7192.7 7197.6 7209.4 5442.7 5608.6 7085.2 7207.2 7225.7 6989.2 7190.2 7192.6 7194.6 7198.4 7194.4 7240.5 7241.3 7250.3 7253.6 5474.2 5638.0 6833.1 6875.3 6948.2 29905.6 30174.7 30191.5 30207.5 30239.7 2943.7 2977.3 2981.3 2984.2 2984.8 23349.8 23369.5 23370.0 23391.8 23461.0 3083.5 3107.0 3109.1 3125.8 3155.5 129362.4 129835.0 130372.3 130417.0 130431.0 40726.2 40838.2 40847.0 40857.2 40909.2 42094.8 42140.8 42187.6 42236.4 42293.8 12007.9 12065.3 12066.1 12069.5 12079.8 9654.9 9656.2 9663.0 9668.9 9669.5 9870.8 10026.3 11403.8 11494.8 11868.9 4967.4 4997.4 5016.3 5067.6 5096.7 859.9 891.5 893.1 901.2 923.1 19205.4 19854.1 19859.3 20121.8 20220.9 966.8 967.2 972.6 975.1 1007.9 10130.2 10369.3 10481.8 10511.8 10670.3 179323.0 179497.0 180041.0 180206.0 180266.1 36995.8 37029.3 37101.4 37115.0 37200.6 1209.5 1242.1 1251.9 1257.7 1259.4 18458.9 18822.6 19269.0 19715.7 19801.5 28111.4 28296.3 28327.7 28352.7 28420.3 176110.0 176259.1 176376.0 177443.0 178089.0 26742.9 26986.0 27037.9 27154.2 27196.6 26619.9 31983.4 32562.7 32805.0 32925.5 24279.8 24801.4 25024.9 25858.4 26022.0 24005.0 24612.0 25584.9 25724.1 25753.4 27259.3 27271.7 27394.2 27586.2 28081.9 24040.0 24302.4 24532.6 24585.4 25422.4 18859.8 20368.3 20394.3 20422.7 20500.1 09:48:27 INFO - PID 639 | 09:48:27 INFO - PID 639 | [#2] jquery.html Cycles:180 Average:30088.46 Median:511149.50 stddev:83183.46 (16.3%) stddev-sans-first:83386.93 09:48:27 INFO - PID 639 | Values: 392.9 422.7 436.5 439.8 445.1 14539.0 19017.2 19059.0 20110.8 20239.8 18924.8 19044.9 19306.3 19338.1 19372.3 5513.4 5703.9 5704.1 5705.9 5706.7 3437.3 3637.9 3719.6 5594.4 5767.8 5706.1 5711.8 5723.9 5727.6 5727.9 5503.3 5704.7 5719.7 5721.4 5756.7 5224.6 5239.8 5249.9 5256.9 5258.5 23538.9 24442.8 24446.4 24494.8 24528.8 1649.8 1683.4 1683.6 1685.4 1686.7 13755.7 14872.3 15198.0 15201.0 15386.3 1967.5 2026.9 2045.5 2071.7 2087.2 91104.0 91348.5 91454.5 91514.5 91552.1 9757.9 11014.3 11190.3 11283.9 11615.9 14378.8 34682.0 36196.6 36261.0 36505.8 9054.8 9166.8 9218.3 9333.7 9451.3 6783.2 6909.5 7296.2 7430.9 7566.5 9643.6 9646.5 9776.0 9817.3 10064.2 3556.9 3811.9 3914.7 4047.3 4122.0 811.3 841.6 860.2 868.5 880.1 16841.2 16922.0 17399.7 17651.9 17855.5 886.3 889.7 898.9 911.4 917.2 9193.2 9368.0 9630.1 9641.2 9709.9 489834.0 494347.0 511132.0 511167.0 511444.0 92671.0 93724.0 93884.0 94466.5 94702.5 1072.8 1082.4 1091.3 1095.7 1099.1 14265.7 16900.7 19157.4 19168.4 19271.4 43798.0 44661.3 45024.5 45405.1 45686.3 52953.2 53748.7 53924.0 54147.5 56150.7 7265.5 7319.9 7379.3 7494.6 7580.5 11135.9 11554.2 11663.2 11967.0 12084.5 10037.5 10403.5 10535.7 10648.6 10875.9 9514.1 9582.1 9805.6 9865.7 9979.1 9748.3 9751.2 9841.0 9882.9 9954.7 7731.2 7888.3 7965.6 7966.1 8115.9 10031.2 10080.4 10118.8 10126.9 10235.4 09:48:27 INFO - PID 639 | 09:48:27 INFO - PID 639 | [#3] mootools.html Cycles:180 Average:6315.43 Median:3938.61 stddev:4097.84 (104.0%) stddev-sans-first:4091.95 09:48:27 INFO - PID 639 | Values: 1292.9 1342.3 1368.5 1368.7 1369.8 10096.0 10565.9 10567.7 10568.4 10569.2 9846.4 10183.2 10260.1 10273.5 10281.2 2289.4 2324.6 2326.6 2327.3 2329.2 1945.1 2181.5 2291.0 2319.9 2327.4 1914.2 2224.9 2294.5 2308.7 2311.5 2199.8 2203.1 2208.6 2209.9 2211.6 2064.8 2080.5 2081.3 2081.9 2082.2 9742.9 9881.1 9920.2 9926.2 9939.2 5725.9 5910.9 5913.4 5917.6 5929.9 3169.1 3341.1 3422.4 3439.8 3504.2 1049.7 1105.1 1154.8 1156.8 1157.5 15418.3 15612.2 15612.3 15616.5 15623.5 4754.5 4833.2 5027.4 5054.9 5075.5 10954.3 11007.7 11012.8 11017.9 11036.9 5726.5 5733.7 5735.7 5742.1 5744.4 5241.3 5283.4 5334.8 5340.0 5405.0 3842.4 3925.8 3951.4 4005.6 4060.1 1169.2 1174.4 1174.4 1196.6 1212.8 663.2 676.9 684.9 693.8 694.2 5459.3 5537.0 5622.3 6237.1 6251.5 804.1 821.6 827.7 827.7 845.6 3493.5 3604.7 3611.5 3661.4 3833.7 12701.2 13575.0 13582.9 13586.8 13732.3 13588.5 13599.3 13691.4 13742.5 13760.7 9346.1 9534.9 9539.6 9568.3 9586.8 5371.9 5389.1 5418.4 5479.8 5569.6 11574.7 11576.4 11627.1 11637.3 11738.9 11720.9 12211.6 12275.1 12290.6 12308.1 7151.5 7292.6 7306.8 7308.5 7334.0 9120.3 9262.2 9412.1 9416.4 9421.9 7885.0 8066.0 8067.7 8158.9 8268.7 7764.8 7892.6 7927.1 7957.4 7979.8 7012.9 7154.8 7155.5 7155.9 7158.3 4688.6 4784.8 4835.4 4931.9 4998.5 4760.7 4881.4 4967.0 5028.2 5032.9 09:48:27 INFO - PID 639 | 09:48:27 INFO - PID 639 | [#4] prototype.html Cycles:180 Average:4638.47 Median:5082.12 stddev:1296.95 (25.5%) stddev-sans-first:1260.33 09:48:27 INFO - PID 639 | Values: 366.7 381.4 405.1 406.4 409.3 5076.4 5184.8 5260.6 5263.4 5274.7 5029.6 5141.6 5179.7 5191.5 5242.5 4130.4 4131.4 4146.1 4151.6 4159.0 3949.8 4028.2 4060.9 4136.7 4146.0 4108.5 4122.5 4125.3 4129.3 4142.5 4102.6 4106.2 4128.6 4131.4 4132.6 3539.5 3554.8 3737.5 3758.5 3766.8 5027.2 5055.5 5064.9 5067.2 5087.8 4918.5 4923.0 4923.7 4924.0 4935.3 5408.2 5586.1 5590.1 5614.2 5621.2 4201.2 4224.5 4225.5 4248.0 4249.3 5773.4 5793.7 5796.5 5821.4 5822.3 4275.5 4287.1 4323.7 4356.5 4357.6 4121.6 4213.9 4408.8 4417.9 4440.7 4736.6 4837.6 4854.2 4858.9 4871.7 5556.1 5556.8 5576.8 5581.9 5588.2 1496.1 1513.7 1520.0 1520.7 1536.1 1078.5 1098.3 1105.4 1106.4 1108.7 4800.3 4814.3 4818.4 4818.7 4836.0 5653.4 5707.1 5722.4 5740.0 5750.6 4666.7 4817.8 4837.6 4838.4 4839.7 2998.3 3029.7 3030.9 3035.7 3042.9 5276.9 5282.3 5307.2 5310.5 5311.5 5648.4 5861.5 5905.3 5914.5 5929.4 5256.7 5288.9 5290.4 5302.2 5311.2 5491.4 5737.1 5738.1 5745.2 5758.2 5569.4 5624.6 5642.9 5655.3 5657.2 5276.6 5277.7 5300.6 5308.8 5311.6 4235.3 4353.1 4354.0 4359.6 4362.6 5641.3 5671.5 5681.5 5703.2 5734.6 5490.0 5492.9 5498.9 5508.8 5514.9 5365.0 5420.2 5496.8 5533.6 5548.8 5428.3 5449.9 5453.6 5468.2 5469.4 5549.4 5555.5 5560.6 5576.9 5577.5 5217.7 5446.6 5485.9 5487.6 5492.6 09:48:27 INFO - PID 639 | 09:48:27 INFO - PID 639 | [#5] yui.html Cycles:180 Average:14273.51 Median:50861.24 stddev:17740.99 (34.9%) stddev-sans-first:17761.35 09:48:27 INFO - PID 639 | Values: 671.4 694.5 739.9 765.0 779.5 13035.2 13109.7 13438.5 13612.4 13623.9 13040.5 13129.8 13284.4 13285.5 13312.4 685.0 757.1 900.9 914.7 915.6 914.9 916.3 925.0 931.9 938.2 964.3 967.5 968.0 968.2 968.2 961.1 968.2 968.5 968.7 971.0 714.5 718.8 718.8 719.6 720.9 11771.0 11782.1 11925.2 11954.2 12280.4 9872.9 9907.0 9984.6 10300.5 10353.8 10413.1 10530.2 10534.5 10637.8 10715.2 2696.3 2733.3 2733.7 2734.3 2734.4 61243.0 62048.0 62224.7 62302.4 62740.4 10149.5 10153.4 10204.8 10258.7 10504.8 21047.8 21068.4 21068.5 21170.9 21297.5 6709.5 6709.6 6763.0 6897.3 6960.2 3162.2 3286.6 3322.5 3323.9 3334.4 3633.5 3772.7 3787.5 3789.3 3816.1 716.1 717.8 718.0 719.0 724.6 535.5 568.3 586.7 587.9 591.0 7194.9 8092.6 9242.3 9279.6 9533.1 552.3 574.6 589.2 589.3 606.2 4224.5 4470.6 4532.2 4534.4 4598.8 65332.7 66955.3 68259.0 69037.3 69067.3 55207.7 55537.7 56120.0 57127.4 57281.0 33771.4 39611.6 39966.4 50237.0 51485.5 7922.4 9039.6 9183.6 9284.8 9320.2 25857.7 26204.5 27413.0 28093.9 28191.7 42661.0 44623.6 44962.3 44968.6 45238.3 11695.5 12038.8 12040.1 12177.0 12646.1 10607.1 11543.9 11893.2 12014.4 12515.2 10771.5 10865.1 10942.0 11325.7 11402.0 11470.4 11868.0 11951.3 11993.9 12147.6 11290.0 11326.6 11403.3 11426.8 11501.9 8826.3 8894.5 8970.1 8984.1 9012.4 9139.5 9780.9 9879.2 9942.9 9968.5 09:48:27 INFO - PID 639 | -------- Summary: end -------- 09:48:27 INFO - PID 639 | 09:48:28 INFO - TEST-INFO | 639: exit 0 09:48:28 INFO - TEST-OK | dromaeo_css | took 1125021ms 09:48:28 INFO - TEST-START | kraken 09:48:28 INFO - operating with platform_type : linux_ 09:48:28 INFO - Initialising browser for kraken test... 09:48:28 INFO - TEST-INFO | started process 988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppqrvjS/profile http://localhost:42258/getInfo.html) 09:48:32 INFO - PID 988 | __metrics Screen width/height:1600/1200 09:48:32 INFO - PID 988 | colorDepth:24 09:48:32 INFO - PID 988 | Browser inner width/height: 1024/697 09:48:32 INFO - PID 988 | __metrics 09:48:33 INFO - PID 988 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:48:33 INFO - PID 988 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:48:34 INFO - TEST-INFO | 988: exit 0 09:48:34 INFO - Browser initialized. 09:48:34 INFO - Running cycle 1/1 for kraken test... 09:48:34 INFO - TEST-INFO | started process 1097 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppqrvjS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:48:47 INFO - PID 1097 | RSS: Main: 171343872 09:48:47 INFO - PID 1097 | 09:48:49 INFO - PID 1097 | Cycle 1(1): loaded http://localhost:42258/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42258/tests/kraken/driver.html?testName=audio-beat-detection) 09:48:50 INFO - PID 1097 | RSS: Main: 231645184 09:48:50 INFO - PID 1097 | 09:48:53 INFO - PID 1097 | Cycle 1(1): loaded http://localhost:42258/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42258/tests/kraken/driver.html?testName=audio-dft) 09:48:54 INFO - PID 1097 | RSS: Main: 209899520 09:48:54 INFO - PID 1097 | 09:48:57 INFO - PID 1097 | Cycle 1(1): loaded http://localhost:42258/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42258/tests/kraken/driver.html?testName=audio-fft) 09:48:58 INFO - PID 1097 | RSS: Main: 294641664 09:48:58 INFO - PID 1097 | 09:49:00 INFO - PID 1097 | Cycle 1(1): loaded http://localhost:42258/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42258/tests/kraken/driver.html?testName=audio-oscillator) 09:49:00 INFO - PID 1097 | RSS: Main: 207560704 09:49:00 INFO - PID 1097 | 09:49:03 INFO - PID 1097 | Cycle 1(1): loaded http://localhost:42258/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42258/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:49:03 INFO - PID 1097 | RSS: Main: 210587648 09:49:03 INFO - PID 1097 | 09:49:07 INFO - PID 1097 | Cycle 1(1): loaded http://localhost:42258/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42258/tests/kraken/driver.html?testName=imaging-darkroom) 09:49:07 INFO - PID 1097 | RSS: Main: 248750080 09:49:07 INFO - PID 1097 | 09:49:11 INFO - PID 1097 | Cycle 1(1): loaded http://localhost:42258/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42258/tests/kraken/driver.html?testName=imaging-desaturate) 09:49:11 INFO - PID 1097 | RSS: Main: 242581504 09:49:11 INFO - PID 1097 | 09:49:14 INFO - PID 1097 | Cycle 1(1): loaded http://localhost:42258/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42258/tests/kraken/driver.html?testName=json-parse-financial) 09:49:15 INFO - PID 1097 | RSS: Main: 244682752 09:49:15 INFO - PID 1097 | 09:49:17 INFO - PID 1097 | Cycle 1(1): loaded http://localhost:42258/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42258/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:49:17 INFO - PID 1097 | RSS: Main: 208457728 09:49:17 INFO - PID 1097 | 09:49:19 INFO - PID 1097 | Cycle 1(1): loaded http://localhost:42258/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42258/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:49:20 INFO - PID 1097 | RSS: Main: 215572480 09:49:20 INFO - PID 1097 | 09:49:22 INFO - PID 1097 | Cycle 1(1): loaded http://localhost:42258/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42258/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:49:22 INFO - PID 1097 | RSS: Main: 222355456 09:49:22 INFO - PID 1097 | 09:49:25 INFO - PID 1097 | Cycle 1(1): loaded http://localhost:42258/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42258/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:49:26 INFO - PID 1097 | RSS: Main: 228261888 09:49:26 INFO - PID 1097 | 09:49:29 INFO - PID 1097 | Cycle 1(1): loaded http://localhost:42258/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42258/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:49:30 INFO - PID 1097 | RSS: Main: 228995072 09:49:30 INFO - PID 1097 | 09:49:32 INFO - PID 1097 | Cycle 1(1): loaded http://localhost:42258/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42258/tests/kraken/driver.html?testName=ai-astar) 09:49:32 INFO - PID 1097 | RSS: Main: 297779200 09:49:32 INFO - PID 1097 | 09:49:32 INFO - PID 1097 | __start_tp_report 09:49:32 INFO - PID 1097 | _x_x_mozilla_page_load 09:49:32 INFO - PID 1097 | _x_x_mozilla_page_load_details 09:49:32 INFO - PID 1097 | |i|pagename|runs| 09:49:32 INFO - PID 1097 | |0;ai-astar;104;114;113;112;123;112;113;115;115;113 09:49:32 INFO - PID 1097 | |1;audio-beat-detection;152;130;128;177;131;133;128;128;151;127 09:49:32 INFO - PID 1097 | |2;audio-dft;168;166;169;165;164;167;165;171;165;164 09:49:32 INFO - PID 1097 | |3;audio-fft;75;74;77;103;75;76;75;75;96;76 09:49:32 INFO - PID 1097 | |4;audio-oscillator;84;83;114;84;84;90;110;88;91;107 09:49:32 INFO - PID 1097 | |5;imaging-gaussian-blur;115;114;113;115;114;113;113;114;114;115 09:49:32 INFO - PID 1097 | |6;imaging-darkroom;151;152;151;157;150;152;150;151;152;150 09:49:32 INFO - PID 1097 | |7;imaging-desaturate;95;94;94;95;95;94;95;94;95;95 09:49:32 INFO - PID 1097 | |8;json-parse-financial;53;54;54;54;54;53;52;54;54;54 09:49:32 INFO - PID 1097 | |9;json-stringify-tinderbox;56;56;56;56;56;55;56;56;55;56 09:49:32 INFO - PID 1097 | |10;stanford-crypto-aes;82;83;83;82;83;83;91;84;87;84 09:49:32 INFO - PID 1097 | |11;stanford-crypto-ccm;149;132;132;141;133;141;138;135;220;144 09:49:32 INFO - PID 1097 | |12;stanford-crypto-pbkdf2;184;198;191;190;192;193;192;196;189;189 09:49:32 INFO - PID 1097 | |13;stanford-crypto-sha256-iterative;73;72;73;74;71;73;70;72;71;72 09:49:32 INFO - PID 1097 | __end_tp_report 09:49:32 INFO - PID 1097 | __start_cc_report 09:49:32 INFO - PID 1097 | _x_x_mozilla_cycle_collect,2011 09:49:32 INFO - PID 1097 | __end_cc_report 09:49:32 INFO - PID 1097 | __startTimestamp1491583772526__endTimestamp 09:49:32 INFO - PID 1097 | 09:49:32 INFO - PID 1097 | ------- Summary: start ------- 09:49:32 INFO - PID 1097 | Number of tests: 14 09:49:32 INFO - PID 1097 | 09:49:32 INFO - PID 1097 | [#0] ai-astar Cycles:10 Average:113.40 Median:113.50 stddev:4.60 (4.1%) stddev-sans-first:3.40 09:49:32 INFO - PID 1097 | Values: 104.0 114.0 113.0 112.0 123.0 112.0 113.0 115.0 115.0 113.0 09:49:32 INFO - PID 1097 | 09:49:32 INFO - PID 1097 | [#1] audio-beat-detection Cycles:10 Average:138.50 Median:132.00 stddev:16.47 (12.5%) stddev-sans-first:16.73 09:49:32 INFO - PID 1097 | Values: 152.0 130.0 128.0 177.0 131.0 133.0 128.0 128.0 151.0 127.0 09:49:32 INFO - PID 1097 | 09:49:32 INFO - PID 1097 | [#2] audio-dft Cycles:10 Average:166.40 Median:166.50 stddev:2.32 (1.4%) stddev-sans-first:2.39 09:49:32 INFO - PID 1097 | Values: 168.0 166.0 169.0 165.0 164.0 167.0 165.0 171.0 165.0 164.0 09:49:32 INFO - PID 1097 | 09:49:32 INFO - PID 1097 | [#3] audio-fft Cycles:10 Average:80.20 Median:75.50 stddev:10.34 (13.7%) stddev-sans-first:10.79 09:49:32 INFO - PID 1097 | Values: 75.0 74.0 77.0 103.0 75.0 76.0 75.0 75.0 96.0 76.0 09:49:32 INFO - PID 1097 | 09:49:32 INFO - PID 1097 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:84.00 stddev:12.04 (14.3%) stddev-sans-first:12.27 09:49:32 INFO - PID 1097 | Values: 84.0 83.0 114.0 84.0 84.0 90.0 110.0 88.0 91.0 107.0 09:49:32 INFO - PID 1097 | 09:49:32 INFO - PID 1097 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 09:49:32 INFO - PID 1097 | Values: 115.0 114.0 113.0 115.0 114.0 113.0 113.0 114.0 114.0 115.0 09:49:32 INFO - PID 1097 | 09:49:32 INFO - PID 1097 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:151.50 stddev:2.07 (1.4%) stddev-sans-first:2.18 09:49:32 INFO - PID 1097 | Values: 151.0 152.0 151.0 157.0 150.0 152.0 150.0 151.0 152.0 150.0 09:49:32 INFO - PID 1097 | 09:49:32 INFO - PID 1097 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:49:32 INFO - PID 1097 | Values: 95.0 94.0 94.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 09:49:32 INFO - PID 1097 | 09:49:32 INFO - PID 1097 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:0.70 (1.3%) stddev-sans-first:0.71 09:49:32 INFO - PID 1097 | Values: 53.0 54.0 54.0 54.0 54.0 53.0 52.0 54.0 54.0 54.0 09:49:32 INFO - PID 1097 | 09:49:32 INFO - PID 1097 | [#9] json-stringify-tinderbox Cycles:10 Average:55.80 Median:56.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 09:49:32 INFO - PID 1097 | Values: 56.0 56.0 56.0 56.0 56.0 55.0 56.0 56.0 55.0 56.0 09:49:32 INFO - PID 1097 | 09:49:32 INFO - PID 1097 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:83.50 stddev:2.78 (3.3%) stddev-sans-first:2.83 09:49:32 INFO - PID 1097 | Values: 82.0 83.0 83.0 82.0 83.0 83.0 91.0 84.0 87.0 84.0 09:49:32 INFO - PID 1097 | 09:49:32 INFO - PID 1097 | [#11] stanford-crypto-ccm Cycles:10 Average:146.50 Median:141.00 stddev:26.42 (18.7%) stddev-sans-first:28.01 09:49:32 INFO - PID 1097 | Values: 149.0 132.0 132.0 141.0 133.0 141.0 138.0 135.0 220.0 144.0 09:49:32 INFO - PID 1097 | 09:49:32 INFO - PID 1097 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.40 Median:192.00 stddev:3.89 (2.0%) stddev-sans-first:3.07 09:49:32 INFO - PID 1097 | Values: 184.0 198.0 191.0 190.0 192.0 193.0 192.0 196.0 189.0 189.0 09:49:32 INFO - PID 1097 | 09:49:32 INFO - PID 1097 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:72.50 stddev:1.20 (1.7%) stddev-sans-first:1.22 09:49:32 INFO - PID 1097 | Values: 73.0 72.0 73.0 74.0 71.0 73.0 70.0 72.0 71.0 72.0 09:49:32 INFO - PID 1097 | -------- Summary: end -------- 09:49:32 INFO - PID 1097 | 09:49:33 INFO - TEST-INFO | 1097: exit 0 09:49:33 INFO - TEST-OK | kraken | took 65712ms 09:49:33 INFO - SUITE-END | took 1190s 09:49:34 INFO - Completed test suite (00:19:50) 09:49:34 INFO - javascript benchmark 09:49:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6653.205536630619, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2722.264988453118, 2751.9724802751966, 2787.7212278772126, 2788.1356779398375, 2801.915942521724, 5142.382914050309, 5254.080535906211, 5286.365636123665, 5306.044911915858, 5358.169483730018, 5263.0000299942985, 5306.018386598473, 5313.070212712779, 5363.007843548937, 5370.355557333116, 4595.264757638778, 4645.001324715194, 4663.65022623303, 4723.976380118094, 4759.095771803363, 4661.930071048937, 4676.275177347499, 4687.90624187516, 4738.076075165344, 4789.616830653539, 4595.609373203281, 4657.371254880582, 4662.254039353687, 4668.276417155313, 4671.182543054952, 4691.741954192552, 4693.7653117344, 4695.530446955311, 4698.812047518095, 4703.905921881543, 4605.447346318463, 4642.442906851165, 4656.045510670305, 4659.254519276899, 4667.673262871566, 5150.48495150482, 5214.322138122057, 5228.08508511009, 5230.215467679878, 5232.790688372461, 5724.284464441945, 5732.226149469851, 5732.31212254528, 5734.512566431858, 5736.2256095427, 5674.375818659944, 5726.742296596663, 5764.365919748824, 5779.479846813765, 5785.913211301834, 5332.626716129911, 5337.0, 5354.518093371616, 5401.7299135043095, 5407.324084489439, 5962.612430192024, 5974.671393073336, 5977.342492325841, 5978.372270911578, 5987.072003839412, 5525.944740552623, 5588.776448942078, 5593.216949627055, 5595.38450770415, 5597.160425936142, 5730.0, 5737.627054241461, 5804.419558044162, 5809.8547536311935, 5818.389069147678, 5716.142578613241, 5732.398098199712, 5741.25363702716, 5767.221425107557, 5780.768769249267, 5513.669179849222, 5565.526930210896, 5567.972160139255, 5706.514946229617, 5706.71466426677, 4874.634402419832, 4906.215005599087, 4929.433115191727, 4945.975270123627, 4948.158813001798, 4117.032497363177, 4125.793710314472, 4129.566395528486, 4148.253314403376, 4169.45797046382, 4809.470958194595, 4817.108834865491, 4818.349522814446, 4821.156297647897, 4852.0295940811975, 5652.293463317085, 5666.9716651416475, 5711.257536520226, 5720.8283751487525, 5727.713614319267, 4701.271302948048, 4750.192467280571, 4752.453467851172, 4758.405199350082, 4766.547178018082, 5039.118154323052, 5086.92369614456, 5090.465501122403, 5092.668976516515, 5094.541491265803, 5244.134717771525, 5245.868853278698, 5246.973765131303, 5247.055530004636, 5249.055170069424, 5591.0, 5646.463585959327, 5703.258576385209, 5704.258446401941, 5706.258186435737, 5192.247124166899, 5235.267062611314, 5302.257683924331, 5352.919706204488, 5371.4897084776885, 5677.858053548694, 5689.886202276014, 5694.17434471991, 5702.030654788613, 5707.514861236676, 5767.0, 5770.942290577208, 5777.191193233035, 5781.682007489629, 5784.884302313846, 5443.101888188405, 5492.890142197213, 5505.504504594605, 5517.475839795213, 5524.8342549723575, 5522.0336441123445, 5536.833894983157, 5567.805126820542, 5577.776888924398, 5589.385167631476, 5434.429384914685, 5449.400565937664, 5451.400345962021, 5451.563874890078, 5461.808836690697, 5501.174823776466, 5558.555315574825, 5577.9442205577425, 5578.330600327987, 5618.971905140448, 5354.518093371616, 5427.782888684408, 5461.836144915659, 5468.371137319259, 5469.945300546943], "value": 5169.7282765581585, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.4293479075391, 736.7053178728509, 756.928091831276, 1086.7772106718119, 1103.5089385223578, 25906.222813315584, 26597.0, 26604.201873943788, 26604.733952660466, 26605.201843944666, 31687.68312316876, 32509.83745081277, 32523.349533009387, 32582.511262331085, 32618.0, 7064.434845212397, 7188.388986936116, 7192.676329565182, 7197.568145911262, 7209.351158395743, 5442.673439593637, 5608.5793565482545, 7085.2206257311655, 7207.24323945986, 7225.7470988515415, 6989.16130064393, 7190.209077001526, 7192.604406757626, 7194.640267986606, 7198.3881370083345, 7194.352508274254, 7240.493165478419, 7241.348278654947, 7250.3112204340505, 7253.564786112824, 5474.233607294982, 5638.04153293941, 6833.077534532874, 6875.278095799919, 6948.235694073648, 29905.551416728766, 30174.69825301741, 30191.47127930806, 30207.546886796717, 30239.697603024128, 2943.7203465670727, 2977.330100727319, 2981.3142977115167, 2984.1942675477717, 2984.7761417893526, 23349.76650233493, 23369.532609347887, 23370.0, 23391.76608233913, 23461.0, 3083.5066389377816, 3107.0368185862453, 3109.1449851291077, 3125.7811953163286, 3155.4635711929027, 129362.35318823345, 129835.0, 130372.3481382587, 130417.0, 130431.0, 40726.18547629031, 40838.1832363357, 40847.0, 40857.1828563433, 40909.1818163641, 42094.78952605279, 42140.78929605394, 42187.624990000724, 42236.36645450321, 42293.78853105715, 12007.939960300142, 12065.276083435023, 12066.129749888782, 12069.517219311305, 12079.758404831855, 9654.903450965541, 9656.22750179984, 9663.0, 9668.9033109668, 9669.516524173763, 9870.802583948282, 10026.348287361297, 11403.828942565868, 11494.827577586342, 11868.88131118695, 4967.40391153064, 4997.350344455198, 5016.272640467112, 5067.569256613156, 5096.674864535174, 859.8581234096304, 891.5364010714392, 893.1202765276198, 901.170623634024, 923.0953665407937, 19205.423837284903, 19854.10656520431, 19859.30492432787, 20121.798782011992, 20220.89889550572, 966.7534778631403, 967.2310513142069, 972.6255391674256, 975.1370037516707, 1007.9344842585208, 10130.189584833195, 10369.325993810378, 10481.842772358421, 10511.789764204674, 10670.25308228432, 179323.0, 179497.0, 180041.0, 180206.0, 180266.09866950582, 36995.815020924725, 37029.25941481155, 37101.44347834784, 37115.0, 37200.627993720256, 1209.5282839692527, 1242.1118899986552, 1251.9374031298398, 1257.6730050187018, 1259.3766085787595, 18458.907705461388, 18822.623547529245, 19269.0, 19715.71126739598, 19801.504962376057, 28111.43777124405, 28296.292592684524, 28327.71672283333, 28352.716472835007, 28420.289492762848, 176110.0, 176259.11870440567, 176376.0, 177443.0, 178089.0, 26742.866285669224, 26986.0, 27037.86481067582, 27154.1853744388, 27196.592051118852, 26619.866900665373, 31983.36033279275, 32562.674373255963, 32805.03169809819, 32925.50611740874, 24279.757202428456, 24801.379965501008, 25024.874875625505, 25858.35354116162, 26022.0, 24005.0, 24612.0, 25584.8720756395, 25724.09965651193, 25753.356166095997, 27259.318517037234, 27271.727282727712, 27394.178174654793, 27586.172414827586, 28081.859590701915, 24040.0, 24302.392440189138, 24532.632010520214, 24585.385365366008, 25422.364440889127, 18859.811401885807, 20368.28710995108, 20394.28619998293, 20422.69365959482, 20500.077496512393], "value": 13818.400193040397, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.9057026313682, 422.6829877591806, 436.4784083020791, 439.76692353052886, 445.08757048051484, 14539.0, 19017.239310427583, 19059.0, 20110.798892011077, 20239.797602023977, 18924.810751892477, 19044.904775476138, 19306.32427865025, 19338.12978415971, 19372.321968731096, 5513.4210907854595, 5703.8574035649235, 5704.11586204139, 5705.8573535661735, 5706.7431965561445, 3437.2781715839706, 3637.8908632740927, 3719.6466335698065, 5594.440555944414, 5767.769289228426, 5706.115552089433, 5711.7715291388295, 5723.942760572382, 5727.570432217601, 5727.914081288784, 5503.284573005523, 5704.65772053676, 5719.656820590736, 5721.370649228582, 5756.740946657411, 5224.555912747421, 5239.842804715865, 5249.947500524984, 5256.921146182772, 5258.474152584749, 23538.882305588533, 24442.755572444225, 24446.388840278956, 24494.755052449604, 24528.754712453003, 1649.8432648898336, 1683.4108062178261, 1683.5791052236941, 1685.401682402754, 1686.6795308891271, 13755.724885502234, 14872.256387180598, 15198.0, 15201.0, 15386.307616157188, 1967.4687834284807, 2026.9087891044792, 2045.5295282085056, 2071.6685330347223, 2087.2277257414853, 91104.0, 91348.54325728395, 91454.54272728594, 91514.5424272881, 91552.08447915569, 9757.853632195523, 11014.339139651647, 11190.272632278877, 11283.94358028221, 11615.88384116148, 14378.784318235235, 34682.0, 36196.638033619856, 36261.0, 36505.81747091247, 9054.773630659154, 9166.770830729285, 9218.308626853013, 9333.673321433716, 9451.29115316354, 6783.18601767791, 6909.516333856582, 7296.16094149169, 7430.925690743024, 7566.5460072394735, 9643.566039528097, 9646.517674116267, 9775.951120244354, 9817.263705222136, 10064.245181611263, 3556.893293201208, 3811.8856434307013, 3914.6868250539887, 4047.251258517184, 4121.9587804122175, 811.3347055414504, 841.5918279634373, 860.2214995429147, 868.5483548554716, 880.0978996528481, 16841.242144103544, 16922.0, 17399.652006960045, 17651.911740441472, 17855.464336069937, 886.2555453419159, 889.6797153024905, 898.9460632362079, 911.4030310146732, 917.2111983694018, 9193.218576420946, 9368.0, 9630.133288004114, 9641.228701703847, 9709.875164420648, 489834.0, 494347.0, 511132.0, 511167.0, 511444.0, 92671.0, 93724.0, 93884.0, 94466.52766736122, 94702.52648736713, 1072.7961687279549, 1082.4317233452343, 1091.2961140064615, 1095.687728997232, 1099.142668718401, 14265.714685706434, 16900.66198675995, 19157.425277241706, 19168.424947251606, 19271.444185477772, 43798.0, 44661.330080049476, 45024.47145163998, 45405.09189816119, 45686.314705280114, 52953.20570191527, 53748.73125634503, 53924.0, 54147.458525414244, 56150.71924640514, 7265.491415600857, 7319.890201646873, 7379.3358597726465, 7494.55032698018, 7580.54516728998, 11135.944320278346, 11554.191206615793, 11663.24188927717, 11967.0, 12084.45619947087, 10037.5483103262, 10403.479826008517, 10535.736606584896, 10648.627298044532, 10875.891241087804, 9514.096160864707, 9582.137607615348, 9805.558749856416, 9865.704028879145, 9979.10188083076, 9748.317617766688, 9751.219902407933, 9841.0, 9882.851757223503, 9954.651587194703, 7731.188225236269, 7888.2506161914525, 7965.641546130322, 7966.1237263902085, 8115.918840811516, 10031.197504199501, 10080.445575493124, 10118.797624047626, 10126.949365253127, 10235.385876847413], "value": 9445.774269050255, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1292.9353532323382, 1342.3355439057668, 1368.466298143724, 1368.7262547490502, 1369.7671395862703, 10096.0, 10565.894341056588, 10567.735806604838, 10568.365898046122, 10569.207309451802, 9846.359986600866, 10183.236257280696, 10260.127889129433, 10273.537690803912, 10281.177505799536, 2289.4390874235837, 2324.5931961906686, 2326.5928462519078, 2327.325075728037, 2329.1731435340466, 1945.1344151852431, 2181.5091604388963, 2291.049214575949, 2319.9420014499606, 2327.429779703975, 1914.176903931309, 2224.855384400017, 2294.472271377584, 2308.676785250058, 2311.537692461506, 2199.8350123740784, 2203.063697928382, 2208.6355751301016, 2209.9005544750526, 2211.6461366181334, 2064.7935206479383, 2080.4798800299927, 2081.344376521391, 2081.8542702010864, 2082.1983536338466, 9742.902570974342, 9881.110700037032, 9920.206383489303, 9926.156276716487, 9939.155171810406, 5725.914111288334, 5910.940890591082, 5913.438223368773, 5917.615355001911, 5929.940700592982, 3169.144331030609, 3341.097903566048, 3422.3839708852397, 3439.8280085995852, 3504.176518518146, 1049.6903413493037, 1105.1435137768294, 1154.8036833738286, 1156.7570810129882, 1157.4849192109514, 15418.306176222097, 15612.219389030502, 15612.297446614815, 15616.453424130215, 15623.531294061197, 4754.524547545287, 4833.202521583899, 5027.396712394536, 5054.9241761373605, 5075.467075956972, 10954.287971281841, 11007.669769906915, 11012.779744405067, 11017.944910275397, 11036.944815275872, 5726.513246374022, 5733.655980641175, 5735.655860648374, 5742.081266997344, 5744.425557444306, 5241.344831896013, 5283.445238250005, 5334.759935802898, 5340.0, 5405.0, 3842.366009608439, 3925.8429662813737, 3951.3677811550015, 4005.559388467266, 4060.147369052532, 1169.181572898974, 1174.365842445087, 1174.3834486894448, 1196.611101392051, 1212.7938250497436, 663.1577896071962, 676.9086173366533, 684.8732984397902, 693.7918624412656, 694.1704662927854, 5459.2902922619805, 5536.972315138399, 5622.269105016322, 6237.064440333896, 6251.531135164881, 804.103424681476, 821.6179476543437, 827.6772058897035, 827.6813426830713, 845.6110189312985, 3493.475978603179, 3604.711623070148, 3611.5485564304463, 3661.35926212917, 3833.7316387852584, 12701.174423662616, 13575.0, 13582.86417135816, 13586.796198057036, 13732.313384330942, 13588.456461741618, 13599.320033998261, 13691.383887724876, 13742.450301987808, 13760.724785504433, 9346.11211934865, 9534.856977145348, 9539.570719317648, 9568.330216884751, 9586.760330991641, 5371.919421208763, 5389.083855744454, 5418.376886658085, 5479.835604931858, 5569.637973531708, 11574.6527604172, 11576.36330001858, 11627.069834413396, 11637.301761894314, 11738.88261117412, 11720.941395292968, 12211.633650990485, 12275.140740148105, 12290.569830055905, 12308.138430310151, 7151.499395042505, 7292.598907060163, 7306.780796576111, 7308.451866109956, 7334.046573945353, 9120.270378369582, 9262.16640502358, 9412.058794120534, 9416.387934784218, 9421.905780942103, 7885.0, 8065.9596702016115, 8067.677292908218, 8158.877616835871, 8268.669253229804, 7764.767056988299, 7892.565908875067, 7927.088384835587, 7957.403194760301, 7979.840403191787, 7012.929870701228, 7154.785356439315, 7155.499115061895, 7155.892661610184, 7158.284171583008, 4688.578027977362, 4784.808607655655, 4835.443923948791, 4931.852044438672, 4998.500149985118, 4760.690555113906, 4881.389826271716, 4967.0, 5028.170351891897, 5032.874178145576], "value": 4755.402134639906, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.6553439766621, 381.4335711468469, 405.0562190097074, 406.43505527317035, 409.26741133371274, 5076.416212135606, 5184.818531351399, 5260.605454590902, 5263.394709608397, 5274.709890955995, 5029.622778291634, 5141.562967147797, 5179.715115668637, 5191.5327620514145, 5242.501962313574, 4130.3891482321915, 4131.442255295527, 4146.087860670663, 4151.626353628173, 4158.958410415888, 3949.782761948092, 4028.1540876415843, 4060.878173654795, 4136.689748268876, 4145.9999999999845, 4108.4864391951005, 4122.4640796696385, 4125.319322311815, 4129.339305711087, 4142.523609784883, 4102.589741025903, 4106.178764247133, 4128.60778226068, 4131.380292956081, 4132.628063474302, 3539.50446937429, 3554.8044857532827, 3737.5141231639986, 3758.4926034985474, 3766.8304926278383, 5027.245913113025, 5055.494450554952, 5064.949350506521, 5067.189249720027, 5087.821926232564, 4918.508149185089, 4922.950770492285, 4923.679960802572, 4924.0, 4935.259711043373, 5408.242846001563, 5586.050371436865, 5590.105583106683, 5614.214010038598, 5621.156826476021, 4201.159768046403, 4224.471941007374, 4225.514065882432, 4247.978760106211, 4249.277622804131, 5773.364929857712, 5793.725380416302, 5796.478316951495, 5821.370016395416, 5822.272215973004, 4275.486941567032, 4287.142571485653, 4323.740575565476, 4356.477222733229, 4357.586029327209, 4121.567235440296, 4213.873583792491, 4408.845690400821, 4417.851358646775, 4440.7335559866515, 4736.621070314367, 4837.564619184291, 4854.17479028566, 4858.8785280367565, 4871.683340582851, 5556.111022236423, 5556.805511807067, 5576.804811831566, 5581.944180558224, 5588.161775733673, 1496.1148952319938, 1513.6896936128066, 1520.0271826031349, 1520.6806570620072, 1536.1013806923074, 1078.4607696151925, 1098.2970898624887, 1105.3699391347016, 1106.43571778392, 1108.6840250528721, 4800.3279540864305, 4814.277858321209, 4818.445878723922, 4818.71087734737, 4836.0, 5653.406392328829, 5707.143928410688, 5722.4277572242445, 5740.0, 5750.597458177971, 4666.696664716783, 4817.8313759018265, 4837.637177211724, 4838.371011768448, 4839.661223714376, 2998.310388610632, 3029.681883402255, 3030.8939187128785, 3035.681253468354, 3042.939141217163, 5276.891852710897, 5282.313299271147, 5307.150855863043, 5310.52205301517, 5311.49540793624, 5648.350439699487, 5861.531077513789, 5905.291365036223, 5914.526837852962, 5929.37741537141, 5256.684598924, 5288.947110528846, 5290.391604965402, 5302.1781623848365, 5311.150215965427, 5491.4492572712525, 5737.110747834093, 5738.110592858114, 5745.224394706661, 5758.1650660654805, 5569.359523654832, 5624.593851537115, 5642.887142257214, 5655.264815573949, 5657.179708942263, 5276.551493123127, 5277.683338999673, 5300.6024548158275, 5308.814191503279, 5311.601629877698, 4235.322348424237, 4353.129374125125, 4354.0, 4359.564043595742, 4362.563743625612, 5641.323041234914, 5671.461211184931, 5681.545476361964, 5703.230063941315, 5734.627249228787, 5490.0, 5492.890142197213, 5498.917516237179, 5508.752106155152, 5514.889702206014, 5365.0, 5420.214068960057, 5496.7526461308535, 5533.557315414838, 5548.750306236148, 5428.290088622071, 5449.891002180014, 5453.590980676545, 5468.2344471773185, 5469.371022332482, 5549.38956714753, 5555.527780138572, 5560.5551555876245, 5576.888462230651, 5577.510104365862, 5217.713025783618, 5446.564274858081, 5485.862853428536, 5487.5884308677805, 5492.642978206404], "value": 4253.852288950257, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.4024518178819, 694.5138403117812, 739.944504162188, 764.9961750191248, 779.5322806316209, 13035.217886926792, 13109.67225819355, 13438.5296514622, 13612.387442565083, 13623.863761362383, 13040.478380864753, 13129.803052954214, 13284.402201900913, 13285.468581256762, 13312.40094195761, 684.9931500685004, 757.095271150972, 900.918917297443, 914.6935776514875, 915.6337465013982, 914.9359544831865, 916.2532535983186, 924.958376873039, 931.9301052421062, 938.1884669760642, 964.2719746591314, 967.5307475874196, 967.970960871175, 968.1770495079162, 968.1915600473613, 961.14458132262, 968.1722127580888, 968.4528241543576, 968.7481254873749, 971.0192705367594, 714.5248409807472, 718.7520305494596, 718.823888147402, 719.6186021408662, 720.8594324106801, 11771.0, 11782.116341274354, 11925.224860384047, 11954.222975506564, 12280.385980700928, 9872.851907221397, 9907.0, 9984.600615975352, 10300.484975751182, 10353.844692329545, 10413.114885234763, 10530.15758739299, 10534.47327633623, 10637.840432393443, 10715.196360272932, 2696.298962269804, 2733.316670832292, 2733.740294672003, 2734.2754170144926, 2734.3847634282324, 61243.0, 62048.0, 62224.68887655578, 62302.37697623057, 62740.37259627391, 10149.492525373702, 10153.441560714231, 10204.795904081877, 10258.692239232834, 10504.789904201873, 21047.78952210489, 21068.367948961248, 21068.473288167614, 21170.89414552948, 21297.467563311042, 6709.530332876652, 6709.630970296583, 6763.0, 6897.310268973062, 6960.234374218832, 3162.2094476380903, 3286.5563148974584, 3322.4684050551796, 3323.850426730803, 3334.3664703706218, 3633.5094762206763, 3772.660460558563, 3787.507624008861, 3789.3368660484307, 3816.122291872885, 716.1012928774355, 717.7667258141125, 717.9820504487429, 718.9712411503585, 724.6123324021623, 535.4511625583808, 568.2754488027798, 586.6949186423121, 587.9147523609053, 590.9674967876722, 7194.892076618855, 8092.554909479917, 9242.260619150451, 9279.62881484733, 9533.142017218344, 552.2930648769582, 574.6035235687445, 589.1633879890566, 589.339939268014, 606.233115109387, 4224.471941007374, 4470.575295346936, 4532.2243246346925, 4534.387857639243, 4598.770061496979, 65332.673336633015, 66955.3304466949, 68259.0, 69037.3096269031, 69067.30932690609, 55207.72396137994, 55537.722311388185, 56120.0, 57127.42872571304, 57281.0, 33771.43560093492, 39611.60388396079, 39966.40050399247, 50237.0, 51485.48514514882, 7922.445428819928, 9039.638414463348, 9183.576545635437, 9284.814303713752, 9320.207782338577, 25857.741422585532, 26204.475910481302, 27413.0, 28093.859530702215, 28191.71808281973, 42661.0, 44623.553764463235, 44962.3255651172, 44968.55031449644, 45238.321425177994, 11695.473703683185, 12038.75922481563, 12040.11047799142, 12177.0, 12646.051546133893, 10607.098396636373, 11543.88456115428, 11893.226940248856, 12014.399280036137, 12515.249085054926, 10771.46142692878, 10865.130789536975, 10942.0, 11325.71685707864, 11401.983690102, 11470.4264786762, 11868.0, 11951.282923024646, 11993.880061199625, 12147.574834880737, 11290.0, 11326.603568875049, 11403.258788178742, 11426.771464570827, 11501.942490287494, 8826.293896488138, 8894.510801905957, 8970.147835955573, 8984.101589840964, 9012.41419307743, 9139.451632902048, 9780.85328720084, 9879.209663227068, 9942.921920369268, 9968.451735154345], "value": 6353.622661095581, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1555.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 113.0, 112.0, 123.0, 112.0, 113.0, 115.0, 115.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 130.0, 128.0, 177.0, 131.0, 133.0, 128.0, 128.0, 151.0, 127.0], "value": 138.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 169.0, 165.0, 164.0, 167.0, 165.0, 171.0, 165.0, 164.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 77.0, 103.0, 75.0, 76.0, 75.0, 75.0, 96.0, 76.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 114.0, 84.0, 84.0, 90.0, 110.0, 88.0, 91.0, 107.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 113.0, 115.0, 114.0, 113.0, 113.0, 114.0, 114.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 151.0, 157.0, 150.0, 152.0, 150.0, 151.0, 152.0, 150.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 54.0, 54.0, 53.0, 52.0, 54.0, 54.0, 54.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 56.0, 55.0, 56.0, 56.0, 55.0, 56.0], "value": 55.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 83.0, 82.0, 83.0, 83.0, 91.0, 84.0, 87.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 132.0, 132.0, 141.0, 133.0, 141.0, 138.0, 135.0, 220.0, 144.0], "value": 146.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 198.0, 191.0, 190.0, 192.0, 193.0, 192.0, 196.0, 189.0, 189.0], "value": 191.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 73.0, 74.0, 71.0, 73.0, 70.0, 72.0, 71.0, 72.0], "value": 72.1, "unit": "score"}]}]} 09:49:34 INFO - Return code: 0 09:49:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:49:34 ERROR - # TBPL SUCCESS # 09:49:34 INFO - Running post-action listener: _resource_record_post_action 09:49:34 INFO - [mozharness: 2017-04-07 16:49:34.353090Z] Finished run-tests step (success) 09:49:34 INFO - Running post-run listener: _resource_record_post_run 09:49:34 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 0; Write bytes: 362696704; Read time: 0; Write time: 277508 09:49:34 INFO - TinderboxPrint: CPU usage
13.0% 09:49:34 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:49:34 INFO - TinderboxPrint: I/O write bytes / time
362,696,704 / 277,508 09:49:34 INFO - TinderboxPrint: CPU idle
8,369.6 (86.9%) 09:49:34 INFO - TinderboxPrint: CPU user
1,207.5 (12.5%) 09:49:34 INFO - TinderboxPrint: Swap in / out
0 / 0 09:49:34 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 105140224; Read time: 0; Write time: 114852 09:49:34 INFO - run-tests - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 257556480; Read time: 0; Write time: 162656 09:49:34 INFO - Running post-run listener: _upload_blobber_files 09:49:34 INFO - Blob upload gear active. 09:49:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:49:34 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:49:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:49:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:49:35 INFO - (blobuploader) - INFO - Open directory for files ... 09:49:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:49:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:49:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:49:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:49:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:49:39 INFO - (blobuploader) - INFO - Done attempting. 09:49:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:49:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:49:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:49:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:49:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:49:40 INFO - (blobuploader) - INFO - Done attempting. 09:49:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:49:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:49:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:49:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:49:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:49:41 INFO - (blobuploader) - INFO - Done attempting. 09:49:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:49:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:49:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:49:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:49:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:49:41 INFO - (blobuploader) - INFO - Done attempting. 09:49:41 INFO - (blobuploader) - INFO - Iteration through files over. 09:49:41 INFO - Return code: 0 09:49:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:49:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:49:41 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d420e063a4d2fa4a004a6015c512aa9e057c49d10b20c97f3a2f3eea8b2e40571a9f00cdce2ea17faea0c43c160a3a2e9136d62681cc3777fe441a93a240f66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/758f31bc120d3bd3a6527ca1d50755e199ce3302c3d3ba5414acc3286a10585fe6b2820944e927163a27f19dc3ae1557325c974f60bde3f661ce838cf1037c06", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7dd2e9dd50940a28fcabfc610e119847fe6cdfc0df0eb2219ccf3a509d75462791ec8ca0624036381ff65ae13401e29fc593c933cec8a6dd6b9bdf2580db5e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5ad5077ead88557dd9f0e5e4f79091f1cc372e47e89d9a8b4018e52186754af3ab04130c6398a5910df119fa6b96ad75d63c5d8ca19039bc5e467cc07ed980a"} 09:49:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:49:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:49:41 INFO - Contents: 09:49:41 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d420e063a4d2fa4a004a6015c512aa9e057c49d10b20c97f3a2f3eea8b2e40571a9f00cdce2ea17faea0c43c160a3a2e9136d62681cc3777fe441a93a240f66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/758f31bc120d3bd3a6527ca1d50755e199ce3302c3d3ba5414acc3286a10585fe6b2820944e927163a27f19dc3ae1557325c974f60bde3f661ce838cf1037c06", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7dd2e9dd50940a28fcabfc610e119847fe6cdfc0df0eb2219ccf3a509d75462791ec8ca0624036381ff65ae13401e29fc593c933cec8a6dd6b9bdf2580db5e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5ad5077ead88557dd9f0e5e4f79091f1cc372e47e89d9a8b4018e52186754af3ab04130c6398a5910df119fa6b96ad75d63c5d8ca19039bc5e467cc07ed980a"} 09:49:41 INFO - Running post-run listener: copy_logs_to_upload_dir 09:49:41 INFO - Copying logs to upload dir... 09:49:41 INFO - mkdir: /builds/slave/test/build/upload/logs 09:49:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.515274 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-04-07 09:49:41.395714) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-07 09:49:41.403364) ========= 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=ea65d483da93c827905c2090000001f5-1491582509.690638-893653871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d420e063a4d2fa4a004a6015c512aa9e057c49d10b20c97f3a2f3eea8b2e40571a9f00cdce2ea17faea0c43c160a3a2e9136d62681cc3777fe441a93a240f66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/758f31bc120d3bd3a6527ca1d50755e199ce3302c3d3ba5414acc3286a10585fe6b2820944e927163a27f19dc3ae1557325c974f60bde3f661ce838cf1037c06", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7dd2e9dd50940a28fcabfc610e119847fe6cdfc0df0eb2219ccf3a509d75462791ec8ca0624036381ff65ae13401e29fc593c933cec8a6dd6b9bdf2580db5e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5ad5077ead88557dd9f0e5e4f79091f1cc372e47e89d9a8b4018e52186754af3ab04130c6398a5910df119fa6b96ad75d63c5d8ca19039bc5e467cc07ed980a"} build_url:https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d420e063a4d2fa4a004a6015c512aa9e057c49d10b20c97f3a2f3eea8b2e40571a9f00cdce2ea17faea0c43c160a3a2e9136d62681cc3777fe441a93a240f66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/758f31bc120d3bd3a6527ca1d50755e199ce3302c3d3ba5414acc3286a10585fe6b2820944e927163a27f19dc3ae1557325c974f60bde3f661ce838cf1037c06", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7dd2e9dd50940a28fcabfc610e119847fe6cdfc0df0eb2219ccf3a509d75462791ec8ca0624036381ff65ae13401e29fc593c933cec8a6dd6b9bdf2580db5e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5ad5077ead88557dd9f0e5e4f79091f1cc372e47e89d9a8b4018e52186754af3ab04130c6398a5910df119fa6b96ad75d63c5d8ca19039bc5e467cc07ed980a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-07 09:49:41.431475) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 09:49:41.431814) ========= 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=ea65d483da93c827905c2090000001f5-1491582509.690638-893653871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 09:49:41.510752) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-07 09:49:41.511364) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-07 09:49:41.511699) ========= ========= Total master_lag: 0.17 =========