builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1482037638.43 results: success (0) buildid: 20161217201235 builduid: d61100b0b8f94ab2a50f3e31796cc1d0 revision: 5baae61449c43851c961a83babe18adaa28e3c6b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-17 21:07:18.428831) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-17 21:07:18.429376) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-17 21:07:18.429740) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-17 21:07:18.444801) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 21:07:18.445113) ========= 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=20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-17 21:07:19-- 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% 40.6M=0s 2016-12-17 21:07:19 (40.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.138460 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 21:07:18.598548) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 21:07:18.598925) ========= 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=20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017226 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 21:07:18.648941) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-17 21:07:18.649335) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5baae61449c43851c961a83babe18adaa28e3c6b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5baae61449c43851c961a83babe18adaa28e3c6b --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=20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-17 21:07:19,346 truncating revision to first 12 chars 2016-12-17 21:07:19,346 Setting DEBUG logging. 2016-12-17 21:07:19,346 attempt 1/10 2016-12-17 21:07:19,346 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5baae61449c4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-17 21:07:20,710 unpacking tar archive at: mozilla-central-5baae61449c4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.673653 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-17 21:07:20.340174) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-17 21:07:20.341139) ========= script_repo_revision: 5baae61449c43851c961a83babe18adaa28e3c6b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-17 21:07:20.342164) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-17 21:07:20.342796) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-17 21:07:20.354205) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 47 secs) (at 2016-12-17 21:07:20.354861) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:07:21 INFO - MultiFileLogger online at 20161217 21:07:21 in /builds/slave/test 21:07:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 21:07:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:07:21 INFO - {'append_to_log': False, 21:07:21 INFO - 'base_work_dir': '/builds/slave/test', 21:07:21 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 21:07:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:07:21 INFO - 'branch': 'Firefox-Non-PGO', 21:07:21 INFO - 'buildbot_json_path': 'buildprops.json', 21:07:21 INFO - 'config_files': ('talos/linux_config.py',), 21:07:21 INFO - 'default_actions': ('clobber', 21:07:21 INFO - 'read-buildbot-config', 21:07:21 INFO - 'download-and-extract', 21:07:21 INFO - 'populate-webroot', 21:07:21 INFO - 'create-virtualenv', 21:07:21 INFO - 'install', 21:07:21 INFO - 'run-tests'), 21:07:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:07:21 INFO - 'download_minidump_stackwalk': True, 21:07:21 INFO - 'download_symbols': 'ondemand', 21:07:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:07:21 INFO - 'tooltool.py': '/tools/tooltool.py', 21:07:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:07:21 INFO - '/tools/misc-python/virtualenv.py')}, 21:07:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:07:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:07:21 INFO - 'installer_path': 'installer.exe', 21:07:21 INFO - 'log_level': 'info', 21:07:21 INFO - 'log_name': 'talos', 21:07:21 INFO - 'log_to_console': True, 21:07:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:07:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:07:21 INFO - 'opt_config_files': (), 21:07:21 INFO - 'pip_index': False, 21:07:21 INFO - 'sps_profile': False, 21:07:21 INFO - 'sps_profile_interval': 0, 21:07:21 INFO - 'suite': 'dromaeojs-e10s', 21:07:21 INFO - 'system_bits': '32', 21:07:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:07:21 INFO - 'title': 'talos-linux64-ix-015', 21:07:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:07:21 INFO - 'use_talos_json': True, 21:07:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:07:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:07:21 INFO - 'work_dir': 'build'} 21:07:21 INFO - [mozharness: 2016-12-18 05:07:21.150013Z] Running clobber step. 21:07:21 INFO - Running pre-action listener: _resource_record_pre_action 21:07:21 INFO - Running main action method: clobber 21:07:21 INFO - rmtree: /builds/slave/test/build 21:07:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:07:21 INFO - Running post-action listener: _resource_record_post_action 21:07:21 INFO - [mozharness: 2016-12-18 05:07:21.621546Z] Finished clobber step (success) 21:07:21 INFO - [mozharness: 2016-12-18 05:07:21.621647Z] Running read-buildbot-config step. 21:07:21 INFO - Running pre-action listener: _resource_record_pre_action 21:07:21 INFO - Running main action method: read_buildbot_config 21:07:21 INFO - Using buildbot properties: 21:07:21 INFO - { 21:07:21 INFO - "project": "", 21:07:21 INFO - "product": "firefox", 21:07:21 INFO - "script_repo_revision": "production", 21:07:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 21:07:21 INFO - "repository": "", 21:07:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 21:07:21 INFO - "buildid": "20161217201235", 21:07:21 INFO - "pgo_build": "False", 21:07:21 INFO - "basedir": "/builds/slave/test", 21:07:21 INFO - "buildnumber": 581, 21:07:21 INFO - "slavename": "talos-linux64-ix-015", 21:07:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:07:21 INFO - "platform": "ubuntu64_hw", 21:07:21 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 21:07:21 INFO - "branch": "mozilla-central", 21:07:21 INFO - "repo_path": "mozilla-central", 21:07:21 INFO - "revision": "5baae61449c43851c961a83babe18adaa28e3c6b", 21:07:21 INFO - "stage_platform": "linux64", 21:07:21 INFO - "builduid": "d61100b0b8f94ab2a50f3e31796cc1d0", 21:07:21 INFO - "slavebuilddir": "test" 21:07:21 INFO - } 21:07:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/CtcQ4nFARQ2idasUo0jCOw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 21:07:21 INFO - Running post-action listener: _resource_record_post_action 21:07:21 INFO - [mozharness: 2016-12-18 05:07:21.624075Z] Finished read-buildbot-config step (success) 21:07:21 INFO - [mozharness: 2016-12-18 05:07:21.624163Z] Running download-and-extract step. 21:07:21 INFO - Running pre-action listener: _resource_record_pre_action 21:07:21 INFO - Running main action method: download_and_extract 21:07:21 INFO - mkdir: /builds/slave/test/build/tests 21:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:07:21 INFO - trying https://queue.taskcluster.net/v1/task/CtcQ4nFARQ2idasUo0jCOw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 21:07:21 INFO - Downloading https://queue.taskcluster.net/v1/task/CtcQ4nFARQ2idasUo0jCOw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 21:07:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CtcQ4nFARQ2idasUo0jCOw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:07:22 INFO - Downloaded 1361 bytes. 21:07:22 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 21:07:22 INFO - Using the following test package requirements: 21:07:22 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 21:07:22 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:07:22 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:07:22 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:07:22 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:07:22 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:07:22 INFO - u'jsshell-linux-x86_64.zip'], 21:07:22 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:07:22 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:07:22 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 21:07:22 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:07:22 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:07:22 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:07:22 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:07:22 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:07:22 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:07:22 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:07:22 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:07:22 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:07:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CtcQ4nFARQ2idasUo0jCOw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 21:07:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CtcQ4nFARQ2idasUo0jCOw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:07:22 INFO - Fetch https://queue.taskcluster.net/v1/task/CtcQ4nFARQ2idasUo0jCOw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:07:23 INFO - Expected file size: 20257475 21:07:23 INFO - Obtained file size: 20257475 21:07:27 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:07:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CtcQ4nFARQ2idasUo0jCOw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 21:07:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CtcQ4nFARQ2idasUo0jCOw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:07:27 INFO - Fetch https://queue.taskcluster.net/v1/task/CtcQ4nFARQ2idasUo0jCOw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:07:28 INFO - Expected file size: 20257475 21:07:28 INFO - Obtained file size: 20257475 21:07:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CtcQ4nFARQ2idasUo0jCOw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 21:07:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CtcQ4nFARQ2idasUo0jCOw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:07:32 INFO - Fetch https://queue.taskcluster.net/v1/task/CtcQ4nFARQ2idasUo0jCOw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:07:33 INFO - Expected file size: 14409734 21:07:33 INFO - Obtained file size: 14409734 21:07:33 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')]} 21:07:33 INFO - trying https://queue.taskcluster.net/v1/task/CtcQ4nFARQ2idasUo0jCOw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 21:07:33 INFO - Downloading https://queue.taskcluster.net/v1/task/CtcQ4nFARQ2idasUo0jCOw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 21:07:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CtcQ4nFARQ2idasUo0jCOw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:08:04 WARNING - Socket error when accessing https://queue.taskcluster.net/v1/task/CtcQ4nFARQ2idasUo0jCOw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2: The read operation timed out 21:08:04 INFO - retry: attempt #1 caught exception: The read operation timed out 21:08:04 INFO - retry: Failed, sleeping 30 seconds before retrying 21:08:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CtcQ4nFARQ2idasUo0jCOw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #2 21:08:36 INFO - Downloaded 55634221 bytes. 21:08:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CtcQ4nFARQ2idasUo0jCOw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 21:08:36 INFO - mkdir: /builds/slave/test/properties 21:08:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:08:36 INFO - Writing to file /builds/slave/test/properties/build_url 21:08:36 INFO - Contents: 21:08:36 INFO - build_url:https://queue.taskcluster.net/v1/task/CtcQ4nFARQ2idasUo0jCOw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 21:08:36 INFO - Running post-action listener: _resource_record_post_action 21:08:36 INFO - Running post-action listener: set_extra_try_arguments 21:08:36 INFO - [mozharness: 2016-12-18 05:08:36.795606Z] Finished download-and-extract step (success) 21:08:36 INFO - [mozharness: 2016-12-18 05:08:36.795836Z] Running populate-webroot step. 21:08:36 INFO - Running pre-action listener: _resource_record_pre_action 21:08:36 INFO - Running main action method: populate_webroot 21:08:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:08:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:08:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:08:36 INFO - '--tppagecycles', 21:08:36 INFO - '7'], 21:08:36 INFO - 'tests': ['tsvgm']}}, 21:08:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:08:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:08:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:08:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:08:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:08:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:08:36 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:08:36 INFO - 'talos_options': ['--disable-e10s'], 21:08:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:08:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:08:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:08:36 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:08:36 INFO - 'talos_options': ['--disable-e10s'], 21:08:36 INFO - 'tests': ['damp', 'tps']}, 21:08:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:08:36 INFO - 'tests': ['damp', 'tps']}, 21:08:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:08:36 INFO - 'tests': ['dromaeo_dom']}, 21:08:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:08:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:08:36 INFO - 'tests': ['basic_compositor_video']}, 21:08:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:08:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:08:36 INFO - 'tests': ['a11yr', 21:08:36 INFO - 'ts_paint', 21:08:36 INFO - 'tpaint', 21:08:36 INFO - 'sessionrestore', 21:08:36 INFO - 'sessionrestore_no_auto_restore', 21:08:36 INFO - 'tabpaint']}, 21:08:36 INFO - 'other-e10s': {'tests': ['a11yr', 21:08:36 INFO - 'ts_paint', 21:08:36 INFO - 'tpaint', 21:08:36 INFO - 'sessionrestore', 21:08:36 INFO - 'sessionrestore_no_auto_restore', 21:08:36 INFO - 'tabpaint']}, 21:08:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:08:36 INFO - 'ts_paint', 21:08:36 INFO - 'tpaint', 21:08:36 INFO - 'sessionrestore', 21:08:36 INFO - 'sessionrestore_no_auto_restore', 21:08:36 INFO - 'tabpaint']}, 21:08:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:08:36 INFO - 'ts_paint', 21:08:36 INFO - 'tpaint', 21:08:36 INFO - 'sessionrestore', 21:08:36 INFO - 'sessionrestore_no_auto_restore', 21:08:36 INFO - 'tabpaint']}, 21:08:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:08:36 INFO - 'tests': ['a11yr', 21:08:36 INFO - 'ts_paint', 21:08:36 INFO - 'tpaint', 21:08:36 INFO - 'sessionrestore', 21:08:36 INFO - 'sessionrestore_no_auto_restore', 21:08:36 INFO - 'tabpaint']}, 21:08:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:08:36 INFO - 'tests': ['a11yr', 21:08:36 INFO - 'ts_paint', 21:08:36 INFO - 'tpaint', 21:08:36 INFO - 'sessionrestore', 21:08:36 INFO - 'sessionrestore_no_auto_restore', 21:08:36 INFO - 'tabpaint']}, 21:08:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:08:36 INFO - 'tests': ['tsvgx', 21:08:36 INFO - 'tsvgr_opacity', 21:08:36 INFO - 'tart', 21:08:36 INFO - 'tscrollx', 21:08:36 INFO - 'cart', 21:08:36 INFO - 'tsvg_static']}, 21:08:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:08:36 INFO - 'tsvgr_opacity', 21:08:36 INFO - 'tart', 21:08:36 INFO - 'tscrollx', 21:08:36 INFO - 'cart', 21:08:36 INFO - 'tsvg_static']}, 21:08:36 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:08:36 INFO - 'talos_options': ['--disable-e10s'], 21:08:36 INFO - 'tests': ['tp5o']}, 21:08:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:08:36 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:08:36 INFO - 'talos_options': ['--disable-e10s', 21:08:36 INFO - '--xperf_path', 21:08:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:08:36 INFO - 'tests': ['tp5n']}, 21:08:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:08:36 INFO - 'talos_options': ['--xperf_path', 21:08:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:08:36 INFO - 'tests': ['tp5n']}}, 21:08:36 INFO - 'talos.zip': {'path': '', 21:08:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:08:36 INFO - Running post-action listener: _resource_record_post_action 21:08:36 INFO - [mozharness: 2016-12-18 05:08:36.814952Z] Finished populate-webroot step (success) 21:08:36 INFO - [mozharness: 2016-12-18 05:08:36.815041Z] Running create-virtualenv step. 21:08:36 INFO - Running pre-action listener: _resource_record_pre_action 21:08:36 INFO - Running main action method: create_virtualenv 21:08:36 INFO - Creating virtualenv /builds/slave/test/build/venv 21:08:36 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 21:08:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:08:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:08:36 INFO - Using real prefix '/usr' 21:08:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:08:37 INFO - Installing distribute.............................................................................................................................................................................................done. 21:08:39 INFO - Installing pip.................done. 21:08:39 INFO - Return code: 0 21:08:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:08:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:08:39 INFO - Reading from file tmpfile_stdout 21:08:39 INFO - Output received: 21:08:39 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) 21:08:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:39 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 0x18161f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1927a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b88480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b85820>, '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 0x1b86520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b869b0>, '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': '20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392', '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 21:08:39 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 21:08:39 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 21:08:39 INFO - Using env: {'DISPLAY': ':0', 21:08:39 INFO - 'HOME': '/home/cltbld', 21:08:39 INFO - 'LANG': 'en_US.UTF-8', 21:08:39 INFO - 'LANGUAGE': 'en_US:en', 21:08:39 INFO - 'LOGNAME': 'cltbld', 21:08:39 INFO - 'MAIL': '/var/mail/cltbld', 21:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:39 INFO - 'MOZ_NO_REMOTE': '1', 21:08:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:39 INFO - 'NO_EM_RESTART': '1', 21:08:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:39 INFO - 'PWD': '/builds/slave/test', 21:08:39 INFO - 'SHELL': '/bin/bash', 21:08:39 INFO - 'SHLVL': '1', 21:08:39 INFO - 'TERM': 'linux', 21:08:39 INFO - 'TMOUT': '86400', 21:08:39 INFO - 'USER': 'cltbld', 21:08:39 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392', 21:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:39 INFO - '_': '/tools/buildbot/bin/python'} 21:08:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:39 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 21:08:39 INFO - Cleaning up... 21:08:39 INFO - Return code: 0 21:08:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:39 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 0x18161f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1927a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b88480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b85820>, '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 0x1b86520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b869b0>, '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': '20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392', '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 21:08:39 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 21:08:39 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 21:08:39 INFO - Using env: {'DISPLAY': ':0', 21:08:39 INFO - 'HOME': '/home/cltbld', 21:08:39 INFO - 'LANG': 'en_US.UTF-8', 21:08:39 INFO - 'LANGUAGE': 'en_US:en', 21:08:39 INFO - 'LOGNAME': 'cltbld', 21:08:39 INFO - 'MAIL': '/var/mail/cltbld', 21:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:39 INFO - 'MOZ_NO_REMOTE': '1', 21:08:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:39 INFO - 'NO_EM_RESTART': '1', 21:08:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:39 INFO - 'PWD': '/builds/slave/test', 21:08:39 INFO - 'SHELL': '/bin/bash', 21:08:39 INFO - 'SHLVL': '1', 21:08:39 INFO - 'TERM': 'linux', 21:08:39 INFO - 'TMOUT': '86400', 21:08:39 INFO - 'USER': 'cltbld', 21:08:39 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392', 21:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:39 INFO - '_': '/tools/buildbot/bin/python'} 21:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:40 INFO - Downloading/unpacking psutil>=3.1.1 21:08:40 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 21:08:40 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 21:08:40 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 21:08:40 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 21:08:40 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 21:08:40 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 21:08:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:08:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:08:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:08:42 INFO - Installing collected packages: psutil 21:08:42 INFO - Running setup.py install for psutil 21:08:42 INFO - building 'psutil._psutil_linux' extension 21:08:42 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 21:08:42 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 21:08:42 INFO - building 'psutil._psutil_posix' extension 21:08:42 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 21:08:42 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 21:08:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:08:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:08:42 INFO - Successfully installed psutil 21:08:42 INFO - Cleaning up... 21:08:42 INFO - Return code: 0 21:08:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:42 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 0x18161f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1927a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b88480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b85820>, '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 0x1b86520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b869b0>, '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': '20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392', '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 21:08:42 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 21:08:42 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 21:08:42 INFO - Using env: {'DISPLAY': ':0', 21:08:42 INFO - 'HOME': '/home/cltbld', 21:08:42 INFO - 'LANG': 'en_US.UTF-8', 21:08:42 INFO - 'LANGUAGE': 'en_US:en', 21:08:42 INFO - 'LOGNAME': 'cltbld', 21:08:42 INFO - 'MAIL': '/var/mail/cltbld', 21:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:42 INFO - 'MOZ_NO_REMOTE': '1', 21:08:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:42 INFO - 'NO_EM_RESTART': '1', 21:08:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:42 INFO - 'PWD': '/builds/slave/test', 21:08:42 INFO - 'SHELL': '/bin/bash', 21:08:42 INFO - 'SHLVL': '1', 21:08:42 INFO - 'TERM': 'linux', 21:08:42 INFO - 'TMOUT': '86400', 21:08:42 INFO - 'USER': 'cltbld', 21:08:42 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392', 21:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:42 INFO - '_': '/tools/buildbot/bin/python'} 21:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:08:42 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 21:08:42 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 21:08:42 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 21:08:42 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 21:08:42 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 21:08:42 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 21:08:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:08:44 INFO - Installing collected packages: mozsystemmonitor 21:08:44 INFO - Running setup.py install for mozsystemmonitor 21:08:45 INFO - Successfully installed mozsystemmonitor 21:08:45 INFO - Cleaning up... 21:08:45 INFO - Return code: 0 21:08:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:08:45 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')]} 21:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:45 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')]} 21:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:45 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 0x18161f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1927a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b88480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b85820>, '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 0x1b86520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b869b0>, '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': '20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392', '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 21:08:45 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 21:08:45 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 21:08:45 INFO - Using env: {'DISPLAY': ':0', 21:08:45 INFO - 'HOME': '/home/cltbld', 21:08:45 INFO - 'LANG': 'en_US.UTF-8', 21:08:45 INFO - 'LANGUAGE': 'en_US:en', 21:08:45 INFO - 'LOGNAME': 'cltbld', 21:08:45 INFO - 'MAIL': '/var/mail/cltbld', 21:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:45 INFO - 'MOZ_NO_REMOTE': '1', 21:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:45 INFO - 'NO_EM_RESTART': '1', 21:08:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:45 INFO - 'PWD': '/builds/slave/test', 21:08:45 INFO - 'SHELL': '/bin/bash', 21:08:45 INFO - 'SHLVL': '1', 21:08:45 INFO - 'TERM': 'linux', 21:08:45 INFO - 'TMOUT': '86400', 21:08:45 INFO - 'USER': 'cltbld', 21:08:45 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392', 21:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:45 INFO - '_': '/tools/buildbot/bin/python'} 21:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:45 INFO - Downloading/unpacking jsonschema==2.5.1 21:08:45 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 21:08:45 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 21:08:45 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 21:08:45 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 21:08:45 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 21:08:45 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 21:08:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:08:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:08:47 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 21:08:47 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 21:08:47 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 21:08:47 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 21:08:47 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 21:08:47 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 21:08:47 INFO - Downloading functools32-3.2.3-2.tar.gz 21:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:08:47 INFO - warning: no files found matching '*.txt' 21:08:47 INFO - no previously-included directories found matching 'build' 21:08:47 INFO - no previously-included directories found matching 'dist' 21:08:47 INFO - no previously-included directories found matching '.git*' 21:08:47 INFO - Installing collected packages: jsonschema, functools32 21:08:47 INFO - Running setup.py install for functools32 21:08:47 INFO - warning: no files found matching '*.txt' 21:08:47 INFO - no previously-included directories found matching 'build' 21:08:47 INFO - no previously-included directories found matching 'dist' 21:08:47 INFO - no previously-included directories found matching '.git*' 21:08:47 INFO - Successfully installed jsonschema functools32 21:08:47 INFO - Cleaning up... 21:08:47 INFO - Return code: 0 21:08:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:08: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')]} 21:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08: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')]} 21:08:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:47 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 0x18161f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1927a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b88480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b85820>, '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 0x1b86520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b869b0>, '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': '20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392', '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 21:08:47 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 21:08:47 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 21:08:47 INFO - Using env: {'DISPLAY': ':0', 21:08:47 INFO - 'HOME': '/home/cltbld', 21:08:47 INFO - 'LANG': 'en_US.UTF-8', 21:08:47 INFO - 'LANGUAGE': 'en_US:en', 21:08:47 INFO - 'LOGNAME': 'cltbld', 21:08:47 INFO - 'MAIL': '/var/mail/cltbld', 21:08:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:47 INFO - 'MOZ_NO_REMOTE': '1', 21:08:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:47 INFO - 'NO_EM_RESTART': '1', 21:08:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:47 INFO - 'PWD': '/builds/slave/test', 21:08:47 INFO - 'SHELL': '/bin/bash', 21:08:47 INFO - 'SHLVL': '1', 21:08:47 INFO - 'TERM': 'linux', 21:08:47 INFO - 'TMOUT': '86400', 21:08:47 INFO - 'USER': 'cltbld', 21:08:47 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392', 21:08:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:47 INFO - '_': '/tools/buildbot/bin/python'} 21:08:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:08:47 INFO - Cleaning up... 21:08:48 INFO - Return code: 0 21:08:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18161f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1927a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b88480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b85820>, '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 0x1b86520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b869b0>, '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': '20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392', '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 21:08:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:08:48 INFO - Using env: {'DISPLAY': ':0', 21:08:48 INFO - 'HOME': '/home/cltbld', 21:08:48 INFO - 'LANG': 'en_US.UTF-8', 21:08:48 INFO - 'LANGUAGE': 'en_US:en', 21:08:48 INFO - 'LOGNAME': 'cltbld', 21:08:48 INFO - 'MAIL': '/var/mail/cltbld', 21:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:48 INFO - 'MOZ_NO_REMOTE': '1', 21:08:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:48 INFO - 'NO_EM_RESTART': '1', 21:08:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:48 INFO - 'PWD': '/builds/slave/test', 21:08:48 INFO - 'SHELL': '/bin/bash', 21:08:48 INFO - 'SHLVL': '1', 21:08:48 INFO - 'TERM': 'linux', 21:08:48 INFO - 'TMOUT': '86400', 21:08:48 INFO - 'USER': 'cltbld', 21:08:48 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392', 21:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:48 INFO - '_': '/tools/buildbot/bin/python'} 21:08:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:48 INFO - Downloading/unpacking blobuploader==1.2.4 21:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:50 INFO - Downloading blobuploader-1.2.4.tar.gz 21:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:08:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:08:50 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 21:08:50 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 21:08:50 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 21:08:50 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 21:08:50 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 21:08:50 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 21:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:08:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:08:50 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 21:08:50 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 21:08:50 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 21:08:50 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 21:08:50 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 21:08:50 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 21:08:50 INFO - Downloading docopt-0.6.1.tar.gz 21:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:08:51 INFO - Installing collected packages: blobuploader, requests, docopt 21:08:51 INFO - Running setup.py install for blobuploader 21:08:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:08:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:08:51 INFO - Running setup.py install for requests 21:08:51 INFO - Running setup.py install for docopt 21:08:51 INFO - Successfully installed blobuploader requests docopt 21:08:51 INFO - Cleaning up... 21:08:51 INFO - Return code: 0 21:08:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:08: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')]} 21:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08: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')]} 21:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:51 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 0x18161f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1927a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b88480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b85820>, '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 0x1b86520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b869b0>, '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': '20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392', '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 21:08:51 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 21:08:51 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 21:08:51 INFO - Using env: {'DISPLAY': ':0', 21:08:51 INFO - 'HOME': '/home/cltbld', 21:08:51 INFO - 'LANG': 'en_US.UTF-8', 21:08:51 INFO - 'LANGUAGE': 'en_US:en', 21:08:51 INFO - 'LOGNAME': 'cltbld', 21:08:51 INFO - 'MAIL': '/var/mail/cltbld', 21:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:51 INFO - 'MOZ_NO_REMOTE': '1', 21:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:51 INFO - 'NO_EM_RESTART': '1', 21:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:51 INFO - 'PWD': '/builds/slave/test', 21:08:51 INFO - 'SHELL': '/bin/bash', 21:08:51 INFO - 'SHLVL': '1', 21:08:51 INFO - 'TERM': 'linux', 21:08:51 INFO - 'TMOUT': '86400', 21:08:51 INFO - 'USER': 'cltbld', 21:08:51 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392', 21:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:51 INFO - '_': '/tools/buildbot/bin/python'} 21:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:08:51 INFO - Running setup.py (path:/tmp/pip-SL_cT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:08:51 INFO - Running setup.py (path:/tmp/pip-3LpGHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:08:51 INFO - Running setup.py (path:/tmp/pip-Q6nWvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:08:52 INFO - Running setup.py (path:/tmp/pip-GhSRU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:08:52 INFO - Running setup.py (path:/tmp/pip-arIM2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:08:52 INFO - Running setup.py (path:/tmp/pip-FdhxVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:08:52 INFO - Running setup.py (path:/tmp/pip-o4VPwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:08:52 INFO - Running setup.py (path:/tmp/pip-16zj7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:08:52 INFO - Running setup.py (path:/tmp/pip-Yc2LtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:08:52 INFO - Running setup.py (path:/tmp/pip-xe4NaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:08:52 INFO - Running setup.py (path:/tmp/pip-uF2BRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:08:52 INFO - Running setup.py (path:/tmp/pip-yadOCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:08:52 INFO - Running setup.py (path:/tmp/pip-jNJUy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:08:52 INFO - Running setup.py (path:/tmp/pip-fx1KUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:08:52 INFO - Running setup.py (path:/tmp/pip-MVEGy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:08:52 INFO - Running setup.py (path:/tmp/pip-3SCglK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:08:53 INFO - Running setup.py (path:/tmp/pip-JZ9_yB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:08:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:08:53 INFO - Running setup.py install for manifestparser 21:08:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:08:53 INFO - Running setup.py install for mozcrash 21:08:53 INFO - Running setup.py install for mozdebug 21:08:53 INFO - Running setup.py install for mozdevice 21:08:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:08:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:08:53 INFO - Running setup.py install for mozfile 21:08:53 INFO - Running setup.py install for mozhttpd 21:08:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:08:53 INFO - Running setup.py install for mozinfo 21:08:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:08:53 INFO - Running setup.py install for mozInstall 21:08:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:08:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:08:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:08:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:08:53 INFO - Running setup.py install for mozleak 21:08:53 INFO - Running setup.py install for mozlog 21:08:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:08:54 INFO - Running setup.py install for moznetwork 21:08:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:08:54 INFO - Running setup.py install for mozprocess 21:08:54 INFO - Running setup.py install for mozprofile 21:08:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:08:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:08:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:08:54 INFO - Running setup.py install for mozrunner 21:08:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:08:54 INFO - Running setup.py install for mozscreenshot 21:08:54 INFO - Running setup.py install for moztest 21:08:54 INFO - Running setup.py install for mozversion 21:08:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:08:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:08:54 INFO - Cleaning up... 21:08:54 INFO - Return code: 0 21:08:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:08: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')]} 21:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08: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')]} 21:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:54 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 0x18161f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1927a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b88480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b85820>, '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 0x1b86520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b869b0>, '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': '20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392', '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 21:08:54 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 21:08:54 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 21:08:54 INFO - Using env: {'DISPLAY': ':0', 21:08:54 INFO - 'HOME': '/home/cltbld', 21:08:54 INFO - 'LANG': 'en_US.UTF-8', 21:08:54 INFO - 'LANGUAGE': 'en_US:en', 21:08:54 INFO - 'LOGNAME': 'cltbld', 21:08:54 INFO - 'MAIL': '/var/mail/cltbld', 21:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:54 INFO - 'MOZ_NO_REMOTE': '1', 21:08:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:54 INFO - 'NO_EM_RESTART': '1', 21:08:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:54 INFO - 'PWD': '/builds/slave/test', 21:08:54 INFO - 'SHELL': '/bin/bash', 21:08:54 INFO - 'SHLVL': '1', 21:08:54 INFO - 'TERM': 'linux', 21:08:54 INFO - 'TMOUT': '86400', 21:08:54 INFO - 'USER': 'cltbld', 21:08:54 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392', 21:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:54 INFO - '_': '/tools/buildbot/bin/python'} 21:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:08:55 INFO - Running setup.py (path:/tmp/pip-ob1cKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:08:55 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)) 21:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:08:55 INFO - Running setup.py (path:/tmp/pip-XQ0uDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:08:55 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)) 21:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:08:55 INFO - Running setup.py (path:/tmp/pip-9HsuPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:08:55 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)) 21:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:08:55 INFO - Running setup.py (path:/tmp/pip-7JDGci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:08:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:08:55 INFO - Running setup.py (path:/tmp/pip-KiY1wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:08:55 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)) 21:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:08:55 INFO - Running setup.py (path:/tmp/pip-SyNcfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:08:55 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)) 21:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:08:55 INFO - Running setup.py (path:/tmp/pip-hHHCbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:08:55 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)) 21:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:08:55 INFO - Running setup.py (path:/tmp/pip-GB8zXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:08:55 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)) 21:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:08:55 INFO - Running setup.py (path:/tmp/pip-sv6NeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:08:55 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)) 21:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:08:55 INFO - Running setup.py (path:/tmp/pip-HiTw64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:08:55 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)) 21:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:08:55 INFO - Running setup.py (path:/tmp/pip-NmLcRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:08:55 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)) 21:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:08:55 INFO - Running setup.py (path:/tmp/pip-JTjtwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 21:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:08:56 INFO - Running setup.py (path:/tmp/pip-MBbyLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:08:56 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)) 21:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:08:56 INFO - Running setup.py (path:/tmp/pip-1k8i9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:08:56 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)) 21:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:08:56 INFO - Running setup.py (path:/tmp/pip-jBfU0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:08:56 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)) 21:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:08:56 INFO - Running setup.py (path:/tmp/pip-_jnAzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 21:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:08:56 INFO - Running setup.py (path:/tmp/pip-nOxqLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:08:56 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)) 21:08:56 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)) 21:08:56 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)) 21:08:56 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)) 21:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:08:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:58 INFO - Downloading blessings-1.6.tar.gz 21:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:08:58 INFO - Installing collected packages: blessings 21:08:58 INFO - Running setup.py install for blessings 21:08:58 INFO - Successfully installed blessings 21:08:58 INFO - Cleaning up... 21:08:58 INFO - Return code: 0 21:08:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:08:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:08:58 INFO - Reading from file tmpfile_stdout 21:08:58 INFO - Current package versions: 21:08:58 INFO - argparse == 1.2.1 21:08:58 INFO - blessings == 1.6 21:08:58 INFO - blobuploader == 1.2.4 21:08:58 INFO - docopt == 0.6.1 21:08:58 INFO - functools32 == 3.2.3-2 21:08:58 INFO - jsonschema == 2.5.1 21:08:58 INFO - manifestparser == 1.1 21:08:58 INFO - mozInstall == 1.12 21:08:58 INFO - mozcrash == 1.0 21:08:58 INFO - mozdebug == 0.1 21:08:58 INFO - mozdevice == 0.49 21:08:58 INFO - mozfile == 1.2 21:08:58 INFO - mozhttpd == 0.7 21:08:58 INFO - mozinfo == 0.9 21:08:58 INFO - mozleak == 0.1 21:08:58 INFO - mozlog == 3.4 21:08:58 INFO - moznetwork == 0.27 21:08:58 INFO - mozprocess == 0.23 21:08:58 INFO - mozprofile == 0.28 21:08:58 INFO - mozrunner == 6.13 21:08:58 INFO - mozscreenshot == 0.1 21:08:58 INFO - mozsystemmonitor == 0.3 21:08:58 INFO - moztest == 0.7 21:08:58 INFO - mozversion == 1.4 21:08:58 INFO - psutil == 3.1.1 21:08:58 INFO - requests == 1.2.3 21:08:58 INFO - wsgiref == 0.1.2 21:08:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:08:58 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')]} 21:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:58 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')]} 21:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:58 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 0x18161f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1927a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b88480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b85820>, '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 0x1b86520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b869b0>, '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': '20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392', '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 21:08:58 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 21:08:58 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 21:08:58 INFO - Using env: {'DISPLAY': ':0', 21:08:58 INFO - 'HOME': '/home/cltbld', 21:08:58 INFO - 'LANG': 'en_US.UTF-8', 21:08:58 INFO - 'LANGUAGE': 'en_US:en', 21:08:58 INFO - 'LOGNAME': 'cltbld', 21:08:58 INFO - 'MAIL': '/var/mail/cltbld', 21:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:58 INFO - 'MOZ_NO_REMOTE': '1', 21:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:58 INFO - 'NO_EM_RESTART': '1', 21:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:58 INFO - 'PWD': '/builds/slave/test', 21:08:58 INFO - 'SHELL': '/bin/bash', 21:08:58 INFO - 'SHLVL': '1', 21:08:58 INFO - 'TERM': 'linux', 21:08:58 INFO - 'TMOUT': '86400', 21:08:58 INFO - 'USER': 'cltbld', 21:08:58 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392', 21:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:58 INFO - '_': '/tools/buildbot/bin/python'} 21:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:59 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)) 21:08:59 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)) 21:08:59 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)) 21:08:59 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)) 21:08:59 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)) 21:08:59 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)) 21:08:59 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)) 21:08:59 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)) 21:08:59 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)) 21:08:59 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)) 21:08:59 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)) 21:08:59 INFO - Cleaning up... 21:08:59 INFO - Return code: 0 21:08:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:08: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')]} 21:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08: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')]} 21:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18161f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1927a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b88480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b85820>, '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 0x1b86520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b869b0>, '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': '20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392', '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 21:08: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', 'jsonschema'] in /builds/slave/test/build 21:08: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 jsonschema 21:08:59 INFO - Using env: {'DISPLAY': ':0', 21:08:59 INFO - 'HOME': '/home/cltbld', 21:08:59 INFO - 'LANG': 'en_US.UTF-8', 21:08:59 INFO - 'LANGUAGE': 'en_US:en', 21:08:59 INFO - 'LOGNAME': 'cltbld', 21:08:59 INFO - 'MAIL': '/var/mail/cltbld', 21:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:59 INFO - 'MOZ_NO_REMOTE': '1', 21:08:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:59 INFO - 'NO_EM_RESTART': '1', 21:08:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:59 INFO - 'PWD': '/builds/slave/test', 21:08:59 INFO - 'SHELL': '/bin/bash', 21:08:59 INFO - 'SHLVL': '1', 21:08:59 INFO - 'TERM': 'linux', 21:08:59 INFO - 'TMOUT': '86400', 21:08:59 INFO - 'USER': 'cltbld', 21:08:59 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392', 21:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:59 INFO - '_': '/tools/buildbot/bin/python'} 21:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:08:59 INFO - Cleaning up... 21:08:59 INFO - Return code: 0 21:08:59 INFO - Running post-action listener: _resource_record_post_action 21:08:59 INFO - Running post-action listener: _start_resource_monitoring 21:08:59 INFO - Starting resource monitoring. 21:08:59 INFO - [mozharness: 2016-12-18 05:08:59.295257Z] Finished create-virtualenv step (success) 21:08:59 INFO - [mozharness: 2016-12-18 05:08:59.295789Z] Running install step. 21:08:59 INFO - Running pre-action listener: _resource_record_pre_action 21:08:59 INFO - Running main action method: install 21:08:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:08:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:08:59 INFO - Reading from file tmpfile_stdout 21:08:59 INFO - Detecting whether we're running mozinstall >=1.0... 21:08:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:08:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:08:59 INFO - Reading from file tmpfile_stdout 21:08:59 INFO - Output received: 21:08:59 INFO - Usage: mozinstall [options] installer 21:08:59 INFO - Options: 21:08:59 INFO - -h, --help show this help message and exit 21:08:59 INFO - -d DEST, --destination=DEST 21:08:59 INFO - Directory to install application into. [default: 21:08:59 INFO - "/builds/slave/test"] 21:08:59 INFO - --app=APP Application being installed. [default: firefox] 21:08:59 INFO - mkdir: /builds/slave/test/build/application 21:08:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:08:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:09:15 INFO - Reading from file tmpfile_stdout 21:09:15 INFO - Output received: 21:09:15 INFO - /builds/slave/test/build/application/firefox/firefox 21:09:15 INFO - Running post-action listener: _resource_record_post_action 21:09:15 INFO - [mozharness: 2016-12-18 05:09:15.657433Z] Finished install step (success) 21:09:15 INFO - [mozharness: 2016-12-18 05:09:15.657688Z] Running run-tests step. 21:09:15 INFO - Running pre-action listener: _resource_record_pre_action 21:09:15 INFO - Running main action method: run_tests 21:09:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:09:15 INFO - Python 2.7.3 21:09:15 INFO - Return code: 0 21:09:15 INFO - grabbing minidump binary from tooltool 21:09:15 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')]} 21:09:15 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 0x1b85820>, '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 0x1b86520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b869b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:09:15 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 21:09:15 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 21:09:15 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 21:09:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:09:15 INFO - Return code: 0 21:09:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:09:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:09:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:09:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:09:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:09:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CtcQ4nFARQ2idasUo0jCOw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 21:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CtcQ4nFARQ2idasUo0jCOw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 21:09:15 INFO - Using env: {'DISPLAY': ':0', 21:09:15 INFO - 'HOME': '/home/cltbld', 21:09:15 INFO - 'LANG': 'en_US.UTF-8', 21:09:15 INFO - 'LANGUAGE': 'en_US:en', 21:09:15 INFO - 'LOGNAME': 'cltbld', 21:09:15 INFO - 'MAIL': '/var/mail/cltbld', 21:09:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:09:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:15 INFO - 'MOZ_NO_REMOTE': '1', 21:09:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:09:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:15 INFO - 'NO_EM_RESTART': '1', 21:09:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:15 INFO - 'PWD': '/builds/slave/test', 21:09:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:09:15 INFO - 'SHELL': '/bin/bash', 21:09:15 INFO - 'SHLVL': '1', 21:09:15 INFO - 'TERM': 'linux', 21:09:15 INFO - 'TMOUT': '86400', 21:09:15 INFO - 'USER': 'cltbld', 21:09:15 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392', 21:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:15 INFO - '_': '/tools/buildbot/bin/python'} 21:09:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CtcQ4nFARQ2idasUo0jCOw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 21:09:15 INFO - mozversion application_buildid: 20161217201235 21:09:15 INFO - mozversion application_changeset: 5baae61449c43851c961a83babe18adaa28e3c6b 21:09:15 INFO - mozversion application_display_name: Nightly 21:09:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:09:15 INFO - mozversion application_name: Firefox 21:09:15 INFO - mozversion application_remotingname: firefox 21:09:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:09:15 INFO - mozversion application_vendor: Mozilla 21:09:15 INFO - mozversion application_version: 53.0a1 21:09:15 INFO - mozversion platform_buildid: 20161217201235 21:09:15 INFO - mozversion platform_changeset: 5baae61449c43851c961a83babe18adaa28e3c6b 21:09:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:09:15 INFO - mozversion platform_version: 53.0a1 21:09:15 INFO - using testdate: 1482037755 21:09:15 INFO - actual date: 1482037755 21:09:15 INFO - starting webserver on 'localhost:39769' 21:09:15 INFO - SUITE-START | Running 2 tests 21:09:15 INFO - TEST-START | dromaeo_css 21:09:15 INFO - operating with platform_type : linux_ 21:09:15 INFO - Initialising browser for dromaeo_css test... 21:09:15 INFO - TEST-INFO | started process 9053 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy4C41s/profile http://localhost:39769/getInfo.html) 21:09:20 INFO - PROCESS | 9053 | __metrics Screen width/height:1600/1200 21:09:20 INFO - PROCESS | 9053 | colorDepth:24 21:09:20 INFO - PROCESS | 9053 | Browser inner width/height: 1024/697 21:09:20 INFO - PROCESS | 9053 | __metrics 21:09:20 ERROR - PROCESS | 9053 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3232: TypeError: this.tabs is undefined 21:09:21 INFO - TEST-INFO | 9053: exit 0 21:09:21 INFO - Browser initialized. 21:09:21 INFO - Running cycle 1/1 for dromaeo_css test... 21:09:21 INFO - TEST-INFO | started process 9173 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy4C41s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:09:33 INFO - PROCESS | 9173 | RSS: Main: 163442688 21:09:33 INFO - PROCESS | 9173 | 21:10:23 INFO - PROCESS | 9173 | 1482037823520 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:12:37 INFO - PROCESS | 9173 | Cycle 1(1): loaded http://localhost:39769/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39769/tests/dromaeo/cssquery-ext.html) 21:12:39 INFO - PROCESS | 9173 | RSS: Main: 165150720 21:12:39 INFO - PROCESS | 9173 | 21:15:42 INFO - PROCESS | 9173 | Cycle 1(1): loaded http://localhost:39769/tests/dromaeo/cssquery-ext.html (next: http://localhost:39769/tests/dromaeo/cssquery-jquery.html) 21:15:42 INFO - PROCESS | 9173 | RSS: Main: 165347328 21:15:42 INFO - PROCESS | 9173 | 21:18:45 INFO - PROCESS | 9173 | Cycle 1(1): loaded http://localhost:39769/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39769/tests/dromaeo/cssquery-mootools.html) 21:18:45 INFO - PROCESS | 9173 | RSS: Main: 167399424 21:18:45 INFO - PROCESS | 9173 | 21:21:48 INFO - PROCESS | 9173 | Cycle 1(1): loaded http://localhost:39769/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39769/tests/dromaeo/cssquery-prototype.html) 21:21:48 INFO - PROCESS | 9173 | RSS: Main: 163885056 21:21:48 INFO - PROCESS | 9173 | 21:24:51 INFO - PROCESS | 9173 | Cycle 1(1): loaded http://localhost:39769/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39769/tests/dromaeo/cssquery-yui.html) 21:24:52 INFO - PROCESS | 9173 | RSS: Main: 166809600 21:24:52 INFO - PROCESS | 9173 | 21:27:55 INFO - PROCESS | 9173 | Cycle 1(1): loaded http://localhost:39769/tests/dromaeo/cssquery-yui.html (next: http://localhost:39769/tests/dromaeo/cssquery-dojo.html) 21:27:55 INFO - PROCESS | 9173 | RSS: Main: 168263680 21:27:55 INFO - PROCESS | 9173 | 21:27:55 INFO - PROCESS | 9173 | __start_tp_report 21:27:55 INFO - PROCESS | 9173 | _x_x_mozilla_page_load 21:27:55 INFO - PROCESS | 9173 | _x_x_mozilla_page_load_details 21:27:55 INFO - PROCESS | 9173 | |i|pagename|runs| 21:27:55 INFO - PROCESS | 9173 | |0;dojo.html;2649.721779213183;2672.812903096784;2690.3408664877106;2690.7309269073085;2709.2414124045276;4718.0092180642105;4849.80600775969;4858.829940952068;4896.510348965102;4909.779059942302;4739.715617062979;4742.193827049401;4807.423109226889;4876.658633895629;4888.242322440018;4319.352097185416;4348.369486424466;4391.758453285068;4429.114177164563;4474.709143905636;4379.868603941887;4480.327950807388;4495.9325610115875;4507.729536227836;4529.162105010567;4313.266744653416;4348.021695118605;4496.145732310851;4498.235299999008;4541.409616749835;4332.220200363933;4361.149575832714;4404.66964977628;4422.5356337584735;4499;4344.522102568715;4378.496472905625;4408.823647054114;4411.470623525165;4428.335749637548;4686.203345431285;4786.688865223784;4791.185498465235;4801.375821143229;4812.446568644581;5070;5084.669496482754;5106.872328191825;5116.51393117657;5210.088234558975;5114;5170.741462926839;5178.922316165261;5179.119549676564;5183.663061900965;4826.227803551415;4827.806887724451;4833.830815921497;4879.731614761222;4880.267959806022;5143.871403214875;5171.198464238049;5265.131253343156;5265.341832270966;5279.472052794767;5070.6957582545165;5083.262926875583;5090.211017292326;5111.258867464197;5112.897742045138;4982.2775697524385;5010.799568017312;5215.114808883281;5233.450487698813;5296.09966305729;5101.846944591668;5103.336566246364;5124.205748109049;5187.610929180327;5216.843494695166;5142.845714628567;5148.639595228298;5149.536541711189;5152.072626927189;5200.200772277496;4347.847825326098;4467.5755803198645;4482.731036137842;4494.617957473652;4515;3800.6579407852873;3835.9041023974064;3867.9806600966817;3904.2386734586485;4014.0968282136287;4506.278995360726;4535.274356103007;4545.795439205243;4547.954520454819;4608.493065762764;5294.9205761912835;5306.602004849575;5308.416074231909;5318.946810531923;5323.653962492425;4355.4337936068105;4388.539203383599;4480.596746292849;4494.842680506166;4509.323601459741;4761.214399624093;4764.332993380929;4765.26138448541;4766.904661906742;4808.759562021885;4864.756762161877;4865.0756356292195;4881.4142302922455;4887.242477416006;4951;5042.39491261051;5092.108880945746;5119.155339369111;5130.153524668388;5294.417614062373;4754.952450475451;4784.186688263073;4788.688735232199;4826.8793280168275;4828.734419606955;5060.671056381323;5095.974520127524;5100.974495127649;5112.079825631274;5130.4100028497205;5037.168867136881;5074.720890351066;5076.695398276115;5161.922571161511;5216.608754343515;4945.50544945517;4960.751962401938;4984;5050.3434553507805;5058.367704036996;4994.126027945168;5007.774650140679;5014.749262536931;5023.095842748195;5031.270465782514;4741.620670346433;4792.0895029944195;4808.639352048541;4822.469528351949;4884.462709102067;4947.901041979212;4953.851384458472;4956.727379994135;4968.776405061853;4995.950040499549;4879.048585525788;4881.975590122027;4891.9755401222765;4911.778969946289;4936.827211047596 21:27:55 INFO - PROCESS | 9173 | |1;ext.html;503.69023050823745;506.44797171083536;508.4432546361737;522.305333905905;525.2252926932773;36653.81673091634;38930.41604375937;39224.60775392245;39271.60728392715;39307.803460982694;40046;40490.797546012225;40706.38940415896;40771.59228407715;40800.38799418011;7590.96204518978;7738.26486483786;7746.961265193666;7785.649645765926;7787.844243115134;9456.527173641325;9734.464604446752;9785;10078.193744500459;10082.89917100827;9754.317197796157;9785;9805.705828825146;9812.165965892907;9825.90174098257;9696.46669433181;9747.074027967332;9751.220902042955;9792.853107203326;9816.312858099936;9585;9608;9650.71047868558;9670.516474176333;9673.516324183762;33272;33325.33349333024;33474.6652533474;33518;33583.32833343344;2880.164752221853;3096.922576935572;3451.5858097028517;3469.340825243196;3589.6589823966683;25140;25286.747132528624;25690.100846470472;25703.228903132935;25934.74065259342;3434.227298857762;3460.8615655373756;3532.1699400640828;3647.2340808430263;3656.597774244831;245447;246038;247235;247819;248915.9999999982;45265.321020184725;45530.77234613806;45608.543914561094;45722.77138614286;45777.771111144895;48371;48411.27383089256;48619.75690121527;48728;48770.512294877306;12863.356832158355;13625.659358515919;13648.863511364958;13658.453661853613;13675.452981880811;9509.5720692569;9790.167835734042;10233.232507561814;10414.427206503564;10441.112505436971;15062.397504099932;15499.457518986781;15541;15576.376944922076;15653.452129175652;6332.746690132435;6339.636978049649;6435.485161187187;6487.643179625072;6547.443467305237;745.9291367320096;865.3639574912435;866.1684782608767;921.7695576105973;968.8934217236099;26022;26675.733242667713;27892.44215115686;27897;28331.29171770681;876.1107475911955;911.7219248129384;947.8388673925449;1035.7514196592915;1037.7405648587853;14649.926750366392;14658.633534161518;14757.483488077865;14781.704365912621;14917.328720207617;328251;332778;335813;336439;336945;48486.51513484891;49129.38494533353;49171;49265;49603.25595116076;1136.1876258475395;1164.0920082335792;1174.0548858169086;1177.8409914661581;1179.504608064632;25398.36504087339;26669.733302666726;26816.59775103336;27628.447431051667;27664.446711065262;41532.37701434542;41865.79067104645;41868;41889.58110418857;41991;284760;286179;286319;286857;287353;22116.2259320923;22795.658065128704;23822.404439889142;24293.63559546573;24769.50460990806;36849.63150368462;37280.62719372771;40932.795336023126;41140;41210.587894121876;34876.47685284672;35223.540351245596;35251.82374088113;35345.1163720909;35738.463923040654;34759.82620086883;35229.47155792614;35419.645803541636;35738.64261357353;35805.283894321445;34102.658973410944;34409;34836.303273934886;35032.649673502936;35232.11919702028;30346.241343966576;32305.838470808434;32857.835710821295;32983;33037.50443743394;24832.751672483046;25076.74923250744;25158.74841251564;25648.61527077058;25659.87170064138 21:27:55 INFO - PROCESS | 9173 | |2;jquery.html;348.9267253876684;363.55827669381705;363.8290003698262;370.0895796341001;388.33594553313833;15384.923075384622;16317.755233671489;17061.232244548977;17077.40229091979;17187.656246875085;16347.4278400256;16402.507924762278;16599.17004149794;16694.248758805854;16840.494785156436;4743.8102475901005;4982.202847544376;4995.825146119886;5025.773840177182;5030.849074527751;3646;3830.1190726133004;4882.853514394574;5561.165825126243;5901.3508514063415;5855.47300742933;5940.851478713045;5948.58359914804;5950.880982380371;5962.433568810956;5723.942760572403;5786.392428794979;5823.213866128103;5841.211436456067;5848.976429124908;5071.1632580624155;5129.538341549279;5137.537621614073;5147.562457191143;5155;19629.607407851763;19870.304539341054;20128.39614811558;20170.79829201704;20763.896180519;1896.8900517333711;1902.6289873474677;1928.006463260163;2030.604032213719;2545.071049067096;12403.503859845596;12856.871431285661;13123.868761312455;13783.931080344533;13802;1714.2457318779698;1796.7664203653442;1798.5323815807853;1813.918373673188;1871.3543827379533;55510;57385.13922291169;67389;68116;68960;15005.774913376308;16118.919405403132;16167.514974550782;16436.6712665746;16510.75233871493;27214.958878083828;27232.455350892873;27314.726852731616;27562.5865612016;27642.447151056866;8449.197326253996;8710.303175745925;8730.388872778845;9109.681161159328;9198.63205471787;7267.709291628275;7268.454865884974;7308.634568271672;7403.837642731365;7543.849123017619;7642.69429222836;8098.676052957933;8125.431219814556;8136.959315203386;8213.34293256538;1510.7129645367345;1606.2049285603468;1634.3544300001433;3105.627324721048;3196.6803319667847;775.4533054196778;802.7557286206356;811.3144392987916;825.2820046559532;900.6397441023512;15763.763543546856;16176.43382481631;16208.918955405383;16337.101459419846;16558.172091395383;822.3955392786297;832.3632421197789;833.8749187621784;887.2990337633197;904.9140331668481;8990.820183596423;9208.447493150432;9421.38760980534;9557.283203759607;9613.615455381847;327375;328721;353428;353676;355172;72596.27403726001;78692;79214;80107;80473;886.636479043589;891.3671293381772;942.9486122972972;943.0522325063267;946.7159852044497;15132.394704212149;15216.163111029;15607.219639017776;15684.607884802972;15938.123403212934;27513.724862751118;30159.547606786353;33418.16454588558;35316.64683353133;35418.11454713653;46566.767166163954;46650.53349466598;47051.29423058588;48610.75694621504;49143.26285105655;7356.96321518389;7471.290227428603;7581;7709.7301594443925;7921.9207807923485;10021.549030293509;11067.667969960914;11226.270292430965;11301.773964520828;11653.59212427561;9719.805603888024;9738.75653108678;10102.191824654157;10107.444090575089;10599.62901298451;10099.596016159272;10438.895611044096;10631.255812093079;10662.200334975063;10840.67477975662;10510.369377837354;10702.464876756287;10744.140468762636;10791.56833726642;11223.887761122285;6658.1344425224415;7730.536167829948;7789.5715735635085;7816.179301173295;7973.8405231896195;8373.539455330016;10011.949940250252;10040.397576145455;10057.949710251401;10442.947785261025 21:27:55 INFO - PROCESS | 9173 | |3;mootools.html;1326.7014921642628;1334.8998825088117;1432.9211893345862;1608.7828143200663;1665.2090257127866;6398.264199617045;6675.732970681167;6679.131712877325;7106.2183159852375;7114.573125612467;6854.3145685431555;7133.464990125735;7134.964325178367;7247.565146091225;7266.091738532684;2107.4309936317222;2144.3888491779844;2144.5818065477238;2145.774693657167;2146.8175205107586;2078.1168003598486;2149.118861266873;2177.1291483406685;2180.1715348167672;2182.3234797212913;2097.5070858348276;2107.262458139654;2119.904604292803;2130.4886827161527;2145.0668959002883;2074.2429013410147;2103.3584756649293;2114.0381126587367;2114.4713821544615;2115.037657865683;2033.857629965903;2062.154516648182;2095.6018356512213;2107.1782005017903;2107.4942013916702;7248.782536523912;7277.636118194122;7315.707371705125;7325.670344834495;7343.485955983083;4296.355546667994;4408.559144085598;4426.601605855489;4461.955380446187;4468.642508599337;2666.813323067386;2805.9438811223868;2864.1693908766433;2917.6352955880516;2941.8381988990595;833.8624127019095;852.8848605438249;877.1228771228771;891.6611687558751;894.7494701483595;9445.622175112987;9448.196903263162;9488.33581649278;9508.429494230368;9574.425534467884;3817.351050321452;3956.643902048829;3971.4837071180564;4005.839766409369;4183.686223533247;8368.41421100517;8398;8414.15858414166;8421.957890210631;8442;4489.057297967398;4513.232750432434;4517.435320584927;4518.796654150571;4535.63714902807;3587.390143675529;3703.685186759156;3930.1157239620857;3969.6625786807867;4111.465509483748;3353.279045005336;3460.480927860841;3477.565304336958;3525.11872031992;3527.294541091792;1098.357460885375;1104.0725790336155;1104.8950349716763;1138.1975707126455;1140.0366690146814;657.5101549345768;688.2532452289322;716.1656669979519;834.2658460554673;857.9013413457533;4739.905201896012;4829.830955916526;4945.826896058693;5212.139996900469;5267.707682698314;825.1253671108644;869.517417833096;904.8099899021279;920.7283851263893;938.5072836760755;3567.6967457765863;3750.83121259544;3758.962410375861;3771.735978481535;3776.2825063238447;8602.397832151815;8638.481691098554;8742;8764.737057888273;8784.692535761218;8646.956765216133;8672;8702.608382622797;8704;8722.433041852386;6725.66371681414;6758.526903116833;6795.93204067953;6821.931780682229;6960.965195174093;4842.58837998774;4914.8771280718265;4947.2579113133315;5310.070737620824;5383.16560933056;8102.594870256581;8104.108548059827;8105.148959359418;8232.135625759209;8239.794005149919;7979.9601001994615;8119.512829230265;8186;8220.917790822015;8242.876356854533;5801.883962320814;5867.911981320198;6427.742890284337;6587.736490540325;6670.466362690876;6630.9668451657435;6907.378335949587;6912.170539535288;7064.399526040344;7077.221505634479;6384.07430922523;6439.388258115471;6542.34576542361;6637.103990961158;6746.595204287759;6345.58093346574;6425.518086143651;6478.935210647834;6480.351964803482;6560.147180866456;5659.943400566106;5752.453516915886;5755.280589926259;5757.769689212552;5760.510356619734;4356.629686476685;4408.7575183365225;4423.469183697976;4456.799444025091;4496.550344965477;4332.761698106634;4451.510333863208;4487.730736155841;4653.790579423866;4707.317438971261 21:27:55 INFO - PROCESS | 9173 | |4;prototype.html;344.85516083245034;351.41840254378997;353.8354665080737;356.68789808917205;359.0216659602585;4888.924436623942;4959.677016399012;4967.478414766442;4979.9293151972315;4994.825181118662;4902.852914412564;4915.557599816016;4933.210686290195;4972.154733695272;4979.950200497994;3732.9626703732956;3838.865639702611;3839.5217841131225;3914.4324073009398;3951.4467974483596;3933.311670457673;3945.7040721945827;3945.782981935992;3957.4657421248194;3976.6421022108007;3944.704147188958;3945.7237993340477;3946.7370441458743;3956.9208615827665;3961.504811898513;3573.4282514797505;3770.1517158639363;3943.6253555912144;3956.4876303547167;3957.1294315250598;3326.2848487575047;3332.583876689405;3335.5830521184853;3336.616289126733;3355.9161020974425;4780.402449693788;4793.424789025305;4813.807447702123;4813.809716578949;4817.855464336076;4349.26062569364;4368.934465983013;4375.365571992043;4378.1462614790125;4391.27543955247;5045.268436076785;5183.922241166386;5195.818146364859;5205.375354957391;5239.449857764918;3654.3239500692457;3655.798931058791;3656.3053019926397;3676.191237927652;3680.834362453696;5369.288509302816;5375.274337964363;5409.29607173743;5409.756560954766;5449.482299181572;3584.408572585546;3697.205100903319;3703.6481534254203;3732.4774531565604;3736.8878933632036;3758.1919887224376;3758.248350329945;3770.981145094257;3782.394816829294;3782.8486860525823;4286.721363111388;4293.506246781598;4294;4295.957040429618;4330.39374487572;5077;5164.657189130853;5208.348956380452;5213.374395072616;5238.345206849144;1268.898488120948;1279.3027799849106;1281.9038572107129;1286.601153642355;1292.6445227562494;845.4969293270494;873.2969959182918;883.5670521444446;887.9467231966103;888.7022847346211;4391.560843915583;4465.888352791206;4517.774111294422;4589.1051245007575;4603.378543896598;5360.177539636465;5370.865728356823;5380.91928621071;5399.947010332948;5418.509909774843;4591.311303304531;4596.034832685106;4600.562946520142;4608.446986361591;4611.884702882455;2645.9867700661375;2761.558150695879;2770.891643342639;2788.3029242689327;2795.853699983038;4888.9755551222015;4905.288733133676;4905.3623029006;4915.680480768739;4923.975380123076;5218.739063046833;5267.552258058031;5368.4631536846;5388.676679399248;5400.324959380077;4828.082664293773;4893.580861550111;4903.705777653352;4913.950860491349;4932.90134197314;5174.327337446108;5260.421353651019;5265.368155821326;5288.709120998382;5312.309399778004;5019.749012549285;5092.337996060489;5127.974360128324;5161.045206636784;5311.814086507108;5009.668570400643;5018.0608222545125;5023.246513023076;5024.271480635361;5038.035166285225;3773.3773927302786;3784.508013958168;3787.5833658298116;3792.886213413602;3821.5605205401735;5133.717645529382;5369.704666243238;5443.292371991616;5472.562195024469;5478.260434841245;5209.270702101633;5209.921851172159;5217.373915130209;5232.424433312256;5243.501867322599;5223.902980374164;5243.475652434726;5253.921191182212;5260;5272.604554658493;4917.852464426073;5099.490050994871;5121.389420458642;5153.2270159476375;5177.559907407913;5034.942662041012;5123.436421993652;5155.226715992631;5237.816676416307;5263.289455923555;5116.904272914833;5137.433082909748;5141.974290128525;5159.948400515947;5163.173892177234 21:27:55 INFO - PROCESS | 9173 | |5;yui.html;614.4101662404092;646.4182235987611;655.6066360183887;684.3898435751411;707.6461769115442;12045.036397088234;12474.875251247484;13245.602631921058;14224.644383890409;14231.573052808406;12341.814872776915;12363.196392234498;12429.2542447453;12605.936970315159;12636.11547191697;761.4137114421906;771.4985259581262;777.8910952466659;781.183663072091;782.5774081995716;755.5806527377304;766.0233202666617;787.3661702329651;789.8973133492667;790.8062524681461;818.8567000774871;821.2362502872327;821.9506829590243;822.0874828939872;827.4952279109739;817.2685446525356;818.2594751749676;818.443458448255;818.4966245758875;819.3608984991716;603.0170821560828;606.5753972219464;607.5777334752349;607.6688204928281;608.46455119495;13056.955443564588;13222.404991775296;13228.404721787543;13301.334933253396;13887.097338673055;12774.361281935959;12838;13199.604011879659;13318.86681133186;13422.664433389244;9919.454430006346;10001.849972250422;10005.899941000569;10110.443925584164;10136.290459667825;3185.394774992767;3190.6490286068515;3199.856006479714;3211.8394080296125;3274.67253274673;64503.67748161229;64530.354696453374;65765.3423465764;67318;67430.66284668594;9680.128788408936;9738.561764720605;9743.805123897482;10005.19958403326;10133.341332813343;16747.91626041862;17327.91336043312;17545;18598.907005465157;18961.715574266396;6750.966245168841;6838.93161068383;6894.345037221456;6929.965350173217;6932.37608615217;3686.4101743720876;3719.7210209234418;3733.7199710021855;3776.4524143998965;3778.4521244419407;2767.045369347572;2785.8885644574393;2845.1891211004763;2854.2293580733085;2859.242300790292;507.6015327967528;507.9263506791568;509.42435048395697;527.0171130840954;527.5621234375459;571.8255931940715;607.9907353792682;622.9501639868799;623.7847942459844;653.4315145823165;8328.541930193898;8337.650950540039;8619.827603447897;8672.392932494664;8760.211580957744;618.5299172628835;647.6211416321411;647.6276141218818;649.7563413719855;651.3226244705548;3960.128771670228;4031.294523458383;4034.7377420467574;4127.626614696562;4205.684573656988;61613;63288;65028.67485662542;65723.67138164278;67252.663736681;48764.51235487671;53711.462885370645;56447;56723.43276567264;58800.7059964706;46057.30914036292;46109;47104;50692.999999999265;52849.735751321;8402.705905293285;8649.117299729545;8789.428687135316;8897.28821694276;8984.685536006209;37701.62298376981;38319.23361532809;38404;38599;39383;45156;50020;50853.49146508487;51150.74424627853;51986.740066299426;11679.124065694938;11814.291142531476;12122.15144939881;12142.817857731965;12488.687782805502;12870.292133932724;12936.741265174833;13111.475540978254;13166.341682916007;13354.332283385598;12059.57791477294;12153.45309461094;12718.809217861924;12727.80908286358;12761.87238127644;11917.16579839403;11938.58214962472;12251.203671761306;12597.68505787326;13058.412371443117;12246.142770006014;12413.131080824616;12426.24780736742;12642.87357126417;12735.426905789447;8534.871976920474;9175.908240917772;9388.287374527246;9447.763805904908;9571.234301256021;10285.43430111351;10501.107405870587;10507.264491485523;10522.789544209227;10523.894761052292 21:27:55 INFO - PROCESS | 9173 | __end_tp_report 21:27:55 INFO - PROCESS | 9173 | __start_cc_report 21:27:55 INFO - PROCESS | 9173 | _x_x_mozilla_cycle_collect,341 21:27:55 INFO - PROCESS | 9173 | __end_cc_report 21:27:55 INFO - PROCESS | 9173 | __startTimestamp1482038875690__endTimestamp 21:27:55 INFO - PROCESS | 9173 | 21:27:55 INFO - PROCESS | 9173 | ------- Summary: start ------- 21:27:55 INFO - PROCESS | 9173 | Number of tests: 6 21:27:55 INFO - PROCESS | 9173 | 21:27:55 INFO - PROCESS | 9173 | [#0] dojo.html Cycles:165 Average:4765.99 Median:4879.73 stddev:492.79 (10.1%) stddev-sans-first:465.50 21:27:55 INFO - PROCESS | 9173 | Values: 2649.7 2672.8 2690.3 2690.7 2709.2 4718.0 4849.8 4858.8 4896.5 4909.8 4739.7 4742.2 4807.4 4876.7 4888.2 4319.4 4348.4 4391.8 4429.1 4474.7 4379.9 4480.3 4495.9 4507.7 4529.2 4313.3 4348.0 4496.1 4498.2 4541.4 4332.2 4361.1 4404.7 4422.5 4499.0 4344.5 4378.5 4408.8 4411.5 4428.3 4686.2 4786.7 4791.2 4801.4 4812.4 5070.0 5084.7 5106.9 5116.5 5210.1 5114.0 5170.7 5178.9 5179.1 5183.7 4826.2 4827.8 4833.8 4879.7 4880.3 5143.9 5171.2 5265.1 5265.3 5279.5 5070.7 5083.3 5090.2 5111.3 5112.9 4982.3 5010.8 5215.1 5233.5 5296.1 5101.8 5103.3 5124.2 5187.6 5216.8 5142.8 5148.6 5149.5 5152.1 5200.2 4347.8 4467.6 4482.7 4494.6 4515.0 3800.7 3835.9 3868.0 3904.2 4014.1 4506.3 4535.3 4545.8 4548.0 4608.5 5294.9 5306.6 5308.4 5318.9 5323.7 4355.4 4388.5 4480.6 4494.8 4509.3 4761.2 4764.3 4765.3 4766.9 4808.8 4864.8 4865.1 4881.4 4887.2 4951.0 5042.4 5092.1 5119.2 5130.2 5294.4 4755.0 4784.2 4788.7 4826.9 4828.7 5060.7 5096.0 5101.0 5112.1 5130.4 5037.2 5074.7 5076.7 5161.9 5216.6 4945.5 4960.8 4984.0 5050.3 5058.4 4994.1 5007.8 5014.7 5023.1 5031.3 4741.6 4792.1 4808.6 4822.5 4884.5 4947.9 4953.9 4956.7 4968.8 4996.0 4879.0 4882.0 4892.0 4911.8 4936.8 21:27:55 INFO - PROCESS | 9173 | 21:27:55 INFO - PROCESS | 9173 | [#1] ext.html Cycles:180 Average:44120.33 Median:35230.80 stddev:76275.01 (216.5%) stddev-sans-first:76418.68 21:27:55 INFO - PROCESS | 9173 | Values: 503.7 506.4 508.4 522.3 525.2 36653.8 38930.4 39224.6 39271.6 39307.8 40046.0 40490.8 40706.4 40771.6 40800.4 7591.0 7738.3 7747.0 7785.6 7787.8 9456.5 9734.5 9785.0 10078.2 10082.9 9754.3 9785.0 9805.7 9812.2 9825.9 9696.5 9747.1 9751.2 9792.9 9816.3 9585.0 9608.0 9650.7 9670.5 9673.5 33272.0 33325.3 33474.7 33518.0 33583.3 2880.2 3096.9 3451.6 3469.3 3589.7 25140.0 25286.7 25690.1 25703.2 25934.7 3434.2 3460.9 3532.2 3647.2 3656.6 245447.0 246038.0 247235.0 247819.0 248916.0 45265.3 45530.8 45608.5 45722.8 45777.8 48371.0 48411.3 48619.8 48728.0 48770.5 12863.4 13625.7 13648.9 13658.5 13675.5 9509.6 9790.2 10233.2 10414.4 10441.1 15062.4 15499.5 15541.0 15576.4 15653.5 6332.7 6339.6 6435.5 6487.6 6547.4 745.9 865.4 866.2 921.8 968.9 26022.0 26675.7 27892.4 27897.0 28331.3 876.1 911.7 947.8 1035.8 1037.7 14649.9 14658.6 14757.5 14781.7 14917.3 328251.0 332778.0 335813.0 336439.0 336945.0 48486.5 49129.4 49171.0 49265.0 49603.3 1136.2 1164.1 1174.1 1177.8 1179.5 25398.4 26669.7 26816.6 27628.4 27664.4 41532.4 41865.8 41868.0 41889.6 41991.0 284760.0 286179.0 286319.0 286857.0 287353.0 22116.2 22795.7 23822.4 24293.6 24769.5 36849.6 37280.6 40932.8 41140.0 41210.6 34876.5 35223.5 35251.8 35345.1 35738.5 34759.8 35229.5 35419.6 35738.6 35805.3 34102.7 34409.0 34836.3 35032.6 35232.1 30346.2 32305.8 32857.8 32983.0 33037.5 24832.8 25076.7 25158.7 25648.6 25659.9 21:27:55 INFO - PROCESS | 9173 | 21:27:55 INFO - PROCESS | 9173 | [#2] jquery.html Cycles:180 Average:23434.30 Median:2008.04 stddev:56865.73 (2831.9%) stddev-sans-first:56998.83 21:27:55 INFO - PROCESS | 9173 | Values: 348.9 363.6 363.8 370.1 388.3 15384.9 16317.8 17061.2 17077.4 17187.7 16347.4 16402.5 16599.2 16694.2 16840.5 4743.8 4982.2 4995.8 5025.8 5030.8 3646.0 3830.1 4882.9 5561.2 5901.4 5855.5 5940.9 5948.6 5950.9 5962.4 5723.9 5786.4 5823.2 5841.2 5849.0 5071.2 5129.5 5137.5 5147.6 5155.0 19629.6 19870.3 20128.4 20170.8 20763.9 1896.9 1902.6 1928.0 2030.6 2545.1 12403.5 12856.9 13123.9 13783.9 13802.0 1714.2 1796.8 1798.5 1813.9 1871.4 55510.0 57385.1 67389.0 68116.0 68960.0 15005.8 16118.9 16167.5 16436.7 16510.8 27215.0 27232.5 27314.7 27562.6 27642.4 8449.2 8710.3 8730.4 9109.7 9198.6 7267.7 7268.5 7308.6 7403.8 7543.8 7642.7 8098.7 8125.4 8137.0 8213.3 1510.7 1606.2 1634.4 3105.6 3196.7 775.5 802.8 811.3 825.3 900.6 15763.8 16176.4 16208.9 16337.1 16558.2 822.4 832.4 833.9 887.3 904.9 8990.8 9208.4 9421.4 9557.3 9613.6 327375.0 328721.0 353428.0 353676.0 355172.0 72596.3 78692.0 79214.0 80107.0 80473.0 886.6 891.4 942.9 943.1 946.7 15132.4 15216.2 15607.2 15684.6 15938.1 27513.7 30159.5 33418.2 35316.6 35418.1 46566.8 46650.5 47051.3 48610.8 49143.3 7357.0 7471.3 7581.0 7709.7 7921.9 10021.5 11067.7 11226.3 11301.8 11653.6 9719.8 9738.8 10102.2 10107.4 10599.6 10099.6 10438.9 10631.3 10662.2 10840.7 10510.4 10702.5 10744.1 10791.6 11223.9 6658.1 7730.5 7789.6 7816.2 7973.8 8373.5 10011.9 10040.4 10057.9 10442.9 21:27:55 INFO - PROCESS | 9173 | 21:27:55 INFO - PROCESS | 9173 | [#3] mootools.html Cycles:180 Average:4808.83 Median:5706.20 stddev:2578.69 (45.2%) stddev-sans-first:2572.64 21:27:55 INFO - PROCESS | 9173 | Values: 1326.7 1334.9 1432.9 1608.8 1665.2 6398.3 6675.7 6679.1 7106.2 7114.6 6854.3 7133.5 7135.0 7247.6 7266.1 2107.4 2144.4 2144.6 2145.8 2146.8 2078.1 2149.1 2177.1 2180.2 2182.3 2097.5 2107.3 2119.9 2130.5 2145.1 2074.2 2103.4 2114.0 2114.5 2115.0 2033.9 2062.2 2095.6 2107.2 2107.5 7248.8 7277.6 7315.7 7325.7 7343.5 4296.4 4408.6 4426.6 4462.0 4468.6 2666.8 2805.9 2864.2 2917.6 2941.8 833.9 852.9 877.1 891.7 894.7 9445.6 9448.2 9488.3 9508.4 9574.4 3817.4 3956.6 3971.5 4005.8 4183.7 8368.4 8398.0 8414.2 8422.0 8442.0 4489.1 4513.2 4517.4 4518.8 4535.6 3587.4 3703.7 3930.1 3969.7 4111.5 3353.3 3460.5 3477.6 3525.1 3527.3 1098.4 1104.1 1104.9 1138.2 1140.0 657.5 688.3 716.2 834.3 857.9 4739.9 4829.8 4945.8 5212.1 5267.7 825.1 869.5 904.8 920.7 938.5 3567.7 3750.8 3759.0 3771.7 3776.3 8602.4 8638.5 8742.0 8764.7 8784.7 8647.0 8672.0 8702.6 8704.0 8722.4 6725.7 6758.5 6795.9 6821.9 6961.0 4842.6 4914.9 4947.3 5310.1 5383.2 8102.6 8104.1 8105.1 8232.1 8239.8 7980.0 8119.5 8186.0 8220.9 8242.9 5801.9 5867.9 6427.7 6587.7 6670.5 6631.0 6907.4 6912.2 7064.4 7077.2 6384.1 6439.4 6542.3 6637.1 6746.6 6345.6 6425.5 6478.9 6480.4 6560.1 5659.9 5752.5 5755.3 5757.8 5760.5 4356.6 4408.8 4423.5 4456.8 4496.6 4332.8 4451.5 4487.7 4653.8 4707.3 21:27:55 INFO - PROCESS | 9173 | 21:27:55 INFO - PROCESS | 9173 | [#4] prototype.html Cycles:180 Average:4293.36 Median:4904.50 stddev:1249.78 (25.5%) stddev-sans-first:1217.64 21:27:55 INFO - PROCESS | 9173 | Values: 344.9 351.4 353.8 356.7 359.0 4888.9 4959.7 4967.5 4979.9 4994.8 4902.9 4915.6 4933.2 4972.2 4980.0 3733.0 3838.9 3839.5 3914.4 3951.4 3933.3 3945.7 3945.8 3957.5 3976.6 3944.7 3945.7 3946.7 3956.9 3961.5 3573.4 3770.2 3943.6 3956.5 3957.1 3326.3 3332.6 3335.6 3336.6 3355.9 4780.4 4793.4 4813.8 4813.8 4817.9 4349.3 4368.9 4375.4 4378.1 4391.3 5045.3 5183.9 5195.8 5205.4 5239.4 3654.3 3655.8 3656.3 3676.2 3680.8 5369.3 5375.3 5409.3 5409.8 5449.5 3584.4 3697.2 3703.6 3732.5 3736.9 3758.2 3758.2 3771.0 3782.4 3782.8 4286.7 4293.5 4294.0 4296.0 4330.4 5077.0 5164.7 5208.3 5213.4 5238.3 1268.9 1279.3 1281.9 1286.6 1292.6 845.5 873.3 883.6 887.9 888.7 4391.6 4465.9 4517.8 4589.1 4603.4 5360.2 5370.9 5380.9 5399.9 5418.5 4591.3 4596.0 4600.6 4608.4 4611.9 2646.0 2761.6 2770.9 2788.3 2795.9 4889.0 4905.3 4905.4 4915.7 4924.0 5218.7 5267.6 5368.5 5388.7 5400.3 4828.1 4893.6 4903.7 4914.0 4932.9 5174.3 5260.4 5265.4 5288.7 5312.3 5019.7 5092.3 5128.0 5161.0 5311.8 5009.7 5018.1 5023.2 5024.3 5038.0 3773.4 3784.5 3787.6 3792.9 3821.6 5133.7 5369.7 5443.3 5472.6 5478.3 5209.3 5209.9 5217.4 5232.4 5243.5 5223.9 5243.5 5253.9 5260.0 5272.6 4917.9 5099.5 5121.4 5153.2 5177.6 5034.9 5123.4 5155.2 5237.8 5263.3 5116.9 5137.4 5142.0 5159.9 5163.2 21:27:55 INFO - PROCESS | 9173 | 21:27:55 INFO - PROCESS | 9173 | [#5] yui.html Cycles:180 Average:14959.92 Median:49392.26 stddev:18497.54 (37.5%) stddev-sans-first:18518.07 21:27:55 INFO - PROCESS | 9173 | Values: 614.4 646.4 655.6 684.4 707.6 12045.0 12474.9 13245.6 14224.6 14231.6 12341.8 12363.2 12429.3 12605.9 12636.1 761.4 771.5 777.9 781.2 782.6 755.6 766.0 787.4 789.9 790.8 818.9 821.2 822.0 822.1 827.5 817.3 818.3 818.4 818.5 819.4 603.0 606.6 607.6 607.7 608.5 13057.0 13222.4 13228.4 13301.3 13887.1 12774.4 12838.0 13199.6 13318.9 13422.7 9919.5 10001.8 10005.9 10110.4 10136.3 3185.4 3190.6 3199.9 3211.8 3274.7 64503.7 64530.4 65765.3 67318.0 67430.7 9680.1 9738.6 9743.8 10005.2 10133.3 16747.9 17327.9 17545.0 18598.9 18961.7 6751.0 6838.9 6894.3 6930.0 6932.4 3686.4 3719.7 3733.7 3776.5 3778.5 2767.0 2785.9 2845.2 2854.2 2859.2 507.6 507.9 509.4 527.0 527.6 571.8 608.0 623.0 623.8 653.4 8328.5 8337.7 8619.8 8672.4 8760.2 618.5 647.6 647.6 649.8 651.3 3960.1 4031.3 4034.7 4127.6 4205.7 61613.0 63288.0 65028.7 65723.7 67252.7 48764.5 53711.5 56447.0 56723.4 58800.7 46057.3 46109.0 47104.0 50693.0 52849.7 8402.7 8649.1 8789.4 8897.3 8984.7 37701.6 38319.2 38404.0 38599.0 39383.0 45156.0 50020.0 50853.5 51150.7 51986.7 11679.1 11814.3 12122.2 12142.8 12488.7 12870.3 12936.7 13111.5 13166.3 13354.3 12059.6 12153.5 12718.8 12727.8 12761.9 11917.2 11938.6 12251.2 12597.7 13058.4 12246.1 12413.1 12426.2 12642.9 12735.4 8534.9 9175.9 9388.3 9447.8 9571.2 10285.4 10501.1 10507.3 10522.8 10523.9 21:27:55 INFO - PROCESS | 9173 | -------- Summary: end -------- 21:27:55 INFO - PROCESS | 9173 | 21:27:56 INFO - TEST-INFO | 9173: exit 0 21:27:56 INFO - TEST-OK | dromaeo_css | took 1120527ms 21:27:56 INFO - TEST-START | kraken 21:27:56 INFO - operating with platform_type : linux_ 21:27:56 INFO - Initialising browser for kraken test... 21:27:56 INFO - TEST-INFO | started process 9532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpECHKt3/profile http://localhost:39769/getInfo.html) 21:28:00 INFO - PROCESS | 9532 | __metrics Screen width/height:1600/1200 21:28:00 INFO - PROCESS | 9532 | colorDepth:24 21:28:00 INFO - PROCESS | 9532 | Browser inner width/height: 1024/697 21:28:00 INFO - PROCESS | 9532 | __metrics 21:28:01 ERROR - PROCESS | 9532 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3232: TypeError: this.tabs is undefined 21:28:02 INFO - TEST-INFO | 9532: exit 0 21:28:02 INFO - Browser initialized. 21:28:02 INFO - Running cycle 1/1 for kraken test... 21:28:02 INFO - TEST-INFO | started process 9650 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpECHKt3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:28:14 INFO - PROCESS | 9650 | RSS: Main: 163659776 21:28:14 INFO - PROCESS | 9650 | 21:28:17 INFO - PROCESS | 9650 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39769/tests/kraken/driver.html?testName=audio-beat-detection) 21:28:18 INFO - PROCESS | 9650 | RSS: Main: 168321024 21:28:18 INFO - PROCESS | 9650 | 21:28:20 INFO - PROCESS | 9650 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39769/tests/kraken/driver.html?testName=audio-dft) 21:28:21 INFO - PROCESS | 9650 | RSS: Main: 166182912 21:28:21 INFO - PROCESS | 9650 | 21:28:24 INFO - PROCESS | 9650 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39769/tests/kraken/driver.html?testName=audio-fft) 21:28:25 INFO - PROCESS | 9650 | RSS: Main: 162828288 21:28:25 INFO - PROCESS | 9650 | 21:28:27 INFO - PROCESS | 9650 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39769/tests/kraken/driver.html?testName=audio-oscillator) 21:28:27 INFO - PROCESS | 9650 | RSS: Main: 163258368 21:28:27 INFO - PROCESS | 9650 | 21:28:30 INFO - PROCESS | 9650 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39769/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:28:30 INFO - PROCESS | 9650 | RSS: Main: 163696640 21:28:30 INFO - PROCESS | 9650 | 21:28:34 INFO - PROCESS | 9650 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39769/tests/kraken/driver.html?testName=imaging-darkroom) 21:28:34 INFO - PROCESS | 9650 | RSS: Main: 168476672 21:28:34 INFO - PROCESS | 9650 | 21:28:38 INFO - PROCESS | 9650 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39769/tests/kraken/driver.html?testName=imaging-desaturate) 21:28:38 INFO - PROCESS | 9650 | RSS: Main: 165224448 21:28:38 INFO - PROCESS | 9650 | 21:28:41 INFO - PROCESS | 9650 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39769/tests/kraken/driver.html?testName=json-parse-financial) 21:28:42 INFO - PROCESS | 9650 | RSS: Main: 166543360 21:28:42 INFO - PROCESS | 9650 | 21:28:44 INFO - PROCESS | 9650 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39769/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:28:44 INFO - PROCESS | 9650 | RSS: Main: 166256640 21:28:44 INFO - PROCESS | 9650 | 21:28:46 INFO - PROCESS | 9650 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39769/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:28:47 INFO - PROCESS | 9650 | RSS: Main: 166371328 21:28:47 INFO - PROCESS | 9650 | 21:28:49 INFO - PROCESS | 9650 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39769/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:28:50 INFO - PROCESS | 9650 | RSS: Main: 166719488 21:28:50 INFO - PROCESS | 9650 | 21:28:53 INFO - PROCESS | 9650 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:28:53 INFO - PROCESS | 9650 | RSS: Main: 166801408 21:28:53 INFO - PROCESS | 9650 | 21:28:56 INFO - PROCESS | 9650 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:28:57 INFO - PROCESS | 9650 | RSS: Main: 168902656 21:28:57 INFO - PROCESS | 9650 | 21:28:59 INFO - PROCESS | 9650 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39769/tests/kraken/driver.html?testName=ai-astar) 21:28:59 INFO - PROCESS | 9650 | RSS: Main: 168759296 21:28:59 INFO - PROCESS | 9650 | 21:28:59 INFO - PROCESS | 9650 | __start_tp_report 21:28:59 INFO - PROCESS | 9650 | _x_x_mozilla_page_load 21:28:59 INFO - PROCESS | 9650 | _x_x_mozilla_page_load_details 21:28:59 INFO - PROCESS | 9650 | |i|pagename|runs| 21:28:59 INFO - PROCESS | 9650 | |0;ai-astar;111;116;117;117;119;117;115;115;116;116 21:28:59 INFO - PROCESS | 9650 | |1;audio-beat-detection;148;126;127;167;132;127;130;126;149;131 21:28:59 INFO - PROCESS | 9650 | |2;audio-dft;163;167;167;168;164;165;162;164;163;165 21:28:59 INFO - PROCESS | 9650 | |3;audio-fft;78;77;77;106;77;79;76;79;94;77 21:28:59 INFO - PROCESS | 9650 | |4;audio-oscillator;86;87;109;85;89;88;100;85;85;108 21:28:59 INFO - PROCESS | 9650 | |5;imaging-gaussian-blur;128;128;128;129;131;129;127;128;129;129 21:28:59 INFO - PROCESS | 9650 | |6;imaging-darkroom;149;149;150;149;147;148;148;150;151;147 21:28:59 INFO - PROCESS | 9650 | |7;imaging-desaturate;96;97;96;96;97;96;96;97;96;96 21:28:59 INFO - PROCESS | 9650 | |8;json-parse-financial;65;68;66;65;67;67;71;66;67;65 21:28:59 INFO - PROCESS | 9650 | |9;json-stringify-tinderbox;67;66;67;67;70;65;66;66;69;68 21:28:59 INFO - PROCESS | 9650 | |10;stanford-crypto-aes;87;86;92;89;85;84;85;84;85;87 21:28:59 INFO - PROCESS | 9650 | |11;stanford-crypto-ccm;140;137;137;150;137;144;137;141;193;138 21:28:59 INFO - PROCESS | 9650 | |12;stanford-crypto-pbkdf2;183;183;193;183;184;185;185;187;185;184 21:28:59 INFO - PROCESS | 9650 | |13;stanford-crypto-sha256-iterative;70;71;71;77;71;73;71;70;70;70 21:28:59 INFO - PROCESS | 9650 | __end_tp_report 21:28:59 INFO - PROCESS | 9650 | __start_cc_report 21:28:59 INFO - PROCESS | 9650 | _x_x_mozilla_cycle_collect,853 21:28:59 INFO - PROCESS | 9650 | __end_cc_report 21:28:59 INFO - PROCESS | 9650 | __startTimestamp1482038939692__endTimestamp 21:28:59 INFO - PROCESS | 9650 | 21:28:59 INFO - PROCESS | 9650 | ------- Summary: start ------- 21:28:59 INFO - PROCESS | 9650 | Number of tests: 14 21:28:59 INFO - PROCESS | 9650 | 21:28:59 INFO - PROCESS | 9650 | [#0] ai-astar Cycles:10 Average:115.90 Median:116.50 stddev:2.08 (1.8%) stddev-sans-first:1.24 21:28:59 INFO - PROCESS | 9650 | Values: 111.0 116.0 117.0 117.0 119.0 117.0 115.0 115.0 116.0 116.0 21:28:59 INFO - PROCESS | 9650 | 21:28:59 INFO - PROCESS | 9650 | [#1] audio-beat-detection Cycles:10 Average:136.30 Median:131.50 stddev:13.79 (10.5%) stddev-sans-first:13.96 21:28:59 INFO - PROCESS | 9650 | Values: 148.0 126.0 127.0 167.0 132.0 127.0 130.0 126.0 149.0 131.0 21:28:59 INFO - PROCESS | 9650 | 21:28:59 INFO - PROCESS | 9650 | [#2] audio-dft Cycles:10 Average:164.80 Median:165.00 stddev:1.99 (1.2%) stddev-sans-first:2.00 21:28:59 INFO - PROCESS | 9650 | Values: 163.0 167.0 167.0 168.0 164.0 165.0 162.0 164.0 163.0 165.0 21:28:59 INFO - PROCESS | 9650 | 21:28:59 INFO - PROCESS | 9650 | [#3] audio-fft Cycles:10 Average:82.00 Median:77.50 stddev:9.94 (12.8%) stddev-sans-first:10.44 21:28:59 INFO - PROCESS | 9650 | Values: 78.0 77.0 77.0 106.0 77.0 79.0 76.0 79.0 94.0 77.0 21:28:59 INFO - PROCESS | 9650 | 21:28:59 INFO - PROCESS | 9650 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:85.50 stddev:9.67 (11.3%) stddev-sans-first:9.99 21:28:59 INFO - PROCESS | 9650 | Values: 86.0 87.0 109.0 85.0 89.0 88.0 100.0 85.0 85.0 108.0 21:28:59 INFO - PROCESS | 9650 | 21:28:59 INFO - PROCESS | 9650 | [#5] imaging-gaussian-blur Cycles:10 Average:128.60 Median:129.00 stddev:1.07 (0.8%) stddev-sans-first:1.12 21:28:59 INFO - PROCESS | 9650 | Values: 128.0 128.0 128.0 129.0 131.0 129.0 127.0 128.0 129.0 129.0 21:28:59 INFO - PROCESS | 9650 | 21:28:59 INFO - PROCESS | 9650 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:1.32 (0.9%) stddev-sans-first:1.39 21:28:59 INFO - PROCESS | 9650 | Values: 149.0 149.0 150.0 149.0 147.0 148.0 148.0 150.0 151.0 147.0 21:28:59 INFO - PROCESS | 9650 | 21:28:59 INFO - PROCESS | 9650 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 21:28:59 INFO - PROCESS | 9650 | Values: 96.0 97.0 96.0 96.0 97.0 96.0 96.0 97.0 96.0 96.0 21:28:59 INFO - PROCESS | 9650 | 21:28:59 INFO - PROCESS | 9650 | [#8] json-parse-financial Cycles:10 Average:66.70 Median:67.00 stddev:1.83 (2.7%) stddev-sans-first:1.83 21:28:59 INFO - PROCESS | 9650 | Values: 65.0 68.0 66.0 65.0 67.0 67.0 71.0 66.0 67.0 65.0 21:28:59 INFO - PROCESS | 9650 | 21:28:59 INFO - PROCESS | 9650 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:1.52 (2.3%) stddev-sans-first:1.62 21:28:59 INFO - PROCESS | 9650 | Values: 67.0 66.0 67.0 67.0 70.0 65.0 66.0 66.0 69.0 68.0 21:28:59 INFO - PROCESS | 9650 | 21:28:59 INFO - PROCESS | 9650 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:86.50 stddev:2.50 (2.9%) stddev-sans-first:2.65 21:28:59 INFO - PROCESS | 9650 | Values: 87.0 86.0 92.0 89.0 85.0 84.0 85.0 84.0 85.0 87.0 21:28:59 INFO - PROCESS | 9650 | 21:28:59 INFO - PROCESS | 9650 | [#11] stanford-crypto-ccm Cycles:10 Average:145.40 Median:140.50 stddev:17.24 (12.3%) stddev-sans-first:18.17 21:28:59 INFO - PROCESS | 9650 | Values: 140.0 137.0 137.0 150.0 137.0 144.0 137.0 141.0 193.0 138.0 21:28:59 INFO - PROCESS | 9650 | 21:28:59 INFO - PROCESS | 9650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.20 Median:185.00 stddev:3.01 (1.6%) stddev-sans-first:3.09 21:28:59 INFO - PROCESS | 9650 | Values: 183.0 183.0 193.0 183.0 184.0 185.0 185.0 187.0 185.0 184.0 21:28:59 INFO - PROCESS | 9650 | 21:28:59 INFO - PROCESS | 9650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.00 stddev:2.17 (3.1%) stddev-sans-first:2.24 21:28:59 INFO - PROCESS | 9650 | Values: 70.0 71.0 71.0 77.0 71.0 73.0 71.0 70.0 70.0 70.0 21:28:59 INFO - PROCESS | 9650 | -------- Summary: end -------- 21:28:59 INFO - PROCESS | 9650 | 21:29:00 INFO - TEST-INFO | 9650: exit 0 21:29:00 INFO - TEST-OK | kraken | took 64367ms 21:29:00 INFO - SUITE-END | took 1184s 21:29:00 INFO - Completed test suite (00:19:44) 21:29:00 INFO - javascript benchmark 21:29:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6399.897487973152, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2649.721779213183, 2672.812903096784, 2690.3408664877106, 2690.7309269073085, 2709.2414124045276, 4718.0092180642105, 4849.80600775969, 4858.829940952068, 4896.510348965102, 4909.779059942302, 4739.715617062979, 4742.193827049401, 4807.423109226889, 4876.658633895629, 4888.242322440018, 4319.352097185416, 4348.369486424466, 4391.758453285068, 4429.114177164563, 4474.709143905636, 4379.868603941887, 4480.327950807388, 4495.9325610115875, 4507.729536227836, 4529.162105010567, 4313.266744653416, 4348.021695118605, 4496.145732310851, 4498.235299999008, 4541.409616749835, 4332.220200363933, 4361.149575832714, 4404.66964977628, 4422.5356337584735, 4499.0, 4344.522102568715, 4378.496472905625, 4408.823647054114, 4411.470623525165, 4428.335749637548, 4686.203345431285, 4786.688865223784, 4791.185498465235, 4801.375821143229, 4812.446568644581, 5070.0, 5084.669496482754, 5106.872328191825, 5116.51393117657, 5210.088234558975, 5114.0, 5170.741462926839, 5178.922316165261, 5179.119549676564, 5183.663061900965, 4826.227803551415, 4827.806887724451, 4833.830815921497, 4879.731614761222, 4880.267959806022, 5143.871403214875, 5171.198464238049, 5265.131253343156, 5265.341832270966, 5279.472052794767, 5070.6957582545165, 5083.262926875583, 5090.211017292326, 5111.258867464197, 5112.897742045138, 4982.2775697524385, 5010.799568017312, 5215.114808883281, 5233.450487698813, 5296.09966305729, 5101.846944591668, 5103.336566246364, 5124.205748109049, 5187.610929180327, 5216.843494695166, 5142.845714628567, 5148.639595228298, 5149.536541711189, 5152.072626927189, 5200.200772277496, 4347.847825326098, 4467.5755803198645, 4482.731036137842, 4494.617957473652, 4515.0, 3800.6579407852873, 3835.9041023974064, 3867.9806600966817, 3904.2386734586485, 4014.0968282136287, 4506.278995360726, 4535.274356103007, 4545.795439205243, 4547.954520454819, 4608.493065762764, 5294.9205761912835, 5306.602004849575, 5308.416074231909, 5318.946810531923, 5323.653962492425, 4355.4337936068105, 4388.539203383599, 4480.596746292849, 4494.842680506166, 4509.323601459741, 4761.214399624093, 4764.332993380929, 4765.26138448541, 4766.904661906742, 4808.759562021885, 4864.756762161877, 4865.0756356292195, 4881.4142302922455, 4887.242477416006, 4951.0, 5042.39491261051, 5092.108880945746, 5119.155339369111, 5130.153524668388, 5294.417614062373, 4754.952450475451, 4784.186688263073, 4788.688735232199, 4826.8793280168275, 4828.734419606955, 5060.671056381323, 5095.974520127524, 5100.974495127649, 5112.079825631274, 5130.4100028497205, 5037.168867136881, 5074.720890351066, 5076.695398276115, 5161.922571161511, 5216.608754343515, 4945.50544945517, 4960.751962401938, 4984.0, 5050.3434553507805, 5058.367704036996, 4994.126027945168, 5007.774650140679, 5014.749262536931, 5023.095842748195, 5031.270465782514, 4741.620670346433, 4792.0895029944195, 4808.639352048541, 4822.469528351949, 4884.462709102067, 4947.901041979212, 4953.851384458472, 4956.727379994135, 4968.776405061853, 4995.950040499549, 4879.048585525788, 4881.975590122027, 4891.9755401222765, 4911.778969946289, 4936.827211047596], "value": 4734.810006105959, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.69023050823745, 506.44797171083536, 508.4432546361737, 522.305333905905, 525.2252926932773, 36653.81673091634, 38930.41604375937, 39224.60775392245, 39271.60728392715, 39307.803460982694, 40046.0, 40490.797546012225, 40706.38940415896, 40771.59228407715, 40800.38799418011, 7590.96204518978, 7738.26486483786, 7746.961265193666, 7785.649645765926, 7787.844243115134, 9456.527173641325, 9734.464604446752, 9785.0, 10078.193744500459, 10082.89917100827, 9754.317197796157, 9785.0, 9805.705828825146, 9812.165965892907, 9825.90174098257, 9696.46669433181, 9747.074027967332, 9751.220902042955, 9792.853107203326, 9816.312858099936, 9585.0, 9608.0, 9650.71047868558, 9670.516474176333, 9673.516324183762, 33272.0, 33325.33349333024, 33474.6652533474, 33518.0, 33583.32833343344, 2880.164752221853, 3096.922576935572, 3451.5858097028517, 3469.340825243196, 3589.6589823966683, 25140.0, 25286.747132528624, 25690.100846470472, 25703.228903132935, 25934.74065259342, 3434.227298857762, 3460.8615655373756, 3532.1699400640828, 3647.2340808430263, 3656.597774244831, 245447.0, 246038.0, 247235.0, 247819.0, 248915.9999999982, 45265.321020184725, 45530.77234613806, 45608.543914561094, 45722.77138614286, 45777.771111144895, 48371.0, 48411.27383089256, 48619.75690121527, 48728.0, 48770.512294877306, 12863.356832158355, 13625.659358515919, 13648.863511364958, 13658.453661853613, 13675.452981880811, 9509.5720692569, 9790.167835734042, 10233.232507561814, 10414.427206503564, 10441.112505436971, 15062.397504099932, 15499.457518986781, 15541.0, 15576.376944922076, 15653.452129175652, 6332.746690132435, 6339.636978049649, 6435.485161187187, 6487.643179625072, 6547.443467305237, 745.9291367320096, 865.3639574912435, 866.1684782608767, 921.7695576105973, 968.8934217236099, 26022.0, 26675.733242667713, 27892.44215115686, 27897.0, 28331.29171770681, 876.1107475911955, 911.7219248129384, 947.8388673925449, 1035.7514196592915, 1037.7405648587853, 14649.926750366392, 14658.633534161518, 14757.483488077865, 14781.704365912621, 14917.328720207617, 328251.0, 332778.0, 335813.0, 336439.0, 336945.0, 48486.51513484891, 49129.38494533353, 49171.0, 49265.0, 49603.25595116076, 1136.1876258475395, 1164.0920082335792, 1174.0548858169086, 1177.8409914661581, 1179.504608064632, 25398.36504087339, 26669.733302666726, 26816.59775103336, 27628.447431051667, 27664.446711065262, 41532.37701434542, 41865.79067104645, 41868.0, 41889.58110418857, 41991.0, 284760.0, 286179.0, 286319.0, 286857.0, 287353.0, 22116.2259320923, 22795.658065128704, 23822.404439889142, 24293.63559546573, 24769.50460990806, 36849.63150368462, 37280.62719372771, 40932.795336023126, 41140.0, 41210.587894121876, 34876.47685284672, 35223.540351245596, 35251.82374088113, 35345.1163720909, 35738.463923040654, 34759.82620086883, 35229.47155792614, 35419.645803541636, 35738.64261357353, 35805.283894321445, 34102.658973410944, 34409.0, 34836.303273934886, 35032.649673502936, 35232.11919702028, 30346.241343966576, 32305.838470808434, 32857.835710821295, 32983.0, 33037.50443743394, 24832.751672483046, 25076.74923250744, 25158.74841251564, 25648.61527077058, 25659.87170064138], "value": 17178.012480145182, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.9267253876684, 363.55827669381705, 363.8290003698262, 370.0895796341001, 388.33594553313833, 15384.923075384622, 16317.755233671489, 17061.232244548977, 17077.40229091979, 17187.656246875085, 16347.4278400256, 16402.507924762278, 16599.17004149794, 16694.248758805854, 16840.494785156436, 4743.8102475901005, 4982.202847544376, 4995.825146119886, 5025.773840177182, 5030.849074527751, 3646.0, 3830.1190726133004, 4882.853514394574, 5561.165825126243, 5901.3508514063415, 5855.47300742933, 5940.851478713045, 5948.58359914804, 5950.880982380371, 5962.433568810956, 5723.942760572403, 5786.392428794979, 5823.213866128103, 5841.211436456067, 5848.976429124908, 5071.1632580624155, 5129.538341549279, 5137.537621614073, 5147.562457191143, 5155.0, 19629.607407851763, 19870.304539341054, 20128.39614811558, 20170.79829201704, 20763.896180519, 1896.8900517333711, 1902.6289873474677, 1928.006463260163, 2030.604032213719, 2545.071049067096, 12403.503859845596, 12856.871431285661, 13123.868761312455, 13783.931080344533, 13802.0, 1714.2457318779698, 1796.7664203653442, 1798.5323815807853, 1813.918373673188, 1871.3543827379533, 55510.0, 57385.13922291169, 67389.0, 68116.0, 68960.0, 15005.774913376308, 16118.919405403132, 16167.514974550782, 16436.6712665746, 16510.75233871493, 27214.958878083828, 27232.455350892873, 27314.726852731616, 27562.5865612016, 27642.447151056866, 8449.197326253996, 8710.303175745925, 8730.388872778845, 9109.681161159328, 9198.63205471787, 7267.709291628275, 7268.454865884974, 7308.634568271672, 7403.837642731365, 7543.849123017619, 7642.69429222836, 8098.676052957933, 8125.431219814556, 8136.959315203386, 8213.34293256538, 1510.7129645367345, 1606.2049285603468, 1634.3544300001433, 3105.627324721048, 3196.6803319667847, 775.4533054196778, 802.7557286206356, 811.3144392987916, 825.2820046559532, 900.6397441023512, 15763.763543546856, 16176.43382481631, 16208.918955405383, 16337.101459419846, 16558.172091395383, 822.3955392786297, 832.3632421197789, 833.8749187621784, 887.2990337633197, 904.9140331668481, 8990.820183596423, 9208.447493150432, 9421.38760980534, 9557.283203759607, 9613.615455381847, 327375.0, 328721.0, 353428.0, 353676.0, 355172.0, 72596.27403726001, 78692.0, 79214.0, 80107.0, 80473.0, 886.636479043589, 891.3671293381772, 942.9486122972972, 943.0522325063267, 946.7159852044497, 15132.394704212149, 15216.163111029, 15607.219639017776, 15684.607884802972, 15938.123403212934, 27513.724862751118, 30159.547606786353, 33418.16454588558, 35316.64683353133, 35418.11454713653, 46566.767166163954, 46650.53349466598, 47051.29423058588, 48610.75694621504, 49143.26285105655, 7356.96321518389, 7471.290227428603, 7581.0, 7709.7301594443925, 7921.9207807923485, 10021.549030293509, 11067.667969960914, 11226.270292430965, 11301.773964520828, 11653.59212427561, 9719.805603888024, 9738.75653108678, 10102.191824654157, 10107.444090575089, 10599.62901298451, 10099.596016159272, 10438.895611044096, 10631.255812093079, 10662.200334975063, 10840.67477975662, 10510.369377837354, 10702.464876756287, 10744.140468762636, 10791.56833726642, 11223.887761122285, 6658.1344425224415, 7730.536167829948, 7789.5715735635085, 7816.179301173295, 7973.8405231896195, 8373.539455330016, 10011.949940250252, 10040.397576145455, 10057.949710251401, 10442.947785261025], "value": 8678.768123579726, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.7014921642628, 1334.8998825088117, 1432.9211893345862, 1608.7828143200663, 1665.2090257127866, 6398.264199617045, 6675.732970681167, 6679.131712877325, 7106.2183159852375, 7114.573125612467, 6854.3145685431555, 7133.464990125735, 7134.964325178367, 7247.565146091225, 7266.091738532684, 2107.4309936317222, 2144.3888491779844, 2144.5818065477238, 2145.774693657167, 2146.8175205107586, 2078.1168003598486, 2149.118861266873, 2177.1291483406685, 2180.1715348167672, 2182.3234797212913, 2097.5070858348276, 2107.262458139654, 2119.904604292803, 2130.4886827161527, 2145.0668959002883, 2074.2429013410147, 2103.3584756649293, 2114.0381126587367, 2114.4713821544615, 2115.037657865683, 2033.857629965903, 2062.154516648182, 2095.6018356512213, 2107.1782005017903, 2107.4942013916702, 7248.782536523912, 7277.636118194122, 7315.707371705125, 7325.670344834495, 7343.485955983083, 4296.355546667994, 4408.559144085598, 4426.601605855489, 4461.955380446187, 4468.642508599337, 2666.813323067386, 2805.9438811223868, 2864.1693908766433, 2917.6352955880516, 2941.8381988990595, 833.8624127019095, 852.8848605438249, 877.1228771228771, 891.6611687558751, 894.7494701483595, 9445.622175112987, 9448.196903263162, 9488.33581649278, 9508.429494230368, 9574.425534467884, 3817.351050321452, 3956.643902048829, 3971.4837071180564, 4005.839766409369, 4183.686223533247, 8368.41421100517, 8398.0, 8414.15858414166, 8421.957890210631, 8442.0, 4489.057297967398, 4513.232750432434, 4517.435320584927, 4518.796654150571, 4535.63714902807, 3587.390143675529, 3703.685186759156, 3930.1157239620857, 3969.6625786807867, 4111.465509483748, 3353.279045005336, 3460.480927860841, 3477.565304336958, 3525.11872031992, 3527.294541091792, 1098.357460885375, 1104.0725790336155, 1104.8950349716763, 1138.1975707126455, 1140.0366690146814, 657.5101549345768, 688.2532452289322, 716.1656669979519, 834.2658460554673, 857.9013413457533, 4739.905201896012, 4829.830955916526, 4945.826896058693, 5212.139996900469, 5267.707682698314, 825.1253671108644, 869.517417833096, 904.8099899021279, 920.7283851263893, 938.5072836760755, 3567.6967457765863, 3750.83121259544, 3758.962410375861, 3771.735978481535, 3776.2825063238447, 8602.397832151815, 8638.481691098554, 8742.0, 8764.737057888273, 8784.692535761218, 8646.956765216133, 8672.0, 8702.608382622797, 8704.0, 8722.433041852386, 6725.66371681414, 6758.526903116833, 6795.93204067953, 6821.931780682229, 6960.965195174093, 4842.58837998774, 4914.8771280718265, 4947.2579113133315, 5310.070737620824, 5383.16560933056, 8102.594870256581, 8104.108548059827, 8105.148959359418, 8232.135625759209, 8239.794005149919, 7979.9601001994615, 8119.512829230265, 8186.0, 8220.917790822015, 8242.876356854533, 5801.883962320814, 5867.911981320198, 6427.742890284337, 6587.736490540325, 6670.466362690876, 6630.9668451657435, 6907.378335949587, 6912.170539535288, 7064.399526040344, 7077.221505634479, 6384.07430922523, 6439.388258115471, 6542.34576542361, 6637.103990961158, 6746.595204287759, 6345.58093346574, 6425.518086143651, 6478.935210647834, 6480.351964803482, 6560.147180866456, 5659.943400566106, 5752.453516915886, 5755.280589926259, 5757.769689212552, 5760.510356619734, 4356.629686476685, 4408.7575183365225, 4423.469183697976, 4456.799444025091, 4496.550344965477, 4332.761698106634, 4451.510333863208, 4487.730736155841, 4653.790579423866, 4707.317438971261], "value": 3925.399402365076, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.85516083245034, 351.41840254378997, 353.8354665080737, 356.68789808917205, 359.0216659602585, 4888.924436623942, 4959.677016399012, 4967.478414766442, 4979.9293151972315, 4994.825181118662, 4902.852914412564, 4915.557599816016, 4933.210686290195, 4972.154733695272, 4979.950200497994, 3732.9626703732956, 3838.865639702611, 3839.5217841131225, 3914.4324073009398, 3951.4467974483596, 3933.311670457673, 3945.7040721945827, 3945.782981935992, 3957.4657421248194, 3976.6421022108007, 3944.704147188958, 3945.7237993340477, 3946.7370441458743, 3956.9208615827665, 3961.504811898513, 3573.4282514797505, 3770.1517158639363, 3943.6253555912144, 3956.4876303547167, 3957.1294315250598, 3326.2848487575047, 3332.583876689405, 3335.5830521184853, 3336.616289126733, 3355.9161020974425, 4780.402449693788, 4793.424789025305, 4813.807447702123, 4813.809716578949, 4817.855464336076, 4349.26062569364, 4368.934465983013, 4375.365571992043, 4378.1462614790125, 4391.27543955247, 5045.268436076785, 5183.922241166386, 5195.818146364859, 5205.375354957391, 5239.449857764918, 3654.3239500692457, 3655.798931058791, 3656.3053019926397, 3676.191237927652, 3680.834362453696, 5369.288509302816, 5375.274337964363, 5409.29607173743, 5409.756560954766, 5449.482299181572, 3584.408572585546, 3697.205100903319, 3703.6481534254203, 3732.4774531565604, 3736.8878933632036, 3758.1919887224376, 3758.248350329945, 3770.981145094257, 3782.394816829294, 3782.8486860525823, 4286.721363111388, 4293.506246781598, 4294.0, 4295.957040429618, 4330.39374487572, 5077.0, 5164.657189130853, 5208.348956380452, 5213.374395072616, 5238.345206849144, 1268.898488120948, 1279.3027799849106, 1281.9038572107129, 1286.601153642355, 1292.6445227562494, 845.4969293270494, 873.2969959182918, 883.5670521444446, 887.9467231966103, 888.7022847346211, 4391.560843915583, 4465.888352791206, 4517.774111294422, 4589.1051245007575, 4603.378543896598, 5360.177539636465, 5370.865728356823, 5380.91928621071, 5399.947010332948, 5418.509909774843, 4591.311303304531, 4596.034832685106, 4600.562946520142, 4608.446986361591, 4611.884702882455, 2645.9867700661375, 2761.558150695879, 2770.891643342639, 2788.3029242689327, 2795.853699983038, 4888.9755551222015, 4905.288733133676, 4905.3623029006, 4915.680480768739, 4923.975380123076, 5218.739063046833, 5267.552258058031, 5368.4631536846, 5388.676679399248, 5400.324959380077, 4828.082664293773, 4893.580861550111, 4903.705777653352, 4913.950860491349, 4932.90134197314, 5174.327337446108, 5260.421353651019, 5265.368155821326, 5288.709120998382, 5312.309399778004, 5019.749012549285, 5092.337996060489, 5127.974360128324, 5161.045206636784, 5311.814086507108, 5009.668570400643, 5018.0608222545125, 5023.246513023076, 5024.271480635361, 5038.035166285225, 3773.3773927302786, 3784.508013958168, 3787.5833658298116, 3792.886213413602, 3821.5605205401735, 5133.717645529382, 5369.704666243238, 5443.292371991616, 5472.562195024469, 5478.260434841245, 5209.270702101633, 5209.921851172159, 5217.373915130209, 5232.424433312256, 5243.501867322599, 5223.902980374164, 5243.475652434726, 5253.921191182212, 5260.0, 5272.604554658493, 4917.852464426073, 5099.490050994871, 5121.389420458642, 5153.2270159476375, 5177.559907407913, 5034.942662041012, 5123.436421993652, 5155.226715992631, 5237.816676416307, 5263.289455923555, 5116.904272914833, 5137.433082909748, 5141.974290128525, 5159.948400515947, 5163.173892177234], "value": 3907.369230852794, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [614.4101662404092, 646.4182235987611, 655.6066360183887, 684.3898435751411, 707.6461769115442, 12045.036397088234, 12474.875251247484, 13245.602631921058, 14224.644383890409, 14231.573052808406, 12341.814872776915, 12363.196392234498, 12429.2542447453, 12605.936970315159, 12636.11547191697, 761.4137114421906, 771.4985259581262, 777.8910952466659, 781.183663072091, 782.5774081995716, 755.5806527377304, 766.0233202666617, 787.3661702329651, 789.8973133492667, 790.8062524681461, 818.8567000774871, 821.2362502872327, 821.9506829590243, 822.0874828939872, 827.4952279109739, 817.2685446525356, 818.2594751749676, 818.443458448255, 818.4966245758875, 819.3608984991716, 603.0170821560828, 606.5753972219464, 607.5777334752349, 607.6688204928281, 608.46455119495, 13056.955443564588, 13222.404991775296, 13228.404721787543, 13301.334933253396, 13887.097338673055, 12774.361281935959, 12838.0, 13199.604011879659, 13318.86681133186, 13422.664433389244, 9919.454430006346, 10001.849972250422, 10005.899941000569, 10110.443925584164, 10136.290459667825, 3185.394774992767, 3190.6490286068515, 3199.856006479714, 3211.8394080296125, 3274.67253274673, 64503.67748161229, 64530.354696453374, 65765.3423465764, 67318.0, 67430.66284668594, 9680.128788408936, 9738.561764720605, 9743.805123897482, 10005.19958403326, 10133.341332813343, 16747.91626041862, 17327.91336043312, 17545.0, 18598.907005465157, 18961.715574266396, 6750.966245168841, 6838.93161068383, 6894.345037221456, 6929.965350173217, 6932.37608615217, 3686.4101743720876, 3719.7210209234418, 3733.7199710021855, 3776.4524143998965, 3778.4521244419407, 2767.045369347572, 2785.8885644574393, 2845.1891211004763, 2854.2293580733085, 2859.242300790292, 507.6015327967528, 507.9263506791568, 509.42435048395697, 527.0171130840954, 527.5621234375459, 571.8255931940715, 607.9907353792682, 622.9501639868799, 623.7847942459844, 653.4315145823165, 8328.541930193898, 8337.650950540039, 8619.827603447897, 8672.392932494664, 8760.211580957744, 618.5299172628835, 647.6211416321411, 647.6276141218818, 649.7563413719855, 651.3226244705548, 3960.128771670228, 4031.294523458383, 4034.7377420467574, 4127.626614696562, 4205.684573656988, 61613.0, 63288.0, 65028.67485662542, 65723.67138164278, 67252.663736681, 48764.51235487671, 53711.462885370645, 56447.0, 56723.43276567264, 58800.7059964706, 46057.30914036292, 46109.0, 47104.0, 50692.999999999265, 52849.735751321, 8402.705905293285, 8649.117299729545, 8789.428687135316, 8897.28821694276, 8984.685536006209, 37701.62298376981, 38319.23361532809, 38404.0, 38599.0, 39383.0, 45156.0, 50020.0, 50853.49146508487, 51150.74424627853, 51986.740066299426, 11679.124065694938, 11814.291142531476, 12122.15144939881, 12142.817857731965, 12488.687782805502, 12870.292133932724, 12936.741265174833, 13111.475540978254, 13166.341682916007, 13354.332283385598, 12059.57791477294, 12153.45309461094, 12718.809217861924, 12727.80908286358, 12761.87238127644, 11917.16579839403, 11938.58214962472, 12251.203671761306, 12597.68505787326, 13058.412371443117, 12246.142770006014, 12413.131080824616, 12426.24780736742, 12642.87357126417, 12735.426905789447, 8534.871976920474, 9175.908240917772, 9388.287374527246, 9447.763805904908, 9571.234301256021, 10285.43430111351, 10501.107405870587, 10507.264491485523, 10522.789544209227, 10523.894761052292], "value": 6345.796617799708, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1587.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 117.0, 117.0, 119.0, 117.0, 115.0, 115.0, 116.0, 116.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 126.0, 127.0, 167.0, 132.0, 127.0, 130.0, 126.0, 149.0, 131.0], "value": 136.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 167.0, 167.0, 168.0, 164.0, 165.0, 162.0, 164.0, 163.0, 165.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 106.0, 77.0, 79.0, 76.0, 79.0, 94.0, 77.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 109.0, 85.0, 89.0, 88.0, 100.0, 85.0, 85.0, 108.0], "value": 92.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 128.0, 128.0, 129.0, 131.0, 129.0, 127.0, 128.0, 129.0, 129.0], "value": 128.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 150.0, 149.0, 147.0, 148.0, 148.0, 150.0, 151.0, 147.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 66.0, 65.0, 67.0, 67.0, 71.0, 66.0, 67.0, 65.0], "value": 66.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 67.0, 70.0, 65.0, 66.0, 66.0, 69.0, 68.0], "value": 67.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 92.0, 89.0, 85.0, 84.0, 85.0, 84.0, 85.0, 87.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 137.0, 137.0, 150.0, 137.0, 144.0, 137.0, 141.0, 193.0, 138.0], "value": 145.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 193.0, 183.0, 184.0, 185.0, 185.0, 187.0, 185.0, 184.0], "value": 185.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 71.0, 77.0, 71.0, 73.0, 71.0, 70.0, 70.0, 70.0], "value": 71.4, "unit": "score"}]}]} 21:29:00 INFO - Return code: 0 21:29:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:29:00 ERROR - # TBPL SUCCESS # 21:29:00 INFO - Running post-action listener: _resource_record_post_action 21:29:00 INFO - [mozharness: 2016-12-18 05:29:00.992693Z] Finished run-tests step (success) 21:29:00 INFO - Running post-run listener: _resource_record_post_run 21:29:01 INFO - Total resource usage - Wall time: 1201s; CPU: 14.0%; Read bytes: 0; Write bytes: 296968192; Read time: 0; Write time: 199452 21:29:01 INFO - TinderboxPrint: CPU usage
13.5% 21:29:01 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 21:29:01 INFO - TinderboxPrint: I/O write bytes / time
296,968,192 / 199,452 21:29:01 INFO - TinderboxPrint: CPU idle
8,285.5 (86.5%) 21:29:01 INFO - TinderboxPrint: CPU user
1,237.9 (12.9%) 21:29:01 INFO - TinderboxPrint: Swap in / out
0 / 0 21:29:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 15581184; Read time: 0; Write time: 4628 21:29:01 INFO - run-tests - Wall time: 1185s; CPU: 14.0%; Read bytes: 0; Write bytes: 281387008; Read time: 0; Write time: 194824 21:29:01 INFO - Running post-run listener: _upload_blobber_files 21:29:01 INFO - Blob upload gear active. 21:29:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:29:01 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 21:29:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:29:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:29:02 INFO - (blobuploader) - INFO - Open directory for files ... 21:29:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:29:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:29:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:29:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:29:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:29:02 INFO - (blobuploader) - INFO - Done attempting. 21:29:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:29:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:29:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:29:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:29:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:29:06 INFO - (blobuploader) - INFO - Done attempting. 21:29:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:29:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:29:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:29:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:29:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:29:07 INFO - (blobuploader) - INFO - Done attempting. 21:29:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:29:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:29:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:29:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:29:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:29:08 INFO - (blobuploader) - INFO - Done attempting. 21:29:08 INFO - (blobuploader) - INFO - Iteration through files over. 21:29:08 INFO - Return code: 0 21:29:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:29:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:29:08 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31d7eb0ed1820a442b4c6c785e5fb1563178a187ac96124fb656b0a9a92cb6356d444394a139bc35a49131f20da0a7963d5f175d35cb39a17446beece41327bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/240c2aaca76ee4d0ea96f9bbcfe821e0f774243ac397a533577d4756409adfe84cae1aa3616d90fa3b1445e12b172941ce4e7974aca12020a522acf0eb91d2f1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dedd4f30344da52aa901e7a493d377c6dc7e0434ff027dec3a64a5ac295bda12c187555a4a333b283473cbead4f7e92e5f54f0c493fc18cedbdd2f33b701e15d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98b645de393b32cc768deb716b7a9f3e207433f1beaa698c7f601fd976835511d1e3a6d56733cf174b174bcb7413af1a96be1b5aef12f3c063b99e289d45468a"} 21:29:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:29:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:29:08 INFO - Contents: 21:29:08 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31d7eb0ed1820a442b4c6c785e5fb1563178a187ac96124fb656b0a9a92cb6356d444394a139bc35a49131f20da0a7963d5f175d35cb39a17446beece41327bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/240c2aaca76ee4d0ea96f9bbcfe821e0f774243ac397a533577d4756409adfe84cae1aa3616d90fa3b1445e12b172941ce4e7974aca12020a522acf0eb91d2f1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dedd4f30344da52aa901e7a493d377c6dc7e0434ff027dec3a64a5ac295bda12c187555a4a333b283473cbead4f7e92e5f54f0c493fc18cedbdd2f33b701e15d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98b645de393b32cc768deb716b7a9f3e207433f1beaa698c7f601fd976835511d1e3a6d56733cf174b174bcb7413af1a96be1b5aef12f3c063b99e289d45468a"} 21:29:08 INFO - Running post-run listener: copy_logs_to_upload_dir 21:29:08 INFO - Copying logs to upload dir... 21:29:08 INFO - mkdir: /builds/slave/test/build/upload/logs 21:29:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1307.365573 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 47 secs) (at 2016-12-17 21:29:07.737935) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-17 21:29:07.740867) ========= 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=20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392 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-Non-PGO/sha512/31d7eb0ed1820a442b4c6c785e5fb1563178a187ac96124fb656b0a9a92cb6356d444394a139bc35a49131f20da0a7963d5f175d35cb39a17446beece41327bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/240c2aaca76ee4d0ea96f9bbcfe821e0f774243ac397a533577d4756409adfe84cae1aa3616d90fa3b1445e12b172941ce4e7974aca12020a522acf0eb91d2f1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dedd4f30344da52aa901e7a493d377c6dc7e0434ff027dec3a64a5ac295bda12c187555a4a333b283473cbead4f7e92e5f54f0c493fc18cedbdd2f33b701e15d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98b645de393b32cc768deb716b7a9f3e207433f1beaa698c7f601fd976835511d1e3a6d56733cf174b174bcb7413af1a96be1b5aef12f3c063b99e289d45468a"} build_url:https://queue.taskcluster.net/v1/task/CtcQ4nFARQ2idasUo0jCOw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011482 build_url: 'https://queue.taskcluster.net/v1/task/CtcQ4nFARQ2idasUo0jCOw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31d7eb0ed1820a442b4c6c785e5fb1563178a187ac96124fb656b0a9a92cb6356d444394a139bc35a49131f20da0a7963d5f175d35cb39a17446beece41327bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/240c2aaca76ee4d0ea96f9bbcfe821e0f774243ac397a533577d4756409adfe84cae1aa3616d90fa3b1445e12b172941ce4e7974aca12020a522acf0eb91d2f1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dedd4f30344da52aa901e7a493d377c6dc7e0434ff027dec3a64a5ac295bda12c187555a4a333b283473cbead4f7e92e5f54f0c493fc18cedbdd2f33b701e15d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98b645de393b32cc768deb716b7a9f3e207433f1beaa698c7f601fd976835511d1e3a6d56733cf174b174bcb7413af1a96be1b5aef12f3c063b99e289d45468a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-17 21:29:07.765245) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 21:29:07.765534) ========= 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=20e666a3d4cfbb71505a330e000001b4-1482037301.243511-709572392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004774 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 21:29:07.850125) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-17 21:29:07.850412) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-17 21:29:07.850681) ========= ========= Total master_lag: 0.18 =========