builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-020 starttime: 1491582558.49 results: success (0) revision: 22df0c5cfbf8a2aa2822bf9c763e6c1c5a3f69de ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-07 09:29:18.493717) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-07 09:29:18.494179) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-07 09:29:18.494462) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-07 09:29:18.509196) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 09:29:18.509522) ========= 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=af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-07 09:29:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 114M=0s 2017-04-07 09:29:19 (114 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.150235 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 09:29:18.674063) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 09:29:18.674441) ========= 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=af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015826 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 09:29:18.723553) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-07 09:29:18.723899) ========= 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=af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-07 09:29:19,146 truncating revision to first 12 chars 2017-04-07 09:29:19,146 Setting DEBUG logging. 2017-04-07 09:29:19,146 attempt 1/10 2017-04-07 09:29:19,147 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:29:20,007 unpacking tar archive at: mozilla-central-22df0c5cfbf8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.189724 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-07 09:29:19.928021) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-07 09:29:19.928369) ========= script_repo_revision: 22df0c5cfbf8a2aa2822bf9c763e6c1c5a3f69de ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-07 09:29:19.928776) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-07 09:29:19.929052) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-07 09:29:19.938449) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-04-07 09:29:19.938802) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:29:20 INFO - MultiFileLogger online at 20170407 09:29:20 in /builds/slave/test 09:29:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:29:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:29:20 INFO - {'append_to_log': False, 09:29:20 INFO - 'base_work_dir': '/builds/slave/test', 09:29:20 INFO - 'blob_upload_branch': 'Firefox', 09:29:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:29:20 INFO - 'branch': 'Firefox', 09:29:20 INFO - 'buildbot_json_path': 'buildprops.json', 09:29:20 INFO - 'config_files': ('talos/linux_config.py',), 09:29:20 INFO - 'default_actions': ('clobber', 09:29:20 INFO - 'read-buildbot-config', 09:29:20 INFO - 'download-and-extract', 09:29:20 INFO - 'populate-webroot', 09:29:20 INFO - 'create-virtualenv', 09:29:20 INFO - 'install', 09:29:20 INFO - 'run-tests'), 09:29:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:29:20 INFO - 'download_minidump_stackwalk': True, 09:29:20 INFO - 'download_symbols': 'ondemand', 09:29:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:29:20 INFO - 'tooltool.py': '/tools/tooltool.py', 09:29:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:29:20 INFO - '/tools/misc-python/virtualenv.py')}, 09:29:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:29:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:29:20 INFO - 'gecko_profile': False, 09:29:20 INFO - 'gecko_profile_interval': 0, 09:29:20 INFO - 'installer_path': 'installer.exe', 09:29:20 INFO - 'log_level': 'info', 09:29:20 INFO - 'log_name': 'talos', 09:29:20 INFO - 'log_to_console': True, 09:29:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:29:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:29:20 INFO - 'opt_config_files': (), 09:29:20 INFO - 'pip_index': False, 09:29:20 INFO - 'suite': 'dromaeojs-e10s', 09:29:20 INFO - 'system_bits': '32', 09:29:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:29:20 INFO - 'title': 'talos-linux64-ix-020', 09:29:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:29:20 INFO - 'use_talos_json': True, 09:29:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:29:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:29:20 INFO - 'work_dir': 'build'} 09:29:20 INFO - [mozharness: 2017-04-07 16:29:20.460987Z] Running clobber step. 09:29:20 INFO - Running pre-action listener: _resource_record_pre_action 09:29:20 INFO - Running main action method: clobber 09:29:20 INFO - rmtree: /builds/slave/test/build 09:29:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:29:21 INFO - Running post-action listener: _resource_record_post_action 09:29:21 INFO - [mozharness: 2017-04-07 16:29:21.397323Z] Finished clobber step (success) 09:29:21 INFO - [mozharness: 2017-04-07 16:29:21.397422Z] Running read-buildbot-config step. 09:29:21 INFO - Running pre-action listener: _resource_record_pre_action 09:29:21 INFO - Running main action method: read_buildbot_config 09:29:21 INFO - Using buildbot properties: 09:29:21 INFO - { 09:29:21 INFO - "project": "", 09:29:21 INFO - "product": "firefox", 09:29:21 INFO - "who": "ffxbld@noreply.mozilla.org", 09:29:21 INFO - "installer_path": "public/build/target.tar.bz2", 09:29:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 09:29:21 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:29:21 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 09:29:21 INFO - "stage_platform": "linux64-stylo", 09:29:21 INFO - "basedir": "/builds/slave/test", 09:29:21 INFO - "buildnumber": 21, 09:29:21 INFO - "platform": "ubuntu64_hw_stylo", 09:29:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:29:21 INFO - "slavebuilddir": "test", 09:29:21 INFO - "taskId": "AvYMBUBzSNGAR18hTIRBiw", 09:29:21 INFO - "branch": "mozilla-central", 09:29:21 INFO - "script_repo_revision": "production", 09:29:21 INFO - "revision": "22df0c5cfbf8a2aa2822bf9c763e6c1c5a3f69de", 09:29:21 INFO - "slavename": "talos-linux64-ix-020", 09:29:21 INFO - "repo_path": "mozilla-central" 09:29:21 INFO - } 09:29:21 INFO - Finding installer, test and symbols from parent task. 09:29:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AvYMBUBzSNGAR18hTIRBiw'}, attempt #1 09:29:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AvYMBUBzSNGAR18hTIRBiw'}, attempt #1 09:29:22 INFO - Task dependencies: LYmRvCjzReSChL0lkNv9sw 09:29:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw'}, attempt #1 09:29:22 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.tar.bz2 09:29:22 INFO - Set test_url: https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/test_packages.json 09:29:22 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.crashreporter-symbols.zip 09:29:22 INFO - Running post-action listener: _resource_record_post_action 09:29:22 INFO - [mozharness: 2017-04-07 16:29:22.868633Z] Finished read-buildbot-config step (success) 09:29:22 INFO - [mozharness: 2017-04-07 16:29:22.868849Z] Running download-and-extract step. 09:29:22 INFO - Running pre-action listener: _resource_record_pre_action 09:29:22 INFO - Running main action method: download_and_extract 09:29:22 INFO - mkdir: /builds/slave/test/build/tests 09:29:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:22 INFO - trying https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.test_packages.json 09:29:22 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:29:22 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:29:23 INFO - Downloaded 986 bytes. 09:29:23 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:29:23 INFO - Using the following test package requirements: 09:29:23 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:29:23 INFO - u'common': [u'target.common.tests.zip'], 09:29:23 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:29:23 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:29:23 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:29:23 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:29:23 INFO - u'mozbase': [u'target.common.tests.zip'], 09:29:23 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:29:23 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:29:23 INFO - u'web-platform': [u'target.common.tests.zip', 09:29:23 INFO - u'target.web-platform.tests.zip'], 09:29:23 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:29:23 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:29:23 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:29:23 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:29:23 INFO - Fetch https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.common.tests.zip into memory 09:29:24 INFO - Expected file size: 58243878 09:29:24 INFO - Obtained file size: 58243878 09:29:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:29:34 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:29:34 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:29:34 INFO - Fetch https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.common.tests.zip into memory 09:29:35 INFO - Expected file size: 58243878 09:29:35 INFO - Obtained file size: 58243878 09:29:46 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:46 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:46 INFO - Fetch https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.talos.tests.zip into memory 09:29:47 INFO - Expected file size: 14404138 09:29:47 INFO - Obtained file size: 14404138 09:29:47 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:47 INFO - trying https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.tar.bz2 09:29:47 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:47 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:48 INFO - Downloaded 59058192 bytes. 09:29:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.tar.bz2 09:29:48 INFO - mkdir: /builds/slave/test/properties 09:29:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:29:48 INFO - Writing to file /builds/slave/test/properties/build_url 09:29:48 INFO - Contents: 09:29:48 INFO - build_url:https://queue.taskcluster.net/v1/task/LYmRvCjzReSChL0lkNv9sw/artifacts/public/build/target.tar.bz2 09:29:48 INFO - Running post-action listener: _resource_record_post_action 09:29:48 INFO - Running post-action listener: set_extra_try_arguments 09:29:48 INFO - [mozharness: 2017-04-07 16:29:48.603777Z] Finished download-and-extract step (success) 09:29:48 INFO - [mozharness: 2017-04-07 16:29:48.603888Z] Running populate-webroot step. 09:29:48 INFO - Running pre-action listener: _resource_record_pre_action 09:29:48 INFO - Running main action method: populate_webroot 09:29:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:29:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:29:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:29:48 INFO - '--tppagecycles', 09:29:48 INFO - '7'], 09:29:48 INFO - 'tests': ['tsvgm']}}, 09:29:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:29:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:29:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:29:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:29:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:29:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:29:48 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:29:48 INFO - 'talos_options': ['--disable-e10s'], 09:29:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:29:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:29:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:29:48 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:29:48 INFO - 'talos_options': ['--disable-e10s'], 09:29:48 INFO - 'tests': ['damp', 'tps']}, 09:29:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:29:48 INFO - 'tests': ['damp', 'tps']}, 09:29:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:29:48 INFO - 'tests': ['dromaeo_dom']}, 09:29:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:29:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:29:48 INFO - 'tests': ['basic_compositor_video']}, 09:29:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:29:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:29:48 INFO - 'tests': ['a11yr', 09:29:48 INFO - 'ts_paint', 09:29:48 INFO - 'tpaint', 09:29:48 INFO - 'sessionrestore', 09:29:48 INFO - 'sessionrestore_no_auto_restore', 09:29:48 INFO - 'tabpaint']}, 09:29:48 INFO - 'other-e10s': {'tests': ['a11yr', 09:29:48 INFO - 'ts_paint', 09:29:48 INFO - 'tpaint', 09:29:48 INFO - 'sessionrestore', 09:29:48 INFO - 'sessionrestore_no_auto_restore', 09:29:48 INFO - 'tabpaint']}, 09:29:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:29:48 INFO - 'ts_paint', 09:29:48 INFO - 'tpaint', 09:29:48 INFO - 'sessionrestore', 09:29:48 INFO - 'sessionrestore_no_auto_restore', 09:29:48 INFO - 'tabpaint']}, 09:29:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:29:48 INFO - 'ts_paint', 09:29:48 INFO - 'tpaint', 09:29:48 INFO - 'sessionrestore', 09:29:48 INFO - 'sessionrestore_no_auto_restore', 09:29:48 INFO - 'tabpaint']}, 09:29:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:29:48 INFO - 'tests': ['a11yr', 09:29:48 INFO - 'ts_paint', 09:29:48 INFO - 'tpaint', 09:29:48 INFO - 'sessionrestore', 09:29:48 INFO - 'sessionrestore_no_auto_restore', 09:29:48 INFO - 'tabpaint']}, 09:29:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:29:48 INFO - 'tests': ['a11yr', 09:29:48 INFO - 'ts_paint', 09:29:48 INFO - 'tpaint', 09:29:48 INFO - 'sessionrestore', 09:29:48 INFO - 'sessionrestore_no_auto_restore', 09:29:48 INFO - 'tabpaint']}, 09:29:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:29:48 INFO - 'tests': ['tsvgx', 09:29:48 INFO - 'tsvgr_opacity', 09:29:48 INFO - 'tart', 09:29:48 INFO - 'tscrollx', 09:29:48 INFO - 'cart', 09:29:48 INFO - 'tsvg_static']}, 09:29:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:29:48 INFO - 'tsvgr_opacity', 09:29:48 INFO - 'tart', 09:29:48 INFO - 'tscrollx', 09:29:48 INFO - 'cart', 09:29:48 INFO - 'tsvg_static']}, 09:29:48 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:29:48 INFO - 'talos_options': ['--disable-e10s'], 09:29:48 INFO - 'tests': ['tp5o']}, 09:29:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:29:48 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:29:48 INFO - 'talos_options': ['--disable-e10s', 09:29:48 INFO - '--xperf_path', 09:29:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:29:48 INFO - 'tests': ['tp5n']}, 09:29:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:29:48 INFO - 'talos_options': ['--xperf_path', 09:29:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:29:48 INFO - 'tests': ['tp5n']}}, 09:29:48 INFO - 'talos.zip': {'path': '', 09:29:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:29:48 INFO - Running post-action listener: _resource_record_post_action 09:29:48 INFO - [mozharness: 2017-04-07 16:29:48.623249Z] Finished populate-webroot step (success) 09:29:48 INFO - [mozharness: 2017-04-07 16:29:48.623339Z] Running create-virtualenv step. 09:29:48 INFO - Running pre-action listener: _resource_record_pre_action 09:29:48 INFO - Running main action method: create_virtualenv 09:29:48 INFO - Creating virtualenv /builds/slave/test/build/venv 09:29:48 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:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:29:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:29:48 INFO - Using real prefix '/usr' 09:29:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:29:49 INFO - Installing distribute.............................................................................................................................................................................................done. 09:29:51 INFO - Installing pip.................done. 09:29:51 INFO - Return code: 0 09:29:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:29:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:29:51 INFO - Reading from file tmpfile_stdout 09:29:51 INFO - Output received: 09:29:51 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:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:29:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b14b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b12290>, '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 0x1b12b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b13040>, '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': 'af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770', '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:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:29:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:29:51 INFO - Using env: {'DISPLAY': ':0', 09:29:51 INFO - 'HOME': '/home/cltbld', 09:29:51 INFO - 'LANG': 'en_US.UTF-8', 09:29:51 INFO - 'LANGUAGE': 'en_US:en', 09:29:51 INFO - 'LOGNAME': 'cltbld', 09:29:51 INFO - 'MAIL': '/var/mail/cltbld', 09:29:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:51 INFO - 'MOZ_NO_REMOTE': '1', 09:29:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:51 INFO - 'NO_EM_RESTART': '1', 09:29:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:51 INFO - 'PWD': '/builds/slave/test', 09:29:51 INFO - 'SHELL': '/bin/bash', 09:29:51 INFO - 'SHLVL': '1', 09:29:51 INFO - 'TERM': 'linux', 09:29:51 INFO - 'TMOUT': '86400', 09:29:51 INFO - 'USER': 'cltbld', 09:29:51 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770', 09:29:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:51 INFO - '_': '/tools/buildbot/bin/python'} 09:29:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:51 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:51 INFO - Cleaning up... 09:29:51 INFO - Return code: 0 09:29:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:29:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b14b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b12290>, '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 0x1b12b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b13040>, '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': 'af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770', '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:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:29:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:29:51 INFO - Using env: {'DISPLAY': ':0', 09:29:51 INFO - 'HOME': '/home/cltbld', 09:29:51 INFO - 'LANG': 'en_US.UTF-8', 09:29:51 INFO - 'LANGUAGE': 'en_US:en', 09:29:51 INFO - 'LOGNAME': 'cltbld', 09:29:51 INFO - 'MAIL': '/var/mail/cltbld', 09:29:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:51 INFO - 'MOZ_NO_REMOTE': '1', 09:29:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:51 INFO - 'NO_EM_RESTART': '1', 09:29:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:51 INFO - 'PWD': '/builds/slave/test', 09:29:51 INFO - 'SHELL': '/bin/bash', 09:29:51 INFO - 'SHLVL': '1', 09:29:51 INFO - 'TERM': 'linux', 09:29:51 INFO - 'TMOUT': '86400', 09:29:51 INFO - 'USER': 'cltbld', 09:29:51 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770', 09:29:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:51 INFO - '_': '/tools/buildbot/bin/python'} 09:29:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:51 INFO - Downloading/unpacking psutil>=3.1.1 09:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:29:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:29:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:29:53 INFO - Installing collected packages: psutil 09:29:53 INFO - Running setup.py install for psutil 09:29:54 INFO - building 'psutil._psutil_linux' extension 09:29:54 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:54 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:54 INFO - building 'psutil._psutil_posix' extension 09:29:54 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:54 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:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:29:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:29:54 INFO - Successfully installed psutil 09:29:54 INFO - Cleaning up... 09:29:54 INFO - Return code: 0 09:29:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b14b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b12290>, '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 0x1b12b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b13040>, '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': 'af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770', '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:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:29:54 INFO - Using env: {'DISPLAY': ':0', 09:29:54 INFO - 'HOME': '/home/cltbld', 09:29:54 INFO - 'LANG': 'en_US.UTF-8', 09:29:54 INFO - 'LANGUAGE': 'en_US:en', 09:29:54 INFO - 'LOGNAME': 'cltbld', 09:29:54 INFO - 'MAIL': '/var/mail/cltbld', 09:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:54 INFO - 'MOZ_NO_REMOTE': '1', 09:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:54 INFO - 'NO_EM_RESTART': '1', 09:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:54 INFO - 'PWD': '/builds/slave/test', 09:29:54 INFO - 'SHELL': '/bin/bash', 09:29:54 INFO - 'SHLVL': '1', 09:29:54 INFO - 'TERM': 'linux', 09:29:54 INFO - 'TMOUT': '86400', 09:29:54 INFO - 'USER': 'cltbld', 09:29:54 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770', 09:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:54 INFO - '_': '/tools/buildbot/bin/python'} 09:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:29:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:29:56 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:56 INFO - Installing collected packages: mozsystemmonitor 09:29:56 INFO - Running setup.py install for mozsystemmonitor 09:29:56 INFO - Successfully installed mozsystemmonitor 09:29:56 INFO - Cleaning up... 09:29:56 INFO - Return code: 0 09:29:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:29:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b14b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b12290>, '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 0x1b12b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b13040>, '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': 'af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770', '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:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:29:56 INFO - Using env: {'DISPLAY': ':0', 09:29:56 INFO - 'HOME': '/home/cltbld', 09:29:56 INFO - 'LANG': 'en_US.UTF-8', 09:29:56 INFO - 'LANGUAGE': 'en_US:en', 09:29:56 INFO - 'LOGNAME': 'cltbld', 09:29:56 INFO - 'MAIL': '/var/mail/cltbld', 09:29:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:56 INFO - 'MOZ_NO_REMOTE': '1', 09:29:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:56 INFO - 'NO_EM_RESTART': '1', 09:29:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:56 INFO - 'PWD': '/builds/slave/test', 09:29:57 INFO - 'SHELL': '/bin/bash', 09:29:57 INFO - 'SHLVL': '1', 09:29:57 INFO - 'TERM': 'linux', 09:29:57 INFO - 'TMOUT': '86400', 09:29:57 INFO - 'USER': 'cltbld', 09:29:57 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770', 09:29:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:57 INFO - '_': '/tools/buildbot/bin/python'} 09:29:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:57 INFO - Downloading/unpacking jsonschema==2.5.1 09:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:29:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:59 INFO - Downloading functools32-3.2.3-2.tar.gz 09:29:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:29:59 INFO - warning: no files found matching '*.txt' 09:29:59 INFO - no previously-included directories found matching 'build' 09:29:59 INFO - no previously-included directories found matching 'dist' 09:29:59 INFO - no previously-included directories found matching '.git*' 09:29:59 INFO - Installing collected packages: jsonschema, functools32 09:29:59 INFO - Running setup.py install for functools32 09:29:59 INFO - warning: no files found matching '*.txt' 09:29:59 INFO - no previously-included directories found matching 'build' 09:29:59 INFO - no previously-included directories found matching 'dist' 09:29:59 INFO - no previously-included directories found matching '.git*' 09:29:59 INFO - Successfully installed jsonschema functools32 09:29:59 INFO - Cleaning up... 09:29:59 INFO - Return code: 0 09:29:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:59 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 0x18771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b14b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b12290>, '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 0x1b12b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b13040>, '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': 'af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770', '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:59 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:59 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:59 INFO - Using env: {'DISPLAY': ':0', 09:29:59 INFO - 'HOME': '/home/cltbld', 09:29:59 INFO - 'LANG': 'en_US.UTF-8', 09:29:59 INFO - 'LANGUAGE': 'en_US:en', 09:29:59 INFO - 'LOGNAME': 'cltbld', 09:29:59 INFO - 'MAIL': '/var/mail/cltbld', 09:29:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:59 INFO - 'MOZ_NO_REMOTE': '1', 09:29:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:59 INFO - 'NO_EM_RESTART': '1', 09:29:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:59 INFO - 'PWD': '/builds/slave/test', 09:29:59 INFO - 'SHELL': '/bin/bash', 09:29:59 INFO - 'SHLVL': '1', 09:29:59 INFO - 'TERM': 'linux', 09:29:59 INFO - 'TMOUT': '86400', 09:29:59 INFO - 'USER': 'cltbld', 09:29:59 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770', 09:29:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:59 INFO - '_': '/tools/buildbot/bin/python'} 09:29:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:29:59 INFO - Cleaning up... 09:29:59 INFO - Return code: 0 09:29:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:59 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 0x18771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b14b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b12290>, '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 0x1b12b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b13040>, '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': 'af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770', '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:59 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:59 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:59 INFO - Using env: {'DISPLAY': ':0', 09:29:59 INFO - 'HOME': '/home/cltbld', 09:29:59 INFO - 'LANG': 'en_US.UTF-8', 09:29:59 INFO - 'LANGUAGE': 'en_US:en', 09:29:59 INFO - 'LOGNAME': 'cltbld', 09:29:59 INFO - 'MAIL': '/var/mail/cltbld', 09:29:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:59 INFO - 'MOZ_NO_REMOTE': '1', 09:29:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:59 INFO - 'NO_EM_RESTART': '1', 09:29:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:59 INFO - 'PWD': '/builds/slave/test', 09:29:59 INFO - 'SHELL': '/bin/bash', 09:29:59 INFO - 'SHLVL': '1', 09:29:59 INFO - 'TERM': 'linux', 09:29:59 INFO - 'TMOUT': '86400', 09:29:59 INFO - 'USER': 'cltbld', 09:29:59 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770', 09:29:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:59 INFO - '_': '/tools/buildbot/bin/python'} 09:30:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:00 INFO - Downloading/unpacking blobuploader==1.2.4 09:30:00 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:30:00 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:30:00 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:30:00 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:30:00 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:30:00 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:30:02 INFO - Downloading blobuploader-1.2.4.tar.gz 09:30:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:30:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:30:02 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:30:02 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:30:02 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:30:02 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:30:02 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:30:02 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:30:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:30:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:30:03 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:30:03 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:30:03 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:30:03 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:30:03 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:30:03 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:30:03 INFO - Downloading docopt-0.6.1.tar.gz 09:30:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:30:03 INFO - Installing collected packages: blobuploader, requests, docopt 09:30:03 INFO - Running setup.py install for blobuploader 09:30:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:30:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:30:03 INFO - Running setup.py install for requests 09:30:03 INFO - Running setup.py install for docopt 09:30:03 INFO - Successfully installed blobuploader requests docopt 09:30:03 INFO - Cleaning up... 09:30:03 INFO - Return code: 0 09:30:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:03 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 0x18771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b14b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b12290>, '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 0x1b12b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b13040>, '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': 'af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770', '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:30:03 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:30:03 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:30:03 INFO - Using env: {'DISPLAY': ':0', 09:30:03 INFO - 'HOME': '/home/cltbld', 09:30:03 INFO - 'LANG': 'en_US.UTF-8', 09:30:03 INFO - 'LANGUAGE': 'en_US:en', 09:30:03 INFO - 'LOGNAME': 'cltbld', 09:30:03 INFO - 'MAIL': '/var/mail/cltbld', 09:30:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:03 INFO - 'MOZ_NO_REMOTE': '1', 09:30:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:03 INFO - 'NO_EM_RESTART': '1', 09:30:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:03 INFO - 'PWD': '/builds/slave/test', 09:30:03 INFO - 'SHELL': '/bin/bash', 09:30:03 INFO - 'SHLVL': '1', 09:30:03 INFO - 'TERM': 'linux', 09:30:03 INFO - 'TMOUT': '86400', 09:30:03 INFO - 'USER': 'cltbld', 09:30:03 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770', 09:30:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:03 INFO - '_': '/tools/buildbot/bin/python'} 09:30:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:30:04 INFO - Running setup.py (path:/tmp/pip-cLP8uG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:30:04 INFO - Running setup.py (path:/tmp/pip-YR3Auo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:30:04 INFO - Running setup.py (path:/tmp/pip-AQRkNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:30:04 INFO - Running setup.py (path:/tmp/pip-ZFe6gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:30:04 INFO - Running setup.py (path:/tmp/pip-217SmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:30:04 INFO - Running setup.py (path:/tmp/pip-4nptvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:30:04 INFO - Running setup.py (path:/tmp/pip-luhJbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:30:04 INFO - Running setup.py (path:/tmp/pip-IwlC_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:30:04 INFO - Running setup.py (path:/tmp/pip-3GWYFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:30:04 INFO - Running setup.py (path:/tmp/pip-i08Sl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:30:04 INFO - Running setup.py (path:/tmp/pip-q8MDI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:30:04 INFO - Running setup.py (path:/tmp/pip-3JXME4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:30:05 INFO - Running setup.py (path:/tmp/pip-slbAfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:30:05 INFO - Running setup.py (path:/tmp/pip-C06KYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:05 INFO - Running setup.py (path:/tmp/pip-JDQr6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:30:05 INFO - Running setup.py (path:/tmp/pip-5eMC7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:30:05 INFO - Running setup.py (path:/tmp/pip-Rj1HS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:30:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:30:05 INFO - Running setup.py install for manifestparser 09:30:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:30:05 INFO - Running setup.py install for mozcrash 09:30:05 INFO - Running setup.py install for mozdebug 09:30:05 INFO - Running setup.py install for mozdevice 09:30:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:30:05 INFO - Running setup.py install for mozfile 09:30:05 INFO - Running setup.py install for mozhttpd 09:30:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:30:06 INFO - Running setup.py install for mozinfo 09:30:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:30:06 INFO - Running setup.py install for mozInstall 09:30:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:30:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:30:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:30:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:30:06 INFO - Running setup.py install for mozleak 09:30:06 INFO - Running setup.py install for mozlog 09:30:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:30:06 INFO - Running setup.py install for moznetwork 09:30:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:30:06 INFO - Running setup.py install for mozprocess 09:30:06 INFO - Running setup.py install for mozprofile 09:30:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:30:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:30:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:30:06 INFO - Running setup.py install for mozrunner 09:30:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:30:06 INFO - Running setup.py install for mozscreenshot 09:30:06 INFO - Running setup.py install for moztest 09:30:07 INFO - Running setup.py install for mozversion 09:30:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:30:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:30:07 INFO - Cleaning up... 09:30:07 INFO - Return code: 0 09:30:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:07 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 0x18771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b14b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b12290>, '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 0x1b12b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b13040>, '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': 'af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770', '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:30:07 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:30:07 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:30:07 INFO - Using env: {'DISPLAY': ':0', 09:30:07 INFO - 'HOME': '/home/cltbld', 09:30:07 INFO - 'LANG': 'en_US.UTF-8', 09:30:07 INFO - 'LANGUAGE': 'en_US:en', 09:30:07 INFO - 'LOGNAME': 'cltbld', 09:30:07 INFO - 'MAIL': '/var/mail/cltbld', 09:30:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:07 INFO - 'MOZ_NO_REMOTE': '1', 09:30:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:07 INFO - 'NO_EM_RESTART': '1', 09:30:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:07 INFO - 'PWD': '/builds/slave/test', 09:30:07 INFO - 'SHELL': '/bin/bash', 09:30:07 INFO - 'SHLVL': '1', 09:30:07 INFO - 'TERM': 'linux', 09:30:07 INFO - 'TMOUT': '86400', 09:30:07 INFO - 'USER': 'cltbld', 09:30:07 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770', 09:30:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:07 INFO - '_': '/tools/buildbot/bin/python'} 09:30:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:30:07 INFO - Running setup.py (path:/tmp/pip-P4iPzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:30:07 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:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:30:07 INFO - Running setup.py (path:/tmp/pip-lB2CE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:30:07 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:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:30:07 INFO - Running setup.py (path:/tmp/pip-915g_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:30:07 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:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:30:07 INFO - Running setup.py (path:/tmp/pip-ibCDFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:30:07 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:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:30:07 INFO - Running setup.py (path:/tmp/pip-7VuXdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:30:07 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:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:30:07 INFO - Running setup.py (path:/tmp/pip-cHVkJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:30:07 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:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:30:07 INFO - Running setup.py (path:/tmp/pip-c1jRW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:30:07 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:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:30:07 INFO - Running setup.py (path:/tmp/pip-XlAqxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:30:07 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:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:30:07 INFO - Running setup.py (path:/tmp/pip-l7KjER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:30:08 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:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:30:08 INFO - Running setup.py (path:/tmp/pip-yOW4Jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:30:08 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:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:30:08 INFO - Running setup.py (path:/tmp/pip-rCozov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:30:08 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:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:30:08 INFO - Running setup.py (path:/tmp/pip-_qCKzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:30:08 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:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:30:08 INFO - Running setup.py (path:/tmp/pip-P3gPY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:30:08 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:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:30:08 INFO - Running setup.py (path:/tmp/pip-U_XSFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:30:08 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:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:08 INFO - Running setup.py (path:/tmp/pip-oB2l5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:08 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:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:30:08 INFO - Running setup.py (path:/tmp/pip-8I4nSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:30:08 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:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:30:08 INFO - Running setup.py (path:/tmp/pip-hKcwEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:30:08 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:30:08 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:30:08 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:30:08 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:30:08 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:30:08 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:30:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:30:08 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:30:08 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:30:08 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:30:08 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:30:08 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:30:08 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:30:10 INFO - Downloading blessings-1.6.tar.gz 09:30:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:30:10 INFO - Installing collected packages: blessings 09:30:10 INFO - Running setup.py install for blessings 09:30:10 INFO - Successfully installed blessings 09:30:10 INFO - Cleaning up... 09:30:10 INFO - Return code: 0 09:30:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:30:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:30:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:30:11 INFO - Reading from file tmpfile_stdout 09:30:11 INFO - Current package versions: 09:30:11 INFO - argparse == 1.2.1 09:30:11 INFO - blessings == 1.6 09:30:11 INFO - blobuploader == 1.2.4 09:30:11 INFO - docopt == 0.6.1 09:30:11 INFO - functools32 == 3.2.3-2 09:30:11 INFO - jsonschema == 2.5.1 09:30:11 INFO - manifestparser == 1.1 09:30:11 INFO - mozInstall == 1.12 09:30:11 INFO - mozcrash == 1.0 09:30:11 INFO - mozdebug == 0.1 09:30:11 INFO - mozdevice == 0.50 09:30:11 INFO - mozfile == 1.2 09:30:11 INFO - mozhttpd == 0.7 09:30:11 INFO - mozinfo == 0.9 09:30:11 INFO - mozleak == 0.1 09:30:11 INFO - mozlog == 3.4 09:30:11 INFO - moznetwork == 0.27 09:30:11 INFO - mozprocess == 0.25 09:30:11 INFO - mozprofile == 0.28 09:30:11 INFO - mozrunner == 6.13 09:30:11 INFO - mozscreenshot == 0.1 09:30:11 INFO - mozsystemmonitor == 0.3 09:30:11 INFO - moztest == 0.8 09:30:11 INFO - mozversion == 1.4 09:30:11 INFO - psutil == 3.1.1 09:30:11 INFO - requests == 1.2.3 09:30:11 INFO - wsgiref == 0.1.2 09:30:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30: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:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30: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:30:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:11 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 0x18771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b14b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b12290>, '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 0x1b12b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b13040>, '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': 'af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770', '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:30:11 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:30:11 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:30:11 INFO - Using env: {'DISPLAY': ':0', 09:30:11 INFO - 'HOME': '/home/cltbld', 09:30:11 INFO - 'LANG': 'en_US.UTF-8', 09:30:11 INFO - 'LANGUAGE': 'en_US:en', 09:30:11 INFO - 'LOGNAME': 'cltbld', 09:30:11 INFO - 'MAIL': '/var/mail/cltbld', 09:30:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:11 INFO - 'MOZ_NO_REMOTE': '1', 09:30:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:11 INFO - 'NO_EM_RESTART': '1', 09:30:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:11 INFO - 'PWD': '/builds/slave/test', 09:30:11 INFO - 'SHELL': '/bin/bash', 09:30:11 INFO - 'SHLVL': '1', 09:30:11 INFO - 'TERM': 'linux', 09:30:11 INFO - 'TMOUT': '86400', 09:30:11 INFO - 'USER': 'cltbld', 09:30:11 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770', 09:30:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:11 INFO - '_': '/tools/buildbot/bin/python'} 09:30:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:11 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:30:11 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:30:11 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:30:11 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:30:11 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:30:11 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:30:11 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:30:11 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:30:11 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:30:11 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:30:11 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:30:11 INFO - Cleaning up... 09:30:11 INFO - Return code: 0 09:30:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:30: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:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30: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:30:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18771f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b14b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b12290>, '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 0x1b12b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b13040>, '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': 'af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770', '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:30: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'] in /builds/slave/test/build 09:30: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 09:30:11 INFO - Using env: {'DISPLAY': ':0', 09:30:11 INFO - 'HOME': '/home/cltbld', 09:30:11 INFO - 'LANG': 'en_US.UTF-8', 09:30:11 INFO - 'LANGUAGE': 'en_US:en', 09:30:11 INFO - 'LOGNAME': 'cltbld', 09:30:11 INFO - 'MAIL': '/var/mail/cltbld', 09:30:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:11 INFO - 'MOZ_NO_REMOTE': '1', 09:30:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:11 INFO - 'NO_EM_RESTART': '1', 09:30:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:11 INFO - 'PWD': '/builds/slave/test', 09:30:11 INFO - 'SHELL': '/bin/bash', 09:30:11 INFO - 'SHLVL': '1', 09:30:11 INFO - 'TERM': 'linux', 09:30:11 INFO - 'TMOUT': '86400', 09:30:11 INFO - 'USER': 'cltbld', 09:30:11 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770', 09:30:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:11 INFO - '_': '/tools/buildbot/bin/python'} 09:30:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:30:11 INFO - Cleaning up... 09:30:11 INFO - Return code: 0 09:30:11 INFO - Running post-action listener: _resource_record_post_action 09:30:11 INFO - Running post-action listener: _start_resource_monitoring 09:30:11 INFO - Starting resource monitoring. 09:30:11 INFO - [mozharness: 2017-04-07 16:30:11.702522Z] Finished create-virtualenv step (success) 09:30:11 INFO - [mozharness: 2017-04-07 16:30:11.703041Z] Running install step. 09:30:11 INFO - Running pre-action listener: _resource_record_pre_action 09:30:11 INFO - Running main action method: install 09:30:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:30:11 INFO - Reading from file tmpfile_stdout 09:30:11 INFO - Detecting whether we're running mozinstall >=1.0... 09:30:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:30:11 INFO - Reading from file tmpfile_stdout 09:30:11 INFO - Output received: 09:30:11 INFO - Usage: mozinstall [options] installer 09:30:11 INFO - Options: 09:30:11 INFO - -h, --help show this help message and exit 09:30:11 INFO - -d DEST, --destination=DEST 09:30:11 INFO - Directory to install application into. [default: 09:30:11 INFO - "/builds/slave/test"] 09:30:11 INFO - --app=APP Application being installed. [default: firefox] 09:30:11 INFO - mkdir: /builds/slave/test/build/application 09:30:11 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:30:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:30:28 INFO - Reading from file tmpfile_stdout 09:30:28 INFO - Output received: 09:30:28 INFO - /builds/slave/test/build/application/firefox/firefox 09:30:28 INFO - Running post-action listener: _resource_record_post_action 09:30:28 INFO - [mozharness: 2017-04-07 16:30:28.369579Z] Finished install step (success) 09:30:28 INFO - [mozharness: 2017-04-07 16:30:28.369852Z] Running run-tests step. 09:30:28 INFO - Running pre-action listener: _resource_record_pre_action 09:30:28 INFO - Running main action method: run_tests 09:30:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:30:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:30:28 INFO - Python 2.7.3 09:30:28 INFO - Return code: 0 09:30:28 INFO - grabbing minidump binary from tooltool 09:30:28 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:30:28 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 0x1b12290>, '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 0x1b12b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b13040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:30:28 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:30:28 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:30:28 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:30:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:30:28 INFO - Return code: 0 09:30:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:30:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:30:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:30:28 INFO - ENV: RUST_BACKTRACE is now 1 09:30:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:30:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:30:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--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-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:30:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --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-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:30:28 INFO - Using env: {'DISPLAY': ':0', 09:30:28 INFO - 'HOME': '/home/cltbld', 09:30:28 INFO - 'LANG': 'en_US.UTF-8', 09:30:28 INFO - 'LANGUAGE': 'en_US:en', 09:30:28 INFO - 'LOGNAME': 'cltbld', 09:30:28 INFO - 'MAIL': '/var/mail/cltbld', 09:30:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:30:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:30:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:28 INFO - 'MOZ_NO_REMOTE': '1', 09:30:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:30:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:28 INFO - 'NO_EM_RESTART': '1', 09:30:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:28 INFO - 'PWD': '/builds/slave/test', 09:30:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:30:28 INFO - 'RUST_BACKTRACE': '1', 09:30:28 INFO - 'SHELL': '/bin/bash', 09:30:28 INFO - 'SHLVL': '1', 09:30:28 INFO - 'TERM': 'linux', 09:30:28 INFO - 'TMOUT': '86400', 09:30:28 INFO - 'USER': 'cltbld', 09:30:28 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770', 09:30:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:28 INFO - '_': '/tools/buildbot/bin/python'} 09:30:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--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-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:30:28 INFO - mozversion application_buildid: 20170407155236 09:30:28 INFO - mozversion application_changeset: 22df0c5cfbf8a2aa2822bf9c763e6c1c5a3f69de 09:30:28 INFO - mozversion application_display_name: Nightly 09:30:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:30:28 INFO - mozversion application_name: Firefox 09:30:28 INFO - mozversion application_remotingname: firefox 09:30:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:30:28 INFO - mozversion application_vendor: Mozilla 09:30:28 INFO - mozversion application_version: 55.0a1 09:30:28 INFO - mozversion platform_buildid: 20170407155236 09:30:28 INFO - mozversion platform_changeset: 22df0c5cfbf8a2aa2822bf9c763e6c1c5a3f69de 09:30:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:30:28 INFO - mozversion platform_version: 55.0a1 09:30:28 INFO - using testdate: 1491582628 09:30:28 INFO - actual date: 1491582628 09:30:28 INFO - starting webserver on 'localhost:49489' 09:30:28 INFO - SUITE-START | Running 2 tests 09:30:28 INFO - TEST-START | dromaeo_css 09:30:28 INFO - operating with platform_type : linux_ 09:30:28 INFO - Initialising browser for dromaeo_css test... 09:30:28 INFO - TEST-INFO | started process 29212 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgtAX5G/profile http://localhost:49489/getInfo.html) 09:30:33 INFO - PID 29212 | __metrics Screen width/height:1600/1200 09:30:33 INFO - PID 29212 | colorDepth:24 09:30:33 INFO - PID 29212 | Browser inner width/height: 1024/697 09:30:33 INFO - PID 29212 | __metrics 09:30:35 ERROR - PID 29212 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 09:30:36 INFO - TEST-INFO | 29212: exit 0 09:30:36 INFO - Browser initialized. 09:30:36 INFO - Running cycle 1/1 for dromaeo_css test... 09:30:36 INFO - TEST-INFO | started process 29356 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgtAX5G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:30:48 INFO - PID 29356 | RSS: Main: 177364992 09:30:48 INFO - PID 29356 | 09:33:53 INFO - PID 29356 | Cycle 1(1): loaded http://localhost:49489/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49489/tests/dromaeo/cssquery-ext.html) 09:33:55 INFO - PID 29356 | RSS: Main: 188506112 09:33:55 INFO - PID 29356 | 09:35:36 INFO - PID 29356 | ************************* 09:35:36 INFO - PID 29356 | A coding exception was thrown and uncaught in a Task. 09:35:36 INFO - PID 29356 | 09:35:36 ERROR - PID 29356 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:35:36 INFO - PID 29356 | Full stack: 09:35:36 INFO - PID 29356 | ************************* 09:35:36 INFO - PID 29356 | ************************* 09:35:36 INFO - PID 29356 | A coding exception was thrown and uncaught in a Task. 09:35:36 INFO - PID 29356 | 09:35:36 ERROR - PID 29356 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:35:36 INFO - PID 29356 | Full stack: 09:35:36 INFO - PID 29356 | ************************* 09:35:36 INFO - PID 29356 | ************************* 09:35:36 INFO - PID 29356 | A coding exception was thrown and uncaught in a Task. 09:35:36 INFO - PID 29356 | 09:35:36 ERROR - PID 29356 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:35:36 INFO - PID 29356 | Full stack: 09:35:36 INFO - PID 29356 | ************************* 09:35:36 INFO - PID 29356 | ************************* 09:35:36 INFO - PID 29356 | A coding exception was thrown and uncaught in a Task. 09:35:36 INFO - PID 29356 | 09:35:36 ERROR - PID 29356 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:35:36 INFO - PID 29356 | Full stack: 09:35:36 INFO - PID 29356 | ************************* 09:36:57 INFO - PID 29356 | Cycle 1(1): loaded http://localhost:49489/tests/dromaeo/cssquery-ext.html (next: http://localhost:49489/tests/dromaeo/cssquery-jquery.html) 09:36:58 INFO - PID 29356 | RSS: Main: 185229312 09:36:58 INFO - PID 29356 | 09:40:00 INFO - PID 29356 | Cycle 1(1): loaded http://localhost:49489/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49489/tests/dromaeo/cssquery-mootools.html) 09:40:00 INFO - PID 29356 | RSS: Main: 193986560 09:40:00 INFO - PID 29356 | 09:43:02 INFO - PID 29356 | Cycle 1(1): loaded http://localhost:49489/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49489/tests/dromaeo/cssquery-prototype.html) 09:43:03 INFO - PID 29356 | RSS: Main: 187887616 09:43:03 INFO - PID 29356 | 09:46:06 INFO - PID 29356 | Cycle 1(1): loaded http://localhost:49489/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49489/tests/dromaeo/cssquery-yui.html) 09:46:06 INFO - PID 29356 | RSS: Main: 194699264 09:46:06 INFO - PID 29356 | 09:49:09 INFO - PID 29356 | Cycle 1(1): loaded http://localhost:49489/tests/dromaeo/cssquery-yui.html (next: http://localhost:49489/tests/dromaeo/cssquery-dojo.html) 09:49:09 INFO - PID 29356 | RSS: Main: 191397888 09:49:09 INFO - PID 29356 | 09:49:09 INFO - PID 29356 | __start_tp_report 09:49:09 INFO - PID 29356 | _x_x_mozilla_page_load 09:49:09 INFO - PID 29356 | _x_x_mozilla_page_load_details 09:49:09 INFO - PID 29356 | |i|pagename|runs| 09:49:09 INFO - PID 29356 | |0;dojo.html;2753.1740477856642;2760.5307097793375;2780.7775377969765;2800.1319590926814;2803.285162283618;5230.398504172022;5316.5215130638235;5322.4411436799155;5368.865778355543;5372.7045012524295;5304.6286759926825;5322.361316641999;5348.171033489805;5382.9730851345785;5427.348718153818;4727.101850648374;4776.593989510896;4785.832495862645;4793.784279707422;4804.591609713161;4786.066716990188;4803.879903002436;4836.903261934759;4842.394700662418;4884.3406140171155;4704.388429504143;4718.197906355927;4737.905241895142;4755.50067242938;4768;4728.148933192024;4736.360591320196;4755.476897541268;4784.952150478521;4795.880102997418;4668.996165824364;4711.8350857719815;4723.952760472385;4731.4795372509;4779.617630589544;5145;5191.195364718475;5201.349831271091;5226.372835259755;5262.2632831403635;5777.277840269966;5785.363610002896;5791.391903850077;5831.416858314177;5848.912266315966;5801.390853960315;5812.128180772918;5819.854503637401;5824.213731146326;5829.242198514208;5311.49540793624;5375.274337964403;5378;5406.135018397038;5440;5981.820545383645;6010.338862725097;6011.819645410645;6041.124037014608;6080.847978800565;5583.664980101207;5621.831345059655;5639.718014099279;5695.601307908407;5705.74324155414;5709.885802283931;5711.885762284731;5760.193572899798;5760.855978600484;5822.388649191774;5565.805196818092;5638.2670252866865;5713.428657134254;5732.656040637575;5742.712864356766;5770.990076736554;5782.855428614318;5783.074708046693;5804.6807425592;5820.941790582125;4911.607071434348;4924.581410580141;4930.161872481687;4938.358013458227;4991.201407774739;4101.89745256365;4118.711690181718;4150.771707556113;4157.8336866525;4169.728967617095;4893.119238537026;4922.778474968635;4925.532074452921;4953.356063711694;4977.303177555145;5760.855978600569;5796.492911842867;5803.187553742479;5813.8081693253625;5830.679312637845;4784.736839473792;4851.611871050308;4888.731119788375;4900.509949005071;4929.06347793918;5103.7192954387865;5108.6168537359845;5141.871453213625;5162.5095615916425;5185.533302002837;5298.231756395378;5304.283921670525;5318.149096144598;5321.494458026481;5322.574194064388;5677.290338707661;5736.741846616829;5811.244538210175;5832.066869300891;5883.735231914659;5290;5308.938212357467;5355.6343132502525;5355.812546560852;5379.112446446293;5722.370539240764;5736.713164341682;5758.913616295843;5779.075347944308;5789.942100579109;5716.28546431696;5790.420957904176;5808.332041815245;5837.854053648693;5872.265966754156;5634.915476267777;5639.464250896158;5655.632383895034;5693.772249109989;5729.512991395778;5554.611177217556;5583.609147359646;5586.273784408001;5593.804216852391;5667.744951477276;5455.290812194389;5496.532794712494;5516.613837031369;5536.2249285100925;5600.915986260128;5666.2350582670815;5668.631538949955;5698.629589076697;5724.8568785779025;5739.053056245672;5433.239346491573;5459.945400545944;5502.119660854244;5506.531944784738;5519 09:49:09 INFO - PID 29356 | |1;ext.html;721.1814590439851;1067.231593252858;1086.2179230953711;1205.4033253539494;1212.5271144253747;32764.672353276488;33533.66466335336;33575.49636755451;33649.32701345978;33736.32527349451;31222.2194445139;31310.84344578274;31313.843430782872;31380.05859824209;31385.686143138562;6631.535792494527;6752.459803215731;7096.219415864251;7288.344049035586;7292.927070729278;6973.058637083979;7010.334018268256;7027.5080744347915;7032.683529241171;7044.5421047632;7027.718891244344;7088;7090.822729431779;7090.929090709078;7091.89362159568;6998.265182155902;7027.754028609025;7031.261717519664;7038.049863268445;7043.11961004877;7076.646167691595;7185.209626941032;7187.89218161728;7189.245129261404;7199.172095209065;32293;32335.83832080848;32513.83743081293;32565.185870353194;32611.673883261337;2953.586497890297;2991.6110905582136;2993.9550906736417;2994.82031078136;3000.354923691395;24515.632265516033;24561.754382456125;24573;24600.384990375205;24667.136650217337;3051.5422686596967;3074.6156730408698;3082.8150310981187;3093.752499800011;3142.3715256948703;137772;137857.3107134468;138089;138436.30781846025;138473;33983.320333593685;34090.48864267038;40396.1920761589;40573.79713101416;41126.177476450306;40857.59142408538;41004.79497602553;41014.38478422826;41263.174736505105;41517.58482415198;12380.876191238152;12593.559225427067;12598.433070511848;12610.558630447891;12611.74776504483;9842.75393115178;9877.60489580423;9882.061204185591;9895.851562226573;9933.25500587459;12679.683007924876;12807.231566106064;12877.678058048436;12882.871171288354;13091.214527128403;5283.339582552181;5351.411344752074;5374.328208973879;5475.589330800206;5543.861403464865;839.4249938791947;875.3085062800444;889.4929889962789;892.5760263874607;923.5936188077225;20184.798152018586;20236;20382.490437738878;20513.282035128697;20788.27241046556;968.5496244246318;973.2408721197477;973.2992245583168;983.6999715086824;984.2568860510269;9968.420842244084;10338.793224135476;10599.470026498644;10674.946625266824;10716.89283107159;195261;195358;195535;195542;197061;39185.41221881674;39434.80282598626;39605.40591891124;39807;39823.40264896029;1213.9575114870938;1248.3945286536023;1250.1623911978995;1258.3645259144073;1265.949362025527;18645.81354186495;19009.33467328637;19959.301424450074;20074.297399590945;20270.493237669176;28675.28311792222;28892.566611501265;29044.419111618074;29048.854755726086;29079.27301817387;177493;178453;178572;179331;179535;22727.772722272566;23074.538509230057;26428.207153785417;26838.86580567085;26943.461130777665;31550.68449315569;31729;31796.36407271888;31897;32521.512177317833;24683;24781.25656230316;24917.626235606116;25795.355116122246;26289.868550657124;24449.144279950116;24510.509789804462;24689.25932222036;25071.373215669755;25361.112361067273;27773.444531109668;27809.44381112326;27846;27849.16452506428;27922;22452.887735561217;22556.548869022856;22851;22922.656160157945;23029.76970230276;17244.655106898044;18229;18285.725714114033;18292.542686432946;18540.258389664803 09:49:09 INFO - PID 29356 | |2;jquery.html;429.7931862291941;430.1225499980041;431.50161563394283;433.61408346571545;452.27635782747586;17315.65368692627;18620.720689189657;19246.615067698636;19256.49665543481;19312.4206273812;18547.35084272051;18637.16132774025;19003.239870405167;19185.712214316798;19208.903955480237;5577.44225577442;5829.417058294158;5880.7353669085;5881.029630111048;5883.529317654577;5692.089265717486;5812.389699081599;5824.068149096145;5828.883422331551;5861.384554621767;5625.943740562583;5832;5849.122631605272;5850.941490585104;5858.941410585903;5580.525655319262;5639.843832014427;5767.798127065554;5815.098659707752;5841.561882858781;5090.821821236276;5109.795608175706;5123.513266239738;5126.282320475099;5151.793928242866;21560.25674351656;21967;22869.885650571807;22950.42623934415;22993.885030574907;1601.1353868910774;1664.592174917153;1665.1424516374077;1674.4558018643988;1676.6311411489453;14603.561893143222;14668.926655366655;14751;15130.243487825675;15234.542963711106;2072.8652637578507;2083.479130217446;2135.4981579328846;2138.9144434222612;2139.7539282982502;80213.59893200497;85238.5738071312;87142;96004.51997740037;97130.0286997128;10857.51141198648;11388;11446.885531144748;11480.966712995703;11534.653960381202;15814.36742530309;15884.52346429609;15907.920460397856;15929.123898185479;15954.20228988546;7578.469507134558;7660.5403675779635;7863.84272314562;8060.234277743605;8091.0695270043525;6705;7004.299570042955;7148.106486689164;7378.29906158914;7431.665575049135;7000.229974702778;7052.0832291801735;7064.717411303491;7134.678939447737;7253.129624444995;1945.9221631134596;1956.1588516937568;1977.4561995451365;1981.2570286142698;2153.569286142778;825.7894236969654;828.7596596986806;842.9367797415218;874.9562521874008;880.401327097567;16129.919350403174;16433.09617971023;16778.244978975974;16901.154942252837;17065.14674266282;864.6411739128317;866.7356456280895;868.5396739727954;888.4047688049022;893.4996402014892;8871.778205544913;9247.213986811063;9307.53462326881;9336.953315233517;9506.95246523763;445776;448587;469646;470310;470404;90271.54864225637;90647;91490.54254728684;92616.53691731498;92640;1068.6793961811582;1078.962236321725;1110.6279396402135;1111.5442668505873;1115.7991561519004;14195.148291102567;14201.786973195203;14289.142651440947;14367.712645747235;14812;42714;42729.78635106929;42892.571074288855;43453.130937381706;44235.55764442314;54255.18617220824;54256.18615720846;54624.18063729127;54951;55020.724896375265;7707.691692332244;7750.8837367440665;7790.5325680459355;8016.238457346776;8118.309943654619;11409;11550.480228389575;11559.479823407799;11809.23239989398;11928.224665396721;9957.850632240667;9970.451625160686;10066.597336106473;10547.261691681508;10565.788684226118;9477.810443791224;9510.524473776146;9574.712758617252;9607.51962401863;9655.806883862424;10155.187584993331;10165.79668406613;10231.334963227366;10579.4710264488;10682.412467314372;7731.110922244014;7768.184340644377;7966.760997170094;7995.240452157036;8014.599270036591;9895;10010.799784004133;10024.498775061073;10070.093691567794;10139.7465063374 09:49:09 INFO - PID 29356 | |3;mootools.html;1313.120209459662;1384.6815232496526;1392.4360633943256;1399.3912647998116;1401.0962928910853;10100.646477373293;10574.101201397882;10590.788184236311;10671.893281067187;10919.890801091986;10688.893111068886;10871.67384978452;10885.346879187255;10910;10911.07255883249;2254.9887250563766;2279.840411171219;2293.0483849202647;2298.494331247123;2304.76952304769;2157.5361297321074;2234.519578290667;2259.1641092795608;2259.48031952651;2270.182734215681;2176.880271585062;2203.9449013774624;2264.230161745006;2286.8170546356337;2298.5173113646156;2010.5375763574314;2083;2102.810747032767;2103.253345062496;2105.8210052145587;1984.117067904783;1999.7900220476786;2019.9596008079757;2138.1874887542635;2220.755716871143;10261.897381026243;10356.119729822974;10372.325798823127;10379;10392.63625773102;5809.912851307234;6052.303985041733;6053.848653783691;6084.300305464884;6091.0863370494335;3280.7652791493283;3412.5051867479324;3434.3818112739696;3436.7250619950346;3443.1736383268085;1087.4399684162663;1091.3779145886767;1115.2694984784978;1124.0557931337635;1151.8099513580248;14950.40198392063;14987.700245995127;14993.400263989428;15141.924290378587;15153;4846.248831431134;4901.779419926112;5152.742362881841;5205.609579281569;5294.444083371268;11093.611723589636;11151.888481115086;11169;11195.160362972809;11199.272047316897;5840.766369345179;5882.705864706748;5889.0283103287475;5898.8230353089475;5899.056151015902;5316.707581083;5336.839894803162;5357.571394288448;5437.646552974124;5493.121100623881;4080.8775736727944;4081.2263587497273;4092.3656833190903;4105.609967053185;4196.370544418301;1176.2001838749732;1194.6834088966432;1195.9043276537857;1202.7594481103815;1216.367488905764;653.3597074866562;685.0717278088118;688.1432616392523;691.029104108728;697.0972590495321;5706.400827913092;5764.308283006066;5774.191613174159;5798.420157984167;6038.154658347835;791.8733002719537;796.450449190057;819.983600328002;820.2658620534588;855.7176131876466;3259.1689119274433;3586.7847929124337;3645.2527231917393;3718.2749363874327;3785.6971442284553;12666.746665066647;13305.933470332586;13325.466981320833;13348.599542013755;13364.2649654268;12864.228146311065;13052.673683157996;13123.081384303197;13141;13186.208827470382;9411.952940235255;9738.75653108678;9767.902320976842;9812.509374531244;9951.402915825074;5393.460653934575;5457.727113644222;5502.779888804403;5547.916781248366;5593.468620481048;12140.271583705005;12168;12184.329861857683;12190.268583884641;12312.322822244505;12548.24710517372;12620.305883176514;12660.366981650697;12821.179340545064;12838.614841554769;7311.634418279171;7507.924920750723;7534.811629709082;7557.168711441627;7560.924390756242;9551.856722149312;9700.466474343979;9790.971947945363;9815.509224538888;9862;7651.120121186135;7744.0319960005;7761.340286075521;7831.8825217622925;7991.960040199761;7939.960300198462;8068.677252909818;8069.556174410463;8177.386695997705;8299.6680132794;7286.016387787793;7415.221401752954;7468.813279667835;7474;7486.737964171446;4923.433805112458;5091.643584949018;5119.897602048012;5217.530422262014;5416.160495123262;5033.84898453047;5039.899202015866;5092.796288148433;5121.79512819498;5299.205119231991 09:49:09 INFO - PID 29356 | |4;prototype.html;383.12073790650453;389.45476333133615;396.44893597898925;401.9658329042031;411.54318706236074;5250.317458730369;5400.78396864125;5521.3926468088475;5560.6385584937;5580.804671836487;5254.605904557155;5335.573154147669;5409.43200963899;5437.184422336652;5444.448332225316;4264.317709166527;4274.166537525184;4275.893102672442;4285.292926667112;4288.785560721967;3927.7643341399466;4114.958850411487;4276.636485898703;4281.12236991416;4298.893542164333;4067.694922880781;4068.87793366198;4074.6129117733767;4075.4701888754566;4088.713790034699;4081.8775436736796;4083.734557253784;4084.4690190275073;4095.9385609215888;4098.590140985907;3575.3564358415474;3582.176099497104;3592.0840185752727;3622.6377362263825;3625.8912232633065;5019.247112933052;5063.8480845574695;5175.223716442526;5192.935448233103;5245.711485868275;4852.150873597142;4857.6599638025355;4857.73282469464;4858.951410485921;4867.415910090812;5732.283464566929;5736.885262294731;5739.311282646067;5742.167385729088;5771.163181338682;3844.730868839182;3975.284448799215;3991.341428664267;4009.679225661969;4020.517537895442;5886.264216972879;6009.188759517453;6062.727177277033;6066.969665151646;6110.655655755727;4115.5678653741525;4127.09203975125;4129.463169787909;4133.256013917464;4134.73124246929;4176.686748493815;4179.707420480598;4191.344418954496;4201.537830838605;4209.116085621992;4630.513796051433;4805;4829.444613869379;4838.153323168432;4839.491853355417;5732.3121225453215;5738.942610573841;5749;5764.538836893039;5780.971095144498;1450.7606244969672;1466.672661241578;1467.8458761830068;1471.683588028579;1472.955811325662;942.1144124522926;986.0878687214298;986.2159583131428;991.2119864707574;1001.8547310639916;4993.775280112403;5010.69935803853;5012.799488020439;5017.422996355466;5035.194368900959;5849.473547380756;5991.940080599225;5996.800639872043;6004;6022.668753218615;4866.46468888422;4969.801207951714;4975.502449754996;4983.651144419929;4996.6002719783055;3120.829688866675;3136.247300647828;3140.7330376918217;3144.8270345131236;3158.7157155855625;5445.200861082934;5449.618526703172;5452.727363631802;5458.8908221835345;5469.726513674301;5925.881482370414;6018.893387314492;6068.817935461943;6103.389661033861;6117.908231376533;5420.159875219348;5462.863428414242;5476.342838859362;5486.067368547357;5491.533219676292;5786.739596718242;5806.883862322815;5881.441263080001;5963.880722385441;5992.610480318765;5803.8549036274435;5807.506361959281;5836.562257830765;5844.181814546052;5854.268216472941;5278.340207474066;5423;5444.210589464585;5459.645123067146;5465.9726701366235;4112.527059388209;4121.814518346741;4138.420621112987;4150.958490415057;4156.584341565819;5713.600047996601;5963.942439858242;5976.252968378953;5989.580729349078;5996.37038110992;5751.1373294006235;5776.480116789509;5785.508231800344;5788.784355285437;5809.190809190809;5785.681787501728;5792.1311803229855;5797.159411885169;5799.797007104731;5825.563082768725;5562.079908048146;5654.349749778664;5673.687947162945;5687.033204355187;5703.258576385043;5768.423157684198;5771.769129234784;5776.537876969748;5782.710864456844;5787.768489260382;5483.643563168382;5605.299337582802;5618.904313658961;5621.8594535136945;5644 09:49:09 INFO - PID 29356 | |5;yui.html;744.3338212299996;761.5506850957934;767.5624893810523;772.4013889235841;781.5857595474399;13211.867881321185;14122.71754564908;14144.151350918952;14216;14321.498747543837;12081.456334464949;12132.332721700302;12139.696507587314;12208.145429819917;12222.388880555958;921.3596550397476;946.5267366316841;947.8672985781996;952.1383148250844;952.5332587032339;937.5078084005884;944.7496413450441;945.8439357506038;946.0397696338222;950.581744032627;994.5773046455264;996.4170959988379;996.451951426716;997.436448406648;1003.5383723487168;976.4287891583397;979.3780949097339;984;986.9555869985868;988.4267125067515;724.112961622014;724.4494184419826;727.9927200727977;728.9088863892014;732.1031736123259;13773;14037.368318425695;14094.85905140956;14575.489857854924;14706.411743530245;13695.589132326046;14192;14252.857471425257;14322.856771432256;14348.569542913729;11322.433878306052;11998.340091294975;12035.398230088547;12052.517899284017;12068.396580170956;2903.303207230271;2930.9413811723857;2932.222960915338;2934.1344303430537;2953.350262942149;62886.371136288966;64304.67847660778;64552;64744.67627661832;66106;8599.828003439896;10123.341982771097;10176.694699159038;10236.795264094677;10519.789604207874;21261.78738212629;21646.134154633954;21648.675269870964;21651.78348216529;21665.350039498524;6706.798796036127;6790.72837086511;6853.828654283583;6956.200036995709;7110.004599356094;3220.951685724716;3230.99212098357;3242.967570324314;3244.641169741909;3294.0447270291825;3663.9633603663624;3675.3935600625596;3741.1021354874633;3747.3254814133716;3778.0932576182067;778.6573907480804;785.2187073861544;786.6578038553133;786.8308313712465;786.9960650196713;531.9521243088141;538.6983289357972;545.7762317449826;549.5054450994137;559.4657102467135;8201.13888041759;8421.95789021051;8657.653693852302;8758.430702004476;8903.513786230136;536.4126281721509;545.9863503412447;559.8852235291755;566.6430149006183;567.5743192605546;3728.9067773305883;3754.0990162360836;3771.867984620525;3778.3387907116144;3970.8610198643487;64035;64978.67510662511;66102.66948665226;66109.66945165339;67169.66415167892;54148.72925635425;54706.45293547093;57031;57399.42600574024;57960;49167.26249106266;50271.99456010859;50305.74847125814;50930.74534627229;52427;7623.542587444771;7726.575038372944;7733.38132949374;7888.447808653339;7941.920580794349;27269.318267043484;27572.862135689193;27850.303742406602;28892.566611500424;29244.7075529242;33950.830245849604;34461.310773784884;34472;35036;35472;8761.167689069529;8926.464412135292;9213;9221.308401869752;9275.76810579741;10449.738756531147;10621.459888315996;10731.839022414513;10997.835032474359;11327.037201837937;9453.196478299422;9509.524523773922;9738.172255358373;9771.951140244253;9856.408615482807;9497.905020949702;9524.523773811421;9544.236461082957;9634.277429192698;9959.203263738738;8597.312215022657;8857.33569982241;8870.379073464796;8895.73312800617;9015.459072455673;7478.326950574475;7884.526928384086;8161.877571836309;8422.284105850826;8662.82674346522;9872.35829671069;9965.489859212621;9986.950065249628;10046.104586981963;10068.69793906184 09:49:09 INFO - PID 29356 | __end_tp_report 09:49:09 INFO - PID 29356 | __start_cc_report 09:49:09 INFO - PID 29356 | _x_x_mozilla_cycle_collect,387 09:49:09 INFO - PID 29356 | __end_cc_report 09:49:09 INFO - PID 29356 | __startTimestamp1491583749566__endTimestamp 09:49:09 INFO - PID 29356 | 09:49:09 INFO - PID 29356 | ------- Summary: start ------- 09:49:09 INFO - PID 29356 | Number of tests: 6 09:49:09 INFO - PID 29356 | 09:49:09 INFO - PID 29356 | [#0] dojo.html Cycles:165 Average:5278.71 Median:5406.14 stddev:625.78 (11.6%) stddev-sans-first:595.51 09:49:09 INFO - PID 29356 | Values: 2753.2 2760.5 2780.8 2800.1 2803.3 5230.4 5316.5 5322.4 5368.9 5372.7 5304.6 5322.4 5348.2 5383.0 5427.3 4727.1 4776.6 4785.8 4793.8 4804.6 4786.1 4803.9 4836.9 4842.4 4884.3 4704.4 4718.2 4737.9 4755.5 4768.0 4728.1 4736.4 4755.5 4785.0 4795.9 4669.0 4711.8 4724.0 4731.5 4779.6 5145.0 5191.2 5201.3 5226.4 5262.3 5777.3 5785.4 5791.4 5831.4 5848.9 5801.4 5812.1 5819.9 5824.2 5829.2 5311.5 5375.3 5378.0 5406.1 5440.0 5981.8 6010.3 6011.8 6041.1 6080.8 5583.7 5621.8 5639.7 5695.6 5705.7 5709.9 5711.9 5760.2 5760.9 5822.4 5565.8 5638.3 5713.4 5732.7 5742.7 5771.0 5782.9 5783.1 5804.7 5820.9 4911.6 4924.6 4930.2 4938.4 4991.2 4101.9 4118.7 4150.8 4157.8 4169.7 4893.1 4922.8 4925.5 4953.4 4977.3 5760.9 5796.5 5803.2 5813.8 5830.7 4784.7 4851.6 4888.7 4900.5 4929.1 5103.7 5108.6 5141.9 5162.5 5185.5 5298.2 5304.3 5318.1 5321.5 5322.6 5677.3 5736.7 5811.2 5832.1 5883.7 5290.0 5308.9 5355.6 5355.8 5379.1 5722.4 5736.7 5758.9 5779.1 5789.9 5716.3 5790.4 5808.3 5837.9 5872.3 5634.9 5639.5 5655.6 5693.8 5729.5 5554.6 5583.6 5586.3 5593.8 5667.7 5455.3 5496.5 5516.6 5536.2 5600.9 5666.2 5668.6 5698.6 5724.9 5739.1 5433.2 5459.9 5502.1 5506.5 5519.0 09:49:09 INFO - PID 29356 | 09:49:09 INFO - PID 29356 | [#1] ext.html Cycles:180 Average:30409.15 Median:2994.39 stddev:44694.24 (1492.6%) stddev-sans-first:44764.03 09:49:09 INFO - PID 29356 | Values: 721.2 1067.2 1086.2 1205.4 1212.5 32764.7 33533.7 33575.5 33649.3 33736.3 31222.2 31310.8 31313.8 31380.1 31385.7 6631.5 6752.5 7096.2 7288.3 7292.9 6973.1 7010.3 7027.5 7032.7 7044.5 7027.7 7088.0 7090.8 7090.9 7091.9 6998.3 7027.8 7031.3 7038.0 7043.1 7076.6 7185.2 7187.9 7189.2 7199.2 32293.0 32335.8 32513.8 32565.2 32611.7 2953.6 2991.6 2994.0 2994.8 3000.4 24515.6 24561.8 24573.0 24600.4 24667.1 3051.5 3074.6 3082.8 3093.8 3142.4 137772.0 137857.3 138089.0 138436.3 138473.0 33983.3 34090.5 40396.2 40573.8 41126.2 40857.6 41004.8 41014.4 41263.2 41517.6 12380.9 12593.6 12598.4 12610.6 12611.7 9842.8 9877.6 9882.1 9895.9 9933.3 12679.7 12807.2 12877.7 12882.9 13091.2 5283.3 5351.4 5374.3 5475.6 5543.9 839.4 875.3 889.5 892.6 923.6 20184.8 20236.0 20382.5 20513.3 20788.3 968.5 973.2 973.3 983.7 984.3 9968.4 10338.8 10599.5 10674.9 10716.9 195261.0 195358.0 195535.0 195542.0 197061.0 39185.4 39434.8 39605.4 39807.0 39823.4 1214.0 1248.4 1250.2 1258.4 1265.9 18645.8 19009.3 19959.3 20074.3 20270.5 28675.3 28892.6 29044.4 29048.9 29079.3 177493.0 178453.0 178572.0 179331.0 179535.0 22727.8 23074.5 26428.2 26838.9 26943.5 31550.7 31729.0 31796.4 31897.0 32521.5 24683.0 24781.3 24917.6 25795.4 26289.9 24449.1 24510.5 24689.3 25071.4 25361.1 27773.4 27809.4 27846.0 27849.2 27922.0 22452.9 22556.5 22851.0 22922.7 23029.8 17244.7 18229.0 18285.7 18292.5 18540.3 09:49:09 INFO - PID 29356 | 09:49:09 INFO - PID 29356 | [#2] jquery.html Cycles:180 Average:28027.14 Median:470357.00 stddev:76393.37 (16.2%) stddev-sans-first:76579.57 09:49:09 INFO - PID 29356 | Values: 429.8 430.1 431.5 433.6 452.3 17315.7 18620.7 19246.6 19256.5 19312.4 18547.4 18637.2 19003.2 19185.7 19208.9 5577.4 5829.4 5880.7 5881.0 5883.5 5692.1 5812.4 5824.1 5828.9 5861.4 5625.9 5832.0 5849.1 5850.9 5858.9 5580.5 5639.8 5767.8 5815.1 5841.6 5090.8 5109.8 5123.5 5126.3 5151.8 21560.3 21967.0 22869.9 22950.4 22993.9 1601.1 1664.6 1665.1 1674.5 1676.6 14603.6 14668.9 14751.0 15130.2 15234.5 2072.9 2083.5 2135.5 2138.9 2139.8 80213.6 85238.6 87142.0 96004.5 97130.0 10857.5 11388.0 11446.9 11481.0 11534.7 15814.4 15884.5 15907.9 15929.1 15954.2 7578.5 7660.5 7863.8 8060.2 8091.1 6705.0 7004.3 7148.1 7378.3 7431.7 7000.2 7052.1 7064.7 7134.7 7253.1 1945.9 1956.2 1977.5 1981.3 2153.6 825.8 828.8 842.9 875.0 880.4 16129.9 16433.1 16778.2 16901.2 17065.1 864.6 866.7 868.5 888.4 893.5 8871.8 9247.2 9307.5 9337.0 9507.0 445776.0 448587.0 469646.0 470310.0 470404.0 90271.5 90647.0 91490.5 92616.5 92640.0 1068.7 1079.0 1110.6 1111.5 1115.8 14195.1 14201.8 14289.1 14367.7 14812.0 42714.0 42729.8 42892.6 43453.1 44235.6 54255.2 54256.2 54624.2 54951.0 55020.7 7707.7 7750.9 7790.5 8016.2 8118.3 11409.0 11550.5 11559.5 11809.2 11928.2 9957.9 9970.5 10066.6 10547.3 10565.8 9477.8 9510.5 9574.7 9607.5 9655.8 10155.2 10165.8 10231.3 10579.5 10682.4 7731.1 7768.2 7966.8 7995.2 8014.6 9895.0 10010.8 10024.5 10070.1 10139.7 09:49:09 INFO - PID 29356 | 09:49:09 INFO - PID 29356 | [#3] mootools.html Cycles:180 Average:6406.77 Median:3514.98 stddev:4117.09 (117.1%) stddev-sans-first:4110.85 09:49:09 INFO - PID 29356 | Values: 1313.1 1384.7 1392.4 1399.4 1401.1 10100.6 10574.1 10590.8 10671.9 10919.9 10688.9 10871.7 10885.3 10910.0 10911.1 2255.0 2279.8 2293.0 2298.5 2304.8 2157.5 2234.5 2259.2 2259.5 2270.2 2176.9 2203.9 2264.2 2286.8 2298.5 2010.5 2083.0 2102.8 2103.3 2105.8 1984.1 1999.8 2020.0 2138.2 2220.8 10261.9 10356.1 10372.3 10379.0 10392.6 5809.9 6052.3 6053.8 6084.3 6091.1 3280.8 3412.5 3434.4 3436.7 3443.2 1087.4 1091.4 1115.3 1124.1 1151.8 14950.4 14987.7 14993.4 15141.9 15153.0 4846.2 4901.8 5152.7 5205.6 5294.4 11093.6 11151.9 11169.0 11195.2 11199.3 5840.8 5882.7 5889.0 5898.8 5899.1 5316.7 5336.8 5357.6 5437.6 5493.1 4080.9 4081.2 4092.4 4105.6 4196.4 1176.2 1194.7 1195.9 1202.8 1216.4 653.4 685.1 688.1 691.0 697.1 5706.4 5764.3 5774.2 5798.4 6038.2 791.9 796.5 820.0 820.3 855.7 3259.2 3586.8 3645.3 3718.3 3785.7 12666.7 13305.9 13325.5 13348.6 13364.3 12864.2 13052.7 13123.1 13141.0 13186.2 9412.0 9738.8 9767.9 9812.5 9951.4 5393.5 5457.7 5502.8 5547.9 5593.5 12140.3 12168.0 12184.3 12190.3 12312.3 12548.2 12620.3 12660.4 12821.2 12838.6 7311.6 7507.9 7534.8 7557.2 7560.9 9551.9 9700.5 9791.0 9815.5 9862.0 7651.1 7744.0 7761.3 7831.9 7992.0 7940.0 8068.7 8069.6 8177.4 8299.7 7286.0 7415.2 7468.8 7474.0 7486.7 4923.4 5091.6 5119.9 5217.5 5416.2 5033.8 5039.9 5092.8 5121.8 5299.2 09:49:09 INFO - PID 29356 | 09:49:09 INFO - PID 29356 | [#4] prototype.html Cycles:180 Average:4732.31 Median:5405.11 stddev:1389.46 (25.7%) stddev-sans-first:1354.47 09:49:09 INFO - PID 29356 | Values: 383.1 389.5 396.4 402.0 411.5 5250.3 5400.8 5521.4 5560.6 5580.8 5254.6 5335.6 5409.4 5437.2 5444.4 4264.3 4274.2 4275.9 4285.3 4288.8 3927.8 4115.0 4276.6 4281.1 4298.9 4067.7 4068.9 4074.6 4075.5 4088.7 4081.9 4083.7 4084.5 4095.9 4098.6 3575.4 3582.2 3592.1 3622.6 3625.9 5019.2 5063.8 5175.2 5192.9 5245.7 4852.2 4857.7 4857.7 4859.0 4867.4 5732.3 5736.9 5739.3 5742.2 5771.2 3844.7 3975.3 3991.3 4009.7 4020.5 5886.3 6009.2 6062.7 6067.0 6110.7 4115.6 4127.1 4129.5 4133.3 4134.7 4176.7 4179.7 4191.3 4201.5 4209.1 4630.5 4805.0 4829.4 4838.2 4839.5 5732.3 5738.9 5749.0 5764.5 5781.0 1450.8 1466.7 1467.8 1471.7 1473.0 942.1 986.1 986.2 991.2 1001.9 4993.8 5010.7 5012.8 5017.4 5035.2 5849.5 5991.9 5996.8 6004.0 6022.7 4866.5 4969.8 4975.5 4983.7 4996.6 3120.8 3136.2 3140.7 3144.8 3158.7 5445.2 5449.6 5452.7 5458.9 5469.7 5925.9 6018.9 6068.8 6103.4 6117.9 5420.2 5462.9 5476.3 5486.1 5491.5 5786.7 5806.9 5881.4 5963.9 5992.6 5803.9 5807.5 5836.6 5844.2 5854.3 5278.3 5423.0 5444.2 5459.6 5466.0 4112.5 4121.8 4138.4 4151.0 4156.6 5713.6 5963.9 5976.3 5989.6 5996.4 5751.1 5776.5 5785.5 5788.8 5809.2 5785.7 5792.1 5797.2 5799.8 5825.6 5562.1 5654.3 5673.7 5687.0 5703.3 5768.4 5771.8 5776.5 5782.7 5787.8 5483.6 5605.3 5618.9 5621.9 5644.0 09:49:09 INFO - PID 29356 | 09:49:09 INFO - PID 29356 | [#5] yui.html Cycles:180 Average:14117.66 Median:57679.71 stddev:17805.12 (30.9%) stddev-sans-first:17826.75 09:49:09 INFO - PID 29356 | Values: 744.3 761.6 767.6 772.4 781.6 13211.9 14122.7 14144.2 14216.0 14321.5 12081.5 12132.3 12139.7 12208.1 12222.4 921.4 946.5 947.9 952.1 952.5 937.5 944.7 945.8 946.0 950.6 994.6 996.4 996.5 997.4 1003.5 976.4 979.4 984.0 987.0 988.4 724.1 724.4 728.0 728.9 732.1 13773.0 14037.4 14094.9 14575.5 14706.4 13695.6 14192.0 14252.9 14322.9 14348.6 11322.4 11998.3 12035.4 12052.5 12068.4 2903.3 2930.9 2932.2 2934.1 2953.4 62886.4 64304.7 64552.0 64744.7 66106.0 8599.8 10123.3 10176.7 10236.8 10519.8 21261.8 21646.1 21648.7 21651.8 21665.4 6706.8 6790.7 6853.8 6956.2 7110.0 3221.0 3231.0 3243.0 3244.6 3294.0 3664.0 3675.4 3741.1 3747.3 3778.1 778.7 785.2 786.7 786.8 787.0 532.0 538.7 545.8 549.5 559.5 8201.1 8422.0 8657.7 8758.4 8903.5 536.4 546.0 559.9 566.6 567.6 3728.9 3754.1 3771.9 3778.3 3970.9 64035.0 64978.7 66102.7 66109.7 67169.7 54148.7 54706.5 57031.0 57399.4 57960.0 49167.3 50272.0 50305.7 50930.7 52427.0 7623.5 7726.6 7733.4 7888.4 7941.9 27269.3 27572.9 27850.3 28892.6 29244.7 33950.8 34461.3 34472.0 35036.0 35472.0 8761.2 8926.5 9213.0 9221.3 9275.8 10449.7 10621.5 10731.8 10997.8 11327.0 9453.2 9509.5 9738.2 9772.0 9856.4 9497.9 9524.5 9544.2 9634.3 9959.2 8597.3 8857.3 8870.4 8895.7 9015.5 7478.3 7884.5 8161.9 8422.3 8662.8 9872.4 9965.5 9987.0 10046.1 10068.7 09:49:09 INFO - PID 29356 | -------- Summary: end -------- 09:49:09 INFO - PID 29356 | 09:49:10 INFO - TEST-INFO | 29356: exit 0 09:49:10 INFO - TEST-OK | dromaeo_css | took 1121825ms 09:49:10 INFO - TEST-START | kraken 09:49:10 INFO - operating with platform_type : linux_ 09:49:10 INFO - Initialising browser for kraken test... 09:49:10 INFO - TEST-INFO | started process 29742 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYnqoiE/profile http://localhost:49489/getInfo.html) 09:49:15 INFO - PID 29742 | __metrics Screen width/height:1600/1200 09:49:15 INFO - PID 29742 | colorDepth:24 09:49:15 INFO - PID 29742 | Browser inner width/height: 1024/697 09:49:15 INFO - PID 29742 | __metrics 09:49:16 ERROR - PID 29742 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 09:49:17 INFO - TEST-INFO | 29742: exit 0 09:49:17 INFO - Browser initialized. 09:49:17 INFO - Running cycle 1/1 for kraken test... 09:49:17 INFO - TEST-INFO | started process 29888 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYnqoiE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:49:30 INFO - PID 29888 | RSS: Main: 177201152 09:49:30 INFO - PID 29888 | 09:49:32 INFO - PID 29888 | Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49489/tests/kraken/driver.html?testName=audio-beat-detection) 09:49:33 INFO - PID 29888 | RSS: Main: 186204160 09:49:33 INFO - PID 29888 | 09:49:36 INFO - PID 29888 | Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49489/tests/kraken/driver.html?testName=audio-dft) 09:49:37 INFO - PID 29888 | RSS: Main: 186212352 09:49:37 INFO - PID 29888 | 09:49:40 INFO - PID 29888 | Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49489/tests/kraken/driver.html?testName=audio-fft) 09:49:40 INFO - PID 29888 | RSS: Main: 181583872 09:49:40 INFO - PID 29888 | 09:49:42 INFO - PID 29888 | Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49489/tests/kraken/driver.html?testName=audio-oscillator) 09:49:43 INFO - PID 29888 | RSS: Main: 182730752 09:49:43 INFO - PID 29888 | 09:49:45 INFO - PID 29888 | Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49489/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:49:46 INFO - PID 29888 | RSS: Main: 183611392 09:49:46 INFO - PID 29888 | 09:49:49 INFO - PID 29888 | Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49489/tests/kraken/driver.html?testName=imaging-darkroom) 09:49:50 INFO - PID 29888 | RSS: Main: 186380288 09:49:50 INFO - PID 29888 | 09:49:53 INFO - PID 29888 | Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49489/tests/kraken/driver.html?testName=imaging-desaturate) 09:49:54 INFO - PID 29888 | RSS: Main: 184999936 09:49:54 INFO - PID 29888 | 09:49:57 INFO - PID 29888 | Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49489/tests/kraken/driver.html?testName=json-parse-financial) 09:49:58 INFO - PID 29888 | RSS: Main: 186400768 09:49:58 INFO - PID 29888 | 09:49:59 INFO - PID 29888 | Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49489/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:50:00 INFO - PID 29888 | RSS: Main: 186396672 09:50:00 INFO - PID 29888 | 09:50:02 INFO - PID 29888 | Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49489/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:50:02 INFO - PID 29888 | RSS: Main: 187191296 09:50:02 INFO - PID 29888 | 09:50:04 INFO - PID 29888 | Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49489/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:50:05 INFO - PID 29888 | RSS: Main: 188272640 09:50:05 INFO - PID 29888 | 09:50:08 INFO - PID 29888 | Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49489/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:50:09 INFO - PID 29888 | RSS: Main: 187924480 09:50:09 INFO - PID 29888 | 09:50:12 INFO - PID 29888 | Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49489/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:50:12 INFO - PID 29888 | RSS: Main: 187428864 09:50:12 INFO - PID 29888 | 09:50:14 INFO - PID 29888 | Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49489/tests/kraken/driver.html?testName=ai-astar) 09:50:14 INFO - PID 29888 | RSS: Main: 190255104 09:50:14 INFO - PID 29888 | 09:50:14 INFO - PID 29888 | __start_tp_report 09:50:14 INFO - PID 29888 | _x_x_mozilla_page_load 09:50:14 INFO - PID 29888 | _x_x_mozilla_page_load_details 09:50:14 INFO - PID 29888 | |i|pagename|runs| 09:50:14 INFO - PID 29888 | |0;ai-astar;103;112;110;112;115;117;112;112;110;116 09:50:14 INFO - PID 29888 | |1;audio-beat-detection;158;125;123;169;124;123;129;123;147;125 09:50:14 INFO - PID 29888 | |2;audio-dft;168;166;168;173;174;169;164;166;167;164 09:50:14 INFO - PID 29888 | |3;audio-fft;77;75;77;110;76;77;76;77;93;75 09:50:14 INFO - PID 29888 | |4;audio-oscillator;84;83;122;90;84;84;99;84;83;104 09:50:14 INFO - PID 29888 | |5;imaging-gaussian-blur;114;115;115;124;115;119;114;115;115;115 09:50:14 INFO - PID 29888 | |6;imaging-darkroom;153;151;153;152;151;150;152;154;153;151 09:50:14 INFO - PID 29888 | |7;imaging-desaturate;100;96;96;95;95;95;96;103;95;95 09:50:14 INFO - PID 29888 | |8;json-parse-financial;53;53;52;55;56;55;55;56;54;55 09:50:14 INFO - PID 29888 | |9;json-stringify-tinderbox;55;56;56;55;55;55;55;56;55;56 09:50:14 INFO - PID 29888 | |10;stanford-crypto-aes;83;81;92;84;84;82;82;82;82;82 09:50:14 INFO - PID 29888 | |11;stanford-crypto-ccm;132;136;137;134;131;138;145;143;190;140 09:50:14 INFO - PID 29888 | |12;stanford-crypto-pbkdf2;192;195;194;193;193;190;192;192;184;192 09:50:14 INFO - PID 29888 | |13;stanford-crypto-sha256-iterative;71;72;72;76;73;71;72;72;73;71 09:50:14 INFO - PID 29888 | __end_tp_report 09:50:14 INFO - PID 29888 | __start_cc_report 09:50:14 INFO - PID 29888 | _x_x_mozilla_cycle_collect,855 09:50:14 INFO - PID 29888 | __end_cc_report 09:50:14 INFO - PID 29888 | __startTimestamp1491583814946__endTimestamp 09:50:14 INFO - PID 29888 | 09:50:14 INFO - PID 29888 | ------- Summary: start ------- 09:50:14 INFO - PID 29888 | Number of tests: 14 09:50:14 INFO - PID 29888 | 09:50:14 INFO - PID 29888 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:3.93 (3.5%) stddev-sans-first:2.52 09:50:14 INFO - PID 29888 | Values: 103.0 112.0 110.0 112.0 115.0 117.0 112.0 112.0 110.0 116.0 09:50:14 INFO - PID 29888 | 09:50:14 INFO - PID 29888 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:127.00 stddev:17.05 (13.4%) stddev-sans-first:15.84 09:50:14 INFO - PID 29888 | Values: 158.0 125.0 123.0 169.0 124.0 123.0 129.0 123.0 147.0 125.0 09:50:14 INFO - PID 29888 | 09:50:14 INFO - PID 29888 | [#2] audio-dft Cycles:10 Average:167.90 Median:168.00 stddev:3.38 (2.0%) stddev-sans-first:3.59 09:50:14 INFO - PID 29888 | Values: 168.0 166.0 168.0 173.0 174.0 169.0 164.0 166.0 167.0 164.0 09:50:14 INFO - PID 29888 | 09:50:14 INFO - PID 29888 | [#3] audio-fft Cycles:10 Average:81.30 Median:77.00 stddev:11.40 (14.8%) stddev-sans-first:11.99 09:50:14 INFO - PID 29888 | Values: 77.0 75.0 77.0 110.0 76.0 77.0 76.0 77.0 93.0 75.0 09:50:14 INFO - PID 29888 | 09:50:14 INFO - PID 29888 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:84.00 stddev:12.97 (15.4%) stddev-sans-first:13.45 09:50:14 INFO - PID 29888 | Values: 84.0 83.0 122.0 90.0 84.0 84.0 99.0 84.0 83.0 104.0 09:50:14 INFO - PID 29888 | 09:50:14 INFO - PID 29888 | [#5] imaging-gaussian-blur Cycles:10 Average:116.10 Median:115.00 stddev:3.11 (2.7%) stddev-sans-first:3.20 09:50:14 INFO - PID 29888 | Values: 114.0 115.0 115.0 124.0 115.0 119.0 114.0 115.0 115.0 115.0 09:50:14 INFO - PID 29888 | 09:50:14 INFO - PID 29888 | [#6] imaging-darkroom Cycles:10 Average:152.00 Median:152.50 stddev:1.25 (0.8%) stddev-sans-first:1.27 09:50:14 INFO - PID 29888 | Values: 153.0 151.0 153.0 152.0 151.0 150.0 152.0 154.0 153.0 151.0 09:50:14 INFO - PID 29888 | 09:50:14 INFO - PID 29888 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:95.00 stddev:2.72 (2.9%) stddev-sans-first:2.59 09:50:14 INFO - PID 29888 | Values: 100.0 96.0 96.0 95.0 95.0 95.0 96.0 103.0 95.0 95.0 09:50:14 INFO - PID 29888 | 09:50:14 INFO - PID 29888 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.00 stddev:1.35 (2.5%) stddev-sans-first:1.33 09:50:14 INFO - PID 29888 | Values: 53.0 53.0 52.0 55.0 56.0 55.0 55.0 56.0 54.0 55.0 09:50:14 INFO - PID 29888 | 09:50:14 INFO - PID 29888 | [#9] json-stringify-tinderbox Cycles:10 Average:55.40 Median:55.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 09:50:14 INFO - PID 29888 | Values: 55.0 56.0 56.0 55.0 55.0 55.0 55.0 56.0 55.0 56.0 09:50:14 INFO - PID 29888 | 09:50:14 INFO - PID 29888 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:82.50 stddev:3.17 (3.8%) stddev-sans-first:3.36 09:50:14 INFO - PID 29888 | Values: 83.0 81.0 92.0 84.0 84.0 82.0 82.0 82.0 82.0 82.0 09:50:14 INFO - PID 29888 | 09:50:14 INFO - PID 29888 | [#11] stanford-crypto-ccm Cycles:10 Average:142.60 Median:139.00 stddev:17.24 (12.4%) stddev-sans-first:17.86 09:50:14 INFO - PID 29888 | Values: 132.0 136.0 137.0 134.0 131.0 138.0 145.0 143.0 190.0 140.0 09:50:14 INFO - PID 29888 | 09:50:14 INFO - PID 29888 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.70 Median:192.50 stddev:3.02 (1.6%) stddev-sans-first:3.20 09:50:14 INFO - PID 29888 | Values: 192.0 195.0 194.0 193.0 193.0 190.0 192.0 192.0 184.0 192.0 09:50:14 INFO - PID 29888 | 09:50:14 INFO - PID 29888 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:72.00 stddev:1.49 (2.1%) stddev-sans-first:1.51 09:50:14 INFO - PID 29888 | Values: 71.0 72.0 72.0 76.0 73.0 71.0 72.0 72.0 73.0 71.0 09:50:14 INFO - PID 29888 | -------- Summary: end -------- 09:50:14 INFO - PID 29888 | 09:50:16 INFO - TEST-INFO | 29888: exit 0 09:50:16 INFO - TEST-OK | kraken | took 65804ms 09:50:16 INFO - SUITE-END | took 1187s 09:50:16 INFO - Completed test suite (00:19:47) 09:50:16 INFO - javascript benchmark 09:50:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6646.20733270933, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2753.1740477856642, 2760.5307097793375, 2780.7775377969765, 2800.1319590926814, 2803.285162283618, 5230.398504172022, 5316.5215130638235, 5322.4411436799155, 5368.865778355543, 5372.7045012524295, 5304.6286759926825, 5322.361316641999, 5348.171033489805, 5382.9730851345785, 5427.348718153818, 4727.101850648374, 4776.593989510896, 4785.832495862645, 4793.784279707422, 4804.591609713161, 4786.066716990188, 4803.879903002436, 4836.903261934759, 4842.394700662418, 4884.3406140171155, 4704.388429504143, 4718.197906355927, 4737.905241895142, 4755.50067242938, 4768.0, 4728.148933192024, 4736.360591320196, 4755.476897541268, 4784.952150478521, 4795.880102997418, 4668.996165824364, 4711.8350857719815, 4723.952760472385, 4731.4795372509, 4779.617630589544, 5145.0, 5191.195364718475, 5201.349831271091, 5226.372835259755, 5262.2632831403635, 5777.277840269966, 5785.363610002896, 5791.391903850077, 5831.416858314177, 5848.912266315966, 5801.390853960315, 5812.128180772918, 5819.854503637401, 5824.213731146326, 5829.242198514208, 5311.49540793624, 5375.274337964403, 5378.0, 5406.135018397038, 5440.0, 5981.820545383645, 6010.338862725097, 6011.819645410645, 6041.124037014608, 6080.847978800565, 5583.664980101207, 5621.831345059655, 5639.718014099279, 5695.601307908407, 5705.74324155414, 5709.885802283931, 5711.885762284731, 5760.193572899798, 5760.855978600484, 5822.388649191774, 5565.805196818092, 5638.2670252866865, 5713.428657134254, 5732.656040637575, 5742.712864356766, 5770.990076736554, 5782.855428614318, 5783.074708046693, 5804.6807425592, 5820.941790582125, 4911.607071434348, 4924.581410580141, 4930.161872481687, 4938.358013458227, 4991.201407774739, 4101.89745256365, 4118.711690181718, 4150.771707556113, 4157.8336866525, 4169.728967617095, 4893.119238537026, 4922.778474968635, 4925.532074452921, 4953.356063711694, 4977.303177555145, 5760.855978600569, 5796.492911842867, 5803.187553742479, 5813.8081693253625, 5830.679312637845, 4784.736839473792, 4851.611871050308, 4888.731119788375, 4900.509949005071, 4929.06347793918, 5103.7192954387865, 5108.6168537359845, 5141.871453213625, 5162.5095615916425, 5185.533302002837, 5298.231756395378, 5304.283921670525, 5318.149096144598, 5321.494458026481, 5322.574194064388, 5677.290338707661, 5736.741846616829, 5811.244538210175, 5832.066869300891, 5883.735231914659, 5290.0, 5308.938212357467, 5355.6343132502525, 5355.812546560852, 5379.112446446293, 5722.370539240764, 5736.713164341682, 5758.913616295843, 5779.075347944308, 5789.942100579109, 5716.28546431696, 5790.420957904176, 5808.332041815245, 5837.854053648693, 5872.265966754156, 5634.915476267777, 5639.464250896158, 5655.632383895034, 5693.772249109989, 5729.512991395778, 5554.611177217556, 5583.609147359646, 5586.273784408001, 5593.804216852391, 5667.744951477276, 5455.290812194389, 5496.532794712494, 5516.613837031369, 5536.2249285100925, 5600.915986260128, 5666.2350582670815, 5668.631538949955, 5698.629589076697, 5724.8568785779025, 5739.053056245672, 5433.239346491573, 5459.945400545944, 5502.119660854244, 5506.531944784738, 5519.0], "value": 5232.8899752225725, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.1814590439851, 1067.231593252858, 1086.2179230953711, 1205.4033253539494, 1212.5271144253747, 32764.672353276488, 33533.66466335336, 33575.49636755451, 33649.32701345978, 33736.32527349451, 31222.2194445139, 31310.84344578274, 31313.843430782872, 31380.05859824209, 31385.686143138562, 6631.535792494527, 6752.459803215731, 7096.219415864251, 7288.344049035586, 7292.927070729278, 6973.058637083979, 7010.334018268256, 7027.5080744347915, 7032.683529241171, 7044.5421047632, 7027.718891244344, 7088.0, 7090.822729431779, 7090.929090709078, 7091.89362159568, 6998.265182155902, 7027.754028609025, 7031.261717519664, 7038.049863268445, 7043.11961004877, 7076.646167691595, 7185.209626941032, 7187.89218161728, 7189.245129261404, 7199.172095209065, 32293.0, 32335.83832080848, 32513.83743081293, 32565.185870353194, 32611.673883261337, 2953.586497890297, 2991.6110905582136, 2993.9550906736417, 2994.82031078136, 3000.354923691395, 24515.632265516033, 24561.754382456125, 24573.0, 24600.384990375205, 24667.136650217337, 3051.5422686596967, 3074.6156730408698, 3082.8150310981187, 3093.752499800011, 3142.3715256948703, 137772.0, 137857.3107134468, 138089.0, 138436.30781846025, 138473.0, 33983.320333593685, 34090.48864267038, 40396.1920761589, 40573.79713101416, 41126.177476450306, 40857.59142408538, 41004.79497602553, 41014.38478422826, 41263.174736505105, 41517.58482415198, 12380.876191238152, 12593.559225427067, 12598.433070511848, 12610.558630447891, 12611.74776504483, 9842.75393115178, 9877.60489580423, 9882.061204185591, 9895.851562226573, 9933.25500587459, 12679.683007924876, 12807.231566106064, 12877.678058048436, 12882.871171288354, 13091.214527128403, 5283.339582552181, 5351.411344752074, 5374.328208973879, 5475.589330800206, 5543.861403464865, 839.4249938791947, 875.3085062800444, 889.4929889962789, 892.5760263874607, 923.5936188077225, 20184.798152018586, 20236.0, 20382.490437738878, 20513.282035128697, 20788.27241046556, 968.5496244246318, 973.2408721197477, 973.2992245583168, 983.6999715086824, 984.2568860510269, 9968.420842244084, 10338.793224135476, 10599.470026498644, 10674.946625266824, 10716.89283107159, 195261.0, 195358.0, 195535.0, 195542.0, 197061.0, 39185.41221881674, 39434.80282598626, 39605.40591891124, 39807.0, 39823.40264896029, 1213.9575114870938, 1248.3945286536023, 1250.1623911978995, 1258.3645259144073, 1265.949362025527, 18645.81354186495, 19009.33467328637, 19959.301424450074, 20074.297399590945, 20270.493237669176, 28675.28311792222, 28892.566611501265, 29044.419111618074, 29048.854755726086, 29079.27301817387, 177493.0, 178453.0, 178572.0, 179331.0, 179535.0, 22727.772722272566, 23074.538509230057, 26428.207153785417, 26838.86580567085, 26943.461130777665, 31550.68449315569, 31729.0, 31796.36407271888, 31897.0, 32521.512177317833, 24683.0, 24781.25656230316, 24917.626235606116, 25795.355116122246, 26289.868550657124, 24449.144279950116, 24510.509789804462, 24689.25932222036, 25071.373215669755, 25361.112361067273, 27773.444531109668, 27809.44381112326, 27846.0, 27849.16452506428, 27922.0, 22452.887735561217, 22556.548869022856, 22851.0, 22922.656160157945, 23029.76970230276, 17244.655106898044, 18229.0, 18285.725714114033, 18292.542686432946, 18540.258389664803], "value": 14169.250092527735, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.7931862291941, 430.1225499980041, 431.50161563394283, 433.61408346571545, 452.27635782747586, 17315.65368692627, 18620.720689189657, 19246.615067698636, 19256.49665543481, 19312.4206273812, 18547.35084272051, 18637.16132774025, 19003.239870405167, 19185.712214316798, 19208.903955480237, 5577.44225577442, 5829.417058294158, 5880.7353669085, 5881.029630111048, 5883.529317654577, 5692.089265717486, 5812.389699081599, 5824.068149096145, 5828.883422331551, 5861.384554621767, 5625.943740562583, 5832.0, 5849.122631605272, 5850.941490585104, 5858.941410585903, 5580.525655319262, 5639.843832014427, 5767.798127065554, 5815.098659707752, 5841.561882858781, 5090.821821236276, 5109.795608175706, 5123.513266239738, 5126.282320475099, 5151.793928242866, 21560.25674351656, 21967.0, 22869.885650571807, 22950.42623934415, 22993.885030574907, 1601.1353868910774, 1664.592174917153, 1665.1424516374077, 1674.4558018643988, 1676.6311411489453, 14603.561893143222, 14668.926655366655, 14751.0, 15130.243487825675, 15234.542963711106, 2072.8652637578507, 2083.479130217446, 2135.4981579328846, 2138.9144434222612, 2139.7539282982502, 80213.59893200497, 85238.5738071312, 87142.0, 96004.51997740037, 97130.0286997128, 10857.51141198648, 11388.0, 11446.885531144748, 11480.966712995703, 11534.653960381202, 15814.36742530309, 15884.52346429609, 15907.920460397856, 15929.123898185479, 15954.20228988546, 7578.469507134558, 7660.5403675779635, 7863.84272314562, 8060.234277743605, 8091.0695270043525, 6705.0, 7004.299570042955, 7148.106486689164, 7378.29906158914, 7431.665575049135, 7000.229974702778, 7052.0832291801735, 7064.717411303491, 7134.678939447737, 7253.129624444995, 1945.9221631134596, 1956.1588516937568, 1977.4561995451365, 1981.2570286142698, 2153.569286142778, 825.7894236969654, 828.7596596986806, 842.9367797415218, 874.9562521874008, 880.401327097567, 16129.919350403174, 16433.09617971023, 16778.244978975974, 16901.154942252837, 17065.14674266282, 864.6411739128317, 866.7356456280895, 868.5396739727954, 888.4047688049022, 893.4996402014892, 8871.778205544913, 9247.213986811063, 9307.53462326881, 9336.953315233517, 9506.95246523763, 445776.0, 448587.0, 469646.0, 470310.0, 470404.0, 90271.54864225637, 90647.0, 91490.54254728684, 92616.53691731498, 92640.0, 1068.6793961811582, 1078.962236321725, 1110.6279396402135, 1111.5442668505873, 1115.7991561519004, 14195.148291102567, 14201.786973195203, 14289.142651440947, 14367.712645747235, 14812.0, 42714.0, 42729.78635106929, 42892.571074288855, 43453.130937381706, 44235.55764442314, 54255.18617220824, 54256.18615720846, 54624.18063729127, 54951.0, 55020.724896375265, 7707.691692332244, 7750.8837367440665, 7790.5325680459355, 8016.238457346776, 8118.309943654619, 11409.0, 11550.480228389575, 11559.479823407799, 11809.23239989398, 11928.224665396721, 9957.850632240667, 9970.451625160686, 10066.597336106473, 10547.261691681508, 10565.788684226118, 9477.810443791224, 9510.524473776146, 9574.712758617252, 9607.51962401863, 9655.806883862424, 10155.187584993331, 10165.79668406613, 10231.334963227366, 10579.4710264488, 10682.412467314372, 7731.110922244014, 7768.184340644377, 7966.760997170094, 7995.240452157036, 8014.599270036591, 9895.0, 10010.799784004133, 10024.498775061073, 10070.093691567794, 10139.7465063374], "value": 8940.68959488234, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1313.120209459662, 1384.6815232496526, 1392.4360633943256, 1399.3912647998116, 1401.0962928910853, 10100.646477373293, 10574.101201397882, 10590.788184236311, 10671.893281067187, 10919.890801091986, 10688.893111068886, 10871.67384978452, 10885.346879187255, 10910.0, 10911.07255883249, 2254.9887250563766, 2279.840411171219, 2293.0483849202647, 2298.494331247123, 2304.76952304769, 2157.5361297321074, 2234.519578290667, 2259.1641092795608, 2259.48031952651, 2270.182734215681, 2176.880271585062, 2203.9449013774624, 2264.230161745006, 2286.8170546356337, 2298.5173113646156, 2010.5375763574314, 2083.0, 2102.810747032767, 2103.253345062496, 2105.8210052145587, 1984.117067904783, 1999.7900220476786, 2019.9596008079757, 2138.1874887542635, 2220.755716871143, 10261.897381026243, 10356.119729822974, 10372.325798823127, 10379.0, 10392.63625773102, 5809.912851307234, 6052.303985041733, 6053.848653783691, 6084.300305464884, 6091.0863370494335, 3280.7652791493283, 3412.5051867479324, 3434.3818112739696, 3436.7250619950346, 3443.1736383268085, 1087.4399684162663, 1091.3779145886767, 1115.2694984784978, 1124.0557931337635, 1151.8099513580248, 14950.40198392063, 14987.700245995127, 14993.400263989428, 15141.924290378587, 15153.0, 4846.248831431134, 4901.779419926112, 5152.742362881841, 5205.609579281569, 5294.444083371268, 11093.611723589636, 11151.888481115086, 11169.0, 11195.160362972809, 11199.272047316897, 5840.766369345179, 5882.705864706748, 5889.0283103287475, 5898.8230353089475, 5899.056151015902, 5316.707581083, 5336.839894803162, 5357.571394288448, 5437.646552974124, 5493.121100623881, 4080.8775736727944, 4081.2263587497273, 4092.3656833190903, 4105.609967053185, 4196.370544418301, 1176.2001838749732, 1194.6834088966432, 1195.9043276537857, 1202.7594481103815, 1216.367488905764, 653.3597074866562, 685.0717278088118, 688.1432616392523, 691.029104108728, 697.0972590495321, 5706.400827913092, 5764.308283006066, 5774.191613174159, 5798.420157984167, 6038.154658347835, 791.8733002719537, 796.450449190057, 819.983600328002, 820.2658620534588, 855.7176131876466, 3259.1689119274433, 3586.7847929124337, 3645.2527231917393, 3718.2749363874327, 3785.6971442284553, 12666.746665066647, 13305.933470332586, 13325.466981320833, 13348.599542013755, 13364.2649654268, 12864.228146311065, 13052.673683157996, 13123.081384303197, 13141.0, 13186.208827470382, 9411.952940235255, 9738.75653108678, 9767.902320976842, 9812.509374531244, 9951.402915825074, 5393.460653934575, 5457.727113644222, 5502.779888804403, 5547.916781248366, 5593.468620481048, 12140.271583705005, 12168.0, 12184.329861857683, 12190.268583884641, 12312.322822244505, 12548.24710517372, 12620.305883176514, 12660.366981650697, 12821.179340545064, 12838.614841554769, 7311.634418279171, 7507.924920750723, 7534.811629709082, 7557.168711441627, 7560.924390756242, 9551.856722149312, 9700.466474343979, 9790.971947945363, 9815.509224538888, 9862.0, 7651.120121186135, 7744.0319960005, 7761.340286075521, 7831.8825217622925, 7991.960040199761, 7939.960300198462, 8068.677252909818, 8069.556174410463, 8177.386695997705, 8299.6680132794, 7286.016387787793, 7415.221401752954, 7468.813279667835, 7474.0, 7486.737964171446, 4923.433805112458, 5091.643584949018, 5119.897602048012, 5217.530422262014, 5416.160495123262, 5033.84898453047, 5039.899202015866, 5092.796288148433, 5121.79512819498, 5299.205119231991], "value": 4814.60679867218, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.12073790650453, 389.45476333133615, 396.44893597898925, 401.9658329042031, 411.54318706236074, 5250.317458730369, 5400.78396864125, 5521.3926468088475, 5560.6385584937, 5580.804671836487, 5254.605904557155, 5335.573154147669, 5409.43200963899, 5437.184422336652, 5444.448332225316, 4264.317709166527, 4274.166537525184, 4275.893102672442, 4285.292926667112, 4288.785560721967, 3927.7643341399466, 4114.958850411487, 4276.636485898703, 4281.12236991416, 4298.893542164333, 4067.694922880781, 4068.87793366198, 4074.6129117733767, 4075.4701888754566, 4088.713790034699, 4081.8775436736796, 4083.734557253784, 4084.4690190275073, 4095.9385609215888, 4098.590140985907, 3575.3564358415474, 3582.176099497104, 3592.0840185752727, 3622.6377362263825, 3625.8912232633065, 5019.247112933052, 5063.8480845574695, 5175.223716442526, 5192.935448233103, 5245.711485868275, 4852.150873597142, 4857.6599638025355, 4857.73282469464, 4858.951410485921, 4867.415910090812, 5732.283464566929, 5736.885262294731, 5739.311282646067, 5742.167385729088, 5771.163181338682, 3844.730868839182, 3975.284448799215, 3991.341428664267, 4009.679225661969, 4020.517537895442, 5886.264216972879, 6009.188759517453, 6062.727177277033, 6066.969665151646, 6110.655655755727, 4115.5678653741525, 4127.09203975125, 4129.463169787909, 4133.256013917464, 4134.73124246929, 4176.686748493815, 4179.707420480598, 4191.344418954496, 4201.537830838605, 4209.116085621992, 4630.513796051433, 4805.0, 4829.444613869379, 4838.153323168432, 4839.491853355417, 5732.3121225453215, 5738.942610573841, 5749.0, 5764.538836893039, 5780.971095144498, 1450.7606244969672, 1466.672661241578, 1467.8458761830068, 1471.683588028579, 1472.955811325662, 942.1144124522926, 986.0878687214298, 986.2159583131428, 991.2119864707574, 1001.8547310639916, 4993.775280112403, 5010.69935803853, 5012.799488020439, 5017.422996355466, 5035.194368900959, 5849.473547380756, 5991.940080599225, 5996.800639872043, 6004.0, 6022.668753218615, 4866.46468888422, 4969.801207951714, 4975.502449754996, 4983.651144419929, 4996.6002719783055, 3120.829688866675, 3136.247300647828, 3140.7330376918217, 3144.8270345131236, 3158.7157155855625, 5445.200861082934, 5449.618526703172, 5452.727363631802, 5458.8908221835345, 5469.726513674301, 5925.881482370414, 6018.893387314492, 6068.817935461943, 6103.389661033861, 6117.908231376533, 5420.159875219348, 5462.863428414242, 5476.342838859362, 5486.067368547357, 5491.533219676292, 5786.739596718242, 5806.883862322815, 5881.441263080001, 5963.880722385441, 5992.610480318765, 5803.8549036274435, 5807.506361959281, 5836.562257830765, 5844.181814546052, 5854.268216472941, 5278.340207474066, 5423.0, 5444.210589464585, 5459.645123067146, 5465.9726701366235, 4112.527059388209, 4121.814518346741, 4138.420621112987, 4150.958490415057, 4156.584341565819, 5713.600047996601, 5963.942439858242, 5976.252968378953, 5989.580729349078, 5996.37038110992, 5751.1373294006235, 5776.480116789509, 5785.508231800344, 5788.784355285437, 5809.190809190809, 5785.681787501728, 5792.1311803229855, 5797.159411885169, 5799.797007104731, 5825.563082768725, 5562.079908048146, 5654.349749778664, 5673.687947162945, 5687.033204355187, 5703.258576385043, 5768.423157684198, 5771.769129234784, 5776.537876969748, 5782.710864456844, 5787.768489260382, 5483.643563168382, 5605.299337582802, 5618.904313658961, 5621.8594535136945, 5644.0], "value": 4309.714330097335, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.3338212299996, 761.5506850957934, 767.5624893810523, 772.4013889235841, 781.5857595474399, 13211.867881321185, 14122.71754564908, 14144.151350918952, 14216.0, 14321.498747543837, 12081.456334464949, 12132.332721700302, 12139.696507587314, 12208.145429819917, 12222.388880555958, 921.3596550397476, 946.5267366316841, 947.8672985781996, 952.1383148250844, 952.5332587032339, 937.5078084005884, 944.7496413450441, 945.8439357506038, 946.0397696338222, 950.581744032627, 994.5773046455264, 996.4170959988379, 996.451951426716, 997.436448406648, 1003.5383723487168, 976.4287891583397, 979.3780949097339, 984.0, 986.9555869985868, 988.4267125067515, 724.112961622014, 724.4494184419826, 727.9927200727977, 728.9088863892014, 732.1031736123259, 13773.0, 14037.368318425695, 14094.85905140956, 14575.489857854924, 14706.411743530245, 13695.589132326046, 14192.0, 14252.857471425257, 14322.856771432256, 14348.569542913729, 11322.433878306052, 11998.340091294975, 12035.398230088547, 12052.517899284017, 12068.396580170956, 2903.303207230271, 2930.9413811723857, 2932.222960915338, 2934.1344303430537, 2953.350262942149, 62886.371136288966, 64304.67847660778, 64552.0, 64744.67627661832, 66106.0, 8599.828003439896, 10123.341982771097, 10176.694699159038, 10236.795264094677, 10519.789604207874, 21261.78738212629, 21646.134154633954, 21648.675269870964, 21651.78348216529, 21665.350039498524, 6706.798796036127, 6790.72837086511, 6853.828654283583, 6956.200036995709, 7110.004599356094, 3220.951685724716, 3230.99212098357, 3242.967570324314, 3244.641169741909, 3294.0447270291825, 3663.9633603663624, 3675.3935600625596, 3741.1021354874633, 3747.3254814133716, 3778.0932576182067, 778.6573907480804, 785.2187073861544, 786.6578038553133, 786.8308313712465, 786.9960650196713, 531.9521243088141, 538.6983289357972, 545.7762317449826, 549.5054450994137, 559.4657102467135, 8201.13888041759, 8421.95789021051, 8657.653693852302, 8758.430702004476, 8903.513786230136, 536.4126281721509, 545.9863503412447, 559.8852235291755, 566.6430149006183, 567.5743192605546, 3728.9067773305883, 3754.0990162360836, 3771.867984620525, 3778.3387907116144, 3970.8610198643487, 64035.0, 64978.67510662511, 66102.66948665226, 66109.66945165339, 67169.66415167892, 54148.72925635425, 54706.45293547093, 57031.0, 57399.42600574024, 57960.0, 49167.26249106266, 50271.99456010859, 50305.74847125814, 50930.74534627229, 52427.0, 7623.542587444771, 7726.575038372944, 7733.38132949374, 7888.447808653339, 7941.920580794349, 27269.318267043484, 27572.862135689193, 27850.303742406602, 28892.566611500424, 29244.7075529242, 33950.830245849604, 34461.310773784884, 34472.0, 35036.0, 35472.0, 8761.167689069529, 8926.464412135292, 9213.0, 9221.308401869752, 9275.76810579741, 10449.738756531147, 10621.459888315996, 10731.839022414513, 10997.835032474359, 11327.037201837937, 9453.196478299422, 9509.524523773922, 9738.172255358373, 9771.951140244253, 9856.408615482807, 9497.905020949702, 9524.523773811421, 9544.236461082957, 9634.277429192698, 9959.203263738738, 8597.312215022657, 8857.33569982241, 8870.379073464796, 8895.73312800617, 9015.459072455673, 7478.326950574475, 7884.526928384086, 8161.877571836309, 8422.284105850826, 8662.82674346522, 9872.35829671069, 9965.489859212621, 9986.950065249628, 10046.104586981963, 10068.69793906184], "value": 6265.331909967098, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 110.0, 112.0, 115.0, 117.0, 112.0, 112.0, 110.0, 116.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 125.0, 123.0, 169.0, 124.0, 123.0, 129.0, 123.0, 147.0, 125.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 168.0, 173.0, 174.0, 169.0, 164.0, 166.0, 167.0, 164.0], "value": 167.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 77.0, 110.0, 76.0, 77.0, 76.0, 77.0, 93.0, 75.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 122.0, 90.0, 84.0, 84.0, 99.0, 84.0, 83.0, 104.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 124.0, 115.0, 119.0, 114.0, 115.0, 115.0, 115.0], "value": 116.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 151.0, 153.0, 152.0, 151.0, 150.0, 152.0, 154.0, 153.0, 151.0], "value": 152.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 103.0, 95.0, 95.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 55.0, 56.0, 55.0, 55.0, 56.0, 54.0, 55.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 55.0, 55.0, 55.0, 55.0, 56.0, 55.0, 56.0], "value": 55.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 92.0, 84.0, 84.0, 82.0, 82.0, 82.0, 82.0, 82.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 136.0, 137.0, 134.0, 131.0, 138.0, 145.0, 143.0, 190.0, 140.0], "value": 142.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 195.0, 194.0, 193.0, 193.0, 190.0, 192.0, 192.0, 184.0, 192.0], "value": 191.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 72.0, 76.0, 73.0, 71.0, 72.0, 72.0, 73.0, 71.0], "value": 72.3, "unit": "score"}]}]} 09:50:16 INFO - Return code: 0 09:50:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:50:16 ERROR - # TBPL SUCCESS # 09:50:16 INFO - Running post-action listener: _resource_record_post_action 09:50:16 INFO - [mozharness: 2017-04-07 16:50:16.732929Z] Finished run-tests step (success) 09:50:16 INFO - Running post-run listener: _resource_record_post_run 09:50:16 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 359346176; Read time: 12; Write time: 426240 09:50:16 INFO - TinderboxPrint: CPU usage
13.3% 09:50:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:50:16 INFO - TinderboxPrint: I/O write bytes / time
359,346,176 / 426,240 09:50:16 INFO - TinderboxPrint: CPU idle
8,324.2 (86.6%) 09:50:16 INFO - TinderboxPrint: CPU user
1,221.6 (12.7%) 09:50:16 INFO - TinderboxPrint: Swap in / out
0 / 0 09:50:16 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103866368; Read time: 0; Write time: 105512 09:50:16 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 255197184; Read time: 0; Write time: 320696 09:50:17 INFO - Running post-run listener: _upload_blobber_files 09:50:17 INFO - Blob upload gear active. 09:50:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:50:17 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:50:17 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:50:17 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:50:17 INFO - (blobuploader) - INFO - Open directory for files ... 09:50:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:50:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:50:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:20 INFO - (blobuploader) - INFO - Done attempting. 09:50:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:50:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:50:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:21 INFO - (blobuploader) - INFO - Done attempting. 09:50:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:50:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:50:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:22 INFO - (blobuploader) - INFO - Done attempting. 09:50:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:50:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:50:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:23 INFO - (blobuploader) - INFO - Done attempting. 09:50:23 INFO - (blobuploader) - INFO - Iteration through files over. 09:50:23 INFO - Return code: 0 09:50:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:50:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:50:23 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0b3d954d185d869433e738ed4679ab55174d2d550879590a9401a407868537eefa019094f62d244680adc2ac051dc853e0ce8369cb8d41a9a6d05e4ec354dba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1507c6ec72c2f18e79a90d443220151d60e32b7316f45264db8164cea9bf96d9564652fb567501837dee710ef012275f71c28ff68b4d2ffa6f659f63d8750ec9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7430c0c2b80135ebd32ac136105ec397c990b7b4490e6ce8df76674664f4ddb2e2d7e806b86ec6c3f9f2611a6271ed2ec5ef1cf37c870fce2ec77cdb818bbfa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29e9cdf8ce579ab122744c79b63cc3991c064266ec7795d30f1c30f22afd061d38c3afc0ed299861d60a8120fb1da41b106c98c0cd66488c543d865628ae36ce"} 09:50:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:50:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:50:23 INFO - Contents: 09:50:23 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0b3d954d185d869433e738ed4679ab55174d2d550879590a9401a407868537eefa019094f62d244680adc2ac051dc853e0ce8369cb8d41a9a6d05e4ec354dba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1507c6ec72c2f18e79a90d443220151d60e32b7316f45264db8164cea9bf96d9564652fb567501837dee710ef012275f71c28ff68b4d2ffa6f659f63d8750ec9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7430c0c2b80135ebd32ac136105ec397c990b7b4490e6ce8df76674664f4ddb2e2d7e806b86ec6c3f9f2611a6271ed2ec5ef1cf37c870fce2ec77cdb818bbfa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29e9cdf8ce579ab122744c79b63cc3991c064266ec7795d30f1c30f22afd061d38c3afc0ed299861d60a8120fb1da41b106c98c0cd66488c543d865628ae36ce"} 09:50:23 INFO - Running post-run listener: copy_logs_to_upload_dir 09:50:23 INFO - Copying logs to upload dir... 09:50:23 INFO - mkdir: /builds/slave/test/build/upload/logs 09:50:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.938247 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-04-07 09:50:22.889884) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-07 09:50:22.893181) ========= 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=af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770 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/a0b3d954d185d869433e738ed4679ab55174d2d550879590a9401a407868537eefa019094f62d244680adc2ac051dc853e0ce8369cb8d41a9a6d05e4ec354dba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1507c6ec72c2f18e79a90d443220151d60e32b7316f45264db8164cea9bf96d9564652fb567501837dee710ef012275f71c28ff68b4d2ffa6f659f63d8750ec9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7430c0c2b80135ebd32ac136105ec397c990b7b4490e6ce8df76674664f4ddb2e2d7e806b86ec6c3f9f2611a6271ed2ec5ef1cf37c870fce2ec77cdb818bbfa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29e9cdf8ce579ab122744c79b63cc3991c064266ec7795d30f1c30f22afd061d38c3afc0ed299861d60a8120fb1da41b106c98c0cd66488c543d865628ae36ce"} 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/a0b3d954d185d869433e738ed4679ab55174d2d550879590a9401a407868537eefa019094f62d244680adc2ac051dc853e0ce8369cb8d41a9a6d05e4ec354dba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1507c6ec72c2f18e79a90d443220151d60e32b7316f45264db8164cea9bf96d9564652fb567501837dee710ef012275f71c28ff68b4d2ffa6f659f63d8750ec9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7430c0c2b80135ebd32ac136105ec397c990b7b4490e6ce8df76674664f4ddb2e2d7e806b86ec6c3f9f2611a6271ed2ec5ef1cf37c870fce2ec77cdb818bbfa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29e9cdf8ce579ab122744c79b63cc3991c064266ec7795d30f1c30f22afd061d38c3afc0ed299861d60a8120fb1da41b106c98c0cd66488c543d865628ae36ce"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-07 09:50:22.919028) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 09:50:22.919368) ========= 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=af724c981e2a0f424dbabf99000001e7-1491582558.162077-249095770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 09:50:23.001738) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-07 09:50:23.002056) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-07 09:50:23.002366) ========= ========= Total master_lag: 0.17 =========