builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-001 starttime: 1493845062.31 results: success (0) revision: 96605941c0021795376d9c6ec1e458de2fac329e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-03 13:57:42.309507) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-03 13:57:42.310016) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-03 13:57:42.310298) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-03 13:57:42.325443) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 13:57:42.325853) ========= 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=8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-03 13:57:42-- 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% 37.5M=0s 2017-05-03 13:57:42 (37.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122169 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 13:57:42.462560) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 13:57:42.462876) ========= 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=8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016318 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 13:57:42.512817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-03 13:57:42.513215) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 96605941c0021795376d9c6ec1e458de2fac329e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 96605941c0021795376d9c6ec1e458de2fac329e --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=8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-03 13:57:42,630 truncating revision to first 12 chars 2017-05-03 13:57:42,630 Setting DEBUG logging. 2017-05-03 13:57:42,630 attempt 1/10 2017-05-03 13:57:42,630 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/96605941c002?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-03 13:57:43,662 unpacking tar archive at: mozilla-central-96605941c002/testing/mozharness/ program finished with exit code 0 elapsedTime=1.401457 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-03 13:57:43.928825) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-03 13:57:43.929154) ========= script_repo_revision: 96605941c0021795376d9c6ec1e458de2fac329e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-03 13:57:43.929546) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-03 13:57:43.929815) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-03 13:57:43.940902) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-05-03 13:57:43.941238) ========= /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=8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:57:44 INFO - MultiFileLogger online at 20170503 13:57:44 in /builds/slave/test 13:57:44 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 13:57:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:57:44 INFO - {'append_to_log': False, 13:57:44 INFO - 'base_work_dir': '/builds/slave/test', 13:57:44 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 13:57:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:57:44 INFO - 'branch': 'Firefox-Non-PGO', 13:57:44 INFO - 'buildbot_json_path': 'buildprops.json', 13:57:44 INFO - 'config_files': ('talos/linux_config.py',), 13:57:44 INFO - 'default_actions': ('clobber', 13:57:44 INFO - 'read-buildbot-config', 13:57:44 INFO - 'download-and-extract', 13:57:44 INFO - 'populate-webroot', 13:57:44 INFO - 'create-virtualenv', 13:57:44 INFO - 'install', 13:57:44 INFO - 'run-tests'), 13:57:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:57:44 INFO - 'download_minidump_stackwalk': True, 13:57:44 INFO - 'download_symbols': 'ondemand', 13:57:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:57:44 INFO - 'tooltool.py': '/tools/tooltool.py', 13:57:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:57:44 INFO - '/tools/misc-python/virtualenv.py')}, 13:57:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:57:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:57:44 INFO - 'gecko_profile': False, 13:57:44 INFO - 'gecko_profile_interval': 0, 13:57:44 INFO - 'installer_path': 'installer.exe', 13:57:44 INFO - 'log_level': 'info', 13:57:44 INFO - 'log_name': 'talos', 13:57:44 INFO - 'log_to_console': True, 13:57:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:57:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:57:44 INFO - 'opt_config_files': (), 13:57:44 INFO - 'pip_index': False, 13:57:44 INFO - 'suite': 'dromaeojs-e10s', 13:57:44 INFO - 'system_bits': '32', 13:57:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:57:44 INFO - 'title': 'talos-linux64-ix-001', 13:57:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:57:44 INFO - 'use_talos_json': True, 13:57:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:57:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:57:44 INFO - 'work_dir': 'build'} 13:57:44 INFO - [mozharness: 2017-05-03 20:57:44.157096Z] Running clobber step. 13:57:44 INFO - Running pre-action listener: _resource_record_pre_action 13:57:44 INFO - Running main action method: clobber 13:57:44 INFO - rmtree: /builds/slave/test/build 13:57:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:57:45 INFO - Running post-action listener: _resource_record_post_action 13:57:45 INFO - [mozharness: 2017-05-03 20:57:45.086890Z] Finished clobber step (success) 13:57:45 INFO - [mozharness: 2017-05-03 20:57:45.086990Z] Running read-buildbot-config step. 13:57:45 INFO - Running pre-action listener: _resource_record_pre_action 13:57:45 INFO - Running main action method: read_buildbot_config 13:57:45 INFO - Using buildbot properties: 13:57:45 INFO - { 13:57:45 INFO - "project": "", 13:57:45 INFO - "product": "firefox", 13:57:45 INFO - "who": "kwierso@gmail.com", 13:57:45 INFO - "installer_path": "public/build/target.tar.bz2", 13:57:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 13:57:45 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 13:57:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 13:57:45 INFO - "stage_platform": "linux64", 13:57:45 INFO - "basedir": "/builds/slave/test", 13:57:45 INFO - "buildnumber": 848, 13:57:45 INFO - "platform": "ubuntu64_hw", 13:57:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:57:45 INFO - "slavebuilddir": "test", 13:57:45 INFO - "taskId": "WFZ-j4ceQe6B31_PY87Dxg", 13:57:45 INFO - "branch": "mozilla-central", 13:57:45 INFO - "script_repo_revision": "production", 13:57:45 INFO - "revision": "96605941c0021795376d9c6ec1e458de2fac329e", 13:57:45 INFO - "slavename": "talos-linux64-ix-001", 13:57:45 INFO - "repo_path": "mozilla-central" 13:57:45 INFO - } 13:57:45 INFO - Finding installer, test and symbols from parent task. 13:57:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WFZ-j4ceQe6B31_PY87Dxg'}, attempt #1 13:57:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WFZ-j4ceQe6B31_PY87Dxg'}, attempt #1 13:57:46 INFO - Task dependencies: MzyTuWZaSjquOpKDjW7FAw 13:57:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MzyTuWZaSjquOpKDjW7FAw'}, attempt #1 13:57:46 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MzyTuWZaSjquOpKDjW7FAw/artifacts/public/build/target.tar.bz2 13:57:46 INFO - Set test_url: https://queue.taskcluster.net/v1/task/MzyTuWZaSjquOpKDjW7FAw/artifacts/public/build/test_packages.json 13:57:46 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MzyTuWZaSjquOpKDjW7FAw/artifacts/public/build/target.crashreporter-symbols.zip 13:57:46 INFO - Running post-action listener: _resource_record_post_action 13:57:46 INFO - [mozharness: 2017-05-03 20:57:46.472449Z] Finished read-buildbot-config step (success) 13:57:46 INFO - [mozharness: 2017-05-03 20:57:46.472665Z] Running download-and-extract step. 13:57:46 INFO - Running pre-action listener: _resource_record_pre_action 13:57:46 INFO - Running main action method: download_and_extract 13:57:46 INFO - mkdir: /builds/slave/test/build/tests 13:57:46 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')]} 13:57:46 INFO - trying https://queue.taskcluster.net/v1/task/MzyTuWZaSjquOpKDjW7FAw/artifacts/public/build/target.test_packages.json 13:57:46 INFO - Downloading https://queue.taskcluster.net/v1/task/MzyTuWZaSjquOpKDjW7FAw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:57:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MzyTuWZaSjquOpKDjW7FAw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:57:47 INFO - Downloaded 986 bytes. 13:57:47 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:57:47 INFO - Using the following test package requirements: 13:57:47 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:57:47 INFO - u'common': [u'target.common.tests.zip'], 13:57:47 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:57:47 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:57:47 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:57:47 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:57:47 INFO - u'mozbase': [u'target.common.tests.zip'], 13:57:47 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:57:47 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:57:47 INFO - u'web-platform': [u'target.common.tests.zip', 13:57:47 INFO - u'target.web-platform.tests.zip'], 13:57:47 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:57:47 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 13:57:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MzyTuWZaSjquOpKDjW7FAw/artifacts/public/build/target.common.tests.zip 13:57:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MzyTuWZaSjquOpKDjW7FAw/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:57:47 INFO - Fetch https://queue.taskcluster.net/v1/task/MzyTuWZaSjquOpKDjW7FAw/artifacts/public/build/target.common.tests.zip into memory 13:57:48 INFO - Content-Length response header: 58435883 13:57:48 INFO - Bytes received: 58435883 13:57:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 13:57:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MzyTuWZaSjquOpKDjW7FAw/artifacts/public/build/target.common.tests.zip 13:57:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MzyTuWZaSjquOpKDjW7FAw/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:57:58 INFO - Fetch https://queue.taskcluster.net/v1/task/MzyTuWZaSjquOpKDjW7FAw/artifacts/public/build/target.common.tests.zip into memory 13:57:59 INFO - Content-Length response header: 58435883 13:57:59 INFO - Bytes received: 58435883 13:58:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MzyTuWZaSjquOpKDjW7FAw/artifacts/public/build/target.talos.tests.zip 13:58:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MzyTuWZaSjquOpKDjW7FAw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:58:09 INFO - Fetch https://queue.taskcluster.net/v1/task/MzyTuWZaSjquOpKDjW7FAw/artifacts/public/build/target.talos.tests.zip into memory 13:58:10 INFO - Content-Length response header: 14408809 13:58:10 INFO - Bytes received: 14408809 13:58:10 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')]} 13:58:10 INFO - trying https://queue.taskcluster.net/v1/task/MzyTuWZaSjquOpKDjW7FAw/artifacts/public/build/target.tar.bz2 13:58:10 INFO - Downloading https://queue.taskcluster.net/v1/task/MzyTuWZaSjquOpKDjW7FAw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:58:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MzyTuWZaSjquOpKDjW7FAw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:58:11 INFO - Downloaded 58475718 bytes. 13:58:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MzyTuWZaSjquOpKDjW7FAw/artifacts/public/build/target.tar.bz2 13:58:11 INFO - mkdir: /builds/slave/test/properties 13:58:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:58:11 INFO - Writing to file /builds/slave/test/properties/build_url 13:58:11 INFO - Contents: 13:58:11 INFO - build_url:https://queue.taskcluster.net/v1/task/MzyTuWZaSjquOpKDjW7FAw/artifacts/public/build/target.tar.bz2 13:58:11 INFO - Running post-action listener: _resource_record_post_action 13:58:11 INFO - Running post-action listener: set_extra_try_arguments 13:58:11 INFO - [mozharness: 2017-05-03 20:58:11.944913Z] Finished download-and-extract step (success) 13:58:11 INFO - [mozharness: 2017-05-03 20:58:11.945010Z] Running populate-webroot step. 13:58:11 INFO - Running pre-action listener: _resource_record_pre_action 13:58:11 INFO - Running main action method: populate_webroot 13:58:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:58:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:58:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:58:11 INFO - '--tppagecycles', 13:58:11 INFO - '7'], 13:58:11 INFO - 'tests': ['tsvgm']}}, 13:58:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:58:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:58:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:58:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:58:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:58:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:58:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:58:11 INFO - 'talos_options': ['--disable-e10s'], 13:58:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:58:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:58:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:58:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:58:11 INFO - 'talos_options': ['--disable-e10s'], 13:58:11 INFO - 'tests': ['damp', 'tps']}, 13:58:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:58:11 INFO - 'tests': ['damp', 'tps']}, 13:58:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:58:11 INFO - 'tests': ['dromaeo_dom']}, 13:58:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:58:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:58:11 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 13:58:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:58:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:58:11 INFO - 'tests': ['a11yr', 13:58:11 INFO - 'ts_paint', 13:58:11 INFO - 'tpaint', 13:58:11 INFO - 'sessionrestore', 13:58:11 INFO - 'sessionrestore_no_auto_restore', 13:58:11 INFO - 'tabpaint']}, 13:58:11 INFO - 'other-e10s': {'tests': ['a11yr', 13:58:11 INFO - 'ts_paint', 13:58:11 INFO - 'tpaint', 13:58:11 INFO - 'sessionrestore', 13:58:11 INFO - 'sessionrestore_no_auto_restore', 13:58:11 INFO - 'tabpaint']}, 13:58:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:58:11 INFO - 'ts_paint', 13:58:11 INFO - 'tpaint', 13:58:11 INFO - 'sessionrestore', 13:58:11 INFO - 'sessionrestore_no_auto_restore', 13:58:11 INFO - 'tabpaint']}, 13:58:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:58:11 INFO - 'ts_paint', 13:58:11 INFO - 'tpaint', 13:58:11 INFO - 'sessionrestore', 13:58:11 INFO - 'sessionrestore_no_auto_restore', 13:58:11 INFO - 'tabpaint']}, 13:58:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:58:11 INFO - 'tests': ['a11yr', 13:58:11 INFO - 'ts_paint', 13:58:11 INFO - 'tpaint', 13:58:11 INFO - 'sessionrestore', 13:58:11 INFO - 'sessionrestore_no_auto_restore', 13:58:11 INFO - 'tabpaint']}, 13:58:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:58:11 INFO - 'tests': ['a11yr', 13:58:11 INFO - 'ts_paint', 13:58:11 INFO - 'tpaint', 13:58:11 INFO - 'sessionrestore', 13:58:11 INFO - 'sessionrestore_no_auto_restore', 13:58:11 INFO - 'tabpaint']}, 13:58:11 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 13:58:11 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 13:58:11 INFO - 'bloom_basic_ref']}, 13:58:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:58:11 INFO - 'tests': ['tsvgx', 13:58:11 INFO - 'tsvgr_opacity', 13:58:11 INFO - 'tart', 13:58:11 INFO - 'tscrollx', 13:58:11 INFO - 'cart', 13:58:11 INFO - 'tsvg_static']}, 13:58:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:58:11 INFO - 'tsvgr_opacity', 13:58:11 INFO - 'tart', 13:58:11 INFO - 'tscrollx', 13:58:11 INFO - 'cart', 13:58:11 INFO - 'tsvg_static']}, 13:58:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:58:11 INFO - 'talos_options': ['--disable-e10s'], 13:58:11 INFO - 'tests': ['tp5o']}, 13:58:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:58:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:58:11 INFO - 'talos_options': ['--disable-e10s', 13:58:11 INFO - '--xperf_path', 13:58:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:58:11 INFO - 'tests': ['tp5n']}, 13:58:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:58:11 INFO - 'talos_options': ['--xperf_path', 13:58:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:58:11 INFO - 'tests': ['tp5n']}}, 13:58:11 INFO - 'talos.zip': {'path': '', 13:58:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:58:11 INFO - Running post-action listener: _resource_record_post_action 13:58:11 INFO - [mozharness: 2017-05-03 20:58:11.958640Z] Finished populate-webroot step (success) 13:58:11 INFO - [mozharness: 2017-05-03 20:58:11.958728Z] Running create-virtualenv step. 13:58:11 INFO - Running pre-action listener: _resource_record_pre_action 13:58:11 INFO - Running main action method: create_virtualenv 13:58:11 INFO - Creating virtualenv /builds/slave/test/build/venv 13:58:11 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 13:58:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:58:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:58:12 INFO - Using real prefix '/usr' 13:58:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:58:12 INFO - Installing distribute.............................................................................................................................................................................................done. 13:58:14 INFO - Installing pip.................done. 13:58:14 INFO - Return code: 0 13:58:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:58:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:58:14 INFO - Reading from file tmpfile_stdout 13:58:14 INFO - Output received: 13:58:14 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) 13:58:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2806a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29abb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a9290>, '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 0x29a9b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa040>, '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': '8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736', '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 13:58:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:58:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:58:14 INFO - Using env: {'DISPLAY': ':0', 13:58:14 INFO - 'HOME': '/home/cltbld', 13:58:14 INFO - 'LANG': 'en_US.UTF-8', 13:58:14 INFO - 'LANGUAGE': 'en_US:en', 13:58:14 INFO - 'LOGNAME': 'cltbld', 13:58:14 INFO - 'MAIL': '/var/mail/cltbld', 13:58:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:14 INFO - 'MOZ_NO_REMOTE': '1', 13:58:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:14 INFO - 'NO_EM_RESTART': '1', 13:58:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:14 INFO - 'PWD': '/builds/slave/test', 13:58:14 INFO - 'SHELL': '/bin/bash', 13:58:14 INFO - 'SHLVL': '1', 13:58:14 INFO - 'TERM': 'linux', 13:58:14 INFO - 'TMOUT': '86400', 13:58:14 INFO - 'USER': 'cltbld', 13:58:14 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736', 13:58:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:14 INFO - '_': '/tools/buildbot/bin/python'} 13:58:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:14 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 13:58:14 INFO - Cleaning up... 13:58:14 INFO - Return code: 0 13:58:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x270e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2806a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29abb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a9290>, '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 0x29a9b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa040>, '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': '8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736', '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 13:58:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:58:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:58:14 INFO - Using env: {'DISPLAY': ':0', 13:58:14 INFO - 'HOME': '/home/cltbld', 13:58:14 INFO - 'LANG': 'en_US.UTF-8', 13:58:14 INFO - 'LANGUAGE': 'en_US:en', 13:58:14 INFO - 'LOGNAME': 'cltbld', 13:58:14 INFO - 'MAIL': '/var/mail/cltbld', 13:58:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:14 INFO - 'MOZ_NO_REMOTE': '1', 13:58:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:14 INFO - 'NO_EM_RESTART': '1', 13:58:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:14 INFO - 'PWD': '/builds/slave/test', 13:58:14 INFO - 'SHELL': '/bin/bash', 13:58:14 INFO - 'SHLVL': '1', 13:58:14 INFO - 'TERM': 'linux', 13:58:14 INFO - 'TMOUT': '86400', 13:58:14 INFO - 'USER': 'cltbld', 13:58:14 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736', 13:58:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:14 INFO - '_': '/tools/buildbot/bin/python'} 13:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:15 INFO - Downloading/unpacking psutil>=3.1.1 13:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:58:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:58:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:58:16 INFO - Installing collected packages: psutil 13:58:16 INFO - Running setup.py install for psutil 13:58:16 INFO - building 'psutil._psutil_linux' extension 13:58:16 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 13:58:16 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 13:58:16 INFO - building 'psutil._psutil_posix' extension 13:58:16 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 13:58:16 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 13:58:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:58:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:58:16 INFO - Successfully installed psutil 13:58:16 INFO - Cleaning up... 13:58:16 INFO - Return code: 0 13:58:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:16 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 0x270e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2806a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29abb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a9290>, '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 0x29a9b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa040>, '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': '8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736', '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 13:58:16 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 13:58:16 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 13:58:16 INFO - Using env: {'DISPLAY': ':0', 13:58:16 INFO - 'HOME': '/home/cltbld', 13:58:16 INFO - 'LANG': 'en_US.UTF-8', 13:58:16 INFO - 'LANGUAGE': 'en_US:en', 13:58:16 INFO - 'LOGNAME': 'cltbld', 13:58:16 INFO - 'MAIL': '/var/mail/cltbld', 13:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:16 INFO - 'MOZ_NO_REMOTE': '1', 13:58:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:16 INFO - 'NO_EM_RESTART': '1', 13:58:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:16 INFO - 'PWD': '/builds/slave/test', 13:58:16 INFO - 'SHELL': '/bin/bash', 13:58:16 INFO - 'SHLVL': '1', 13:58:16 INFO - 'TERM': 'linux', 13:58:16 INFO - 'TMOUT': '86400', 13:58:16 INFO - 'USER': 'cltbld', 13:58:16 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736', 13:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:16 INFO - '_': '/tools/buildbot/bin/python'} 13:58:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:58:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:58:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:58:18 INFO - Installing collected packages: mozsystemmonitor 13:58:18 INFO - Running setup.py install for mozsystemmonitor 13:58:18 INFO - Successfully installed mozsystemmonitor 13:58:18 INFO - Cleaning up... 13:58:18 INFO - Return code: 0 13:58:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:18 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 0x270e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2806a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29abb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a9290>, '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 0x29a9b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa040>, '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': '8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736', '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 13:58:18 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 13:58:18 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 13:58:18 INFO - Using env: {'DISPLAY': ':0', 13:58:18 INFO - 'HOME': '/home/cltbld', 13:58:18 INFO - 'LANG': 'en_US.UTF-8', 13:58:18 INFO - 'LANGUAGE': 'en_US:en', 13:58:18 INFO - 'LOGNAME': 'cltbld', 13:58:18 INFO - 'MAIL': '/var/mail/cltbld', 13:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:18 INFO - 'MOZ_NO_REMOTE': '1', 13:58:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:18 INFO - 'NO_EM_RESTART': '1', 13:58:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:18 INFO - 'PWD': '/builds/slave/test', 13:58:18 INFO - 'SHELL': '/bin/bash', 13:58:18 INFO - 'SHLVL': '1', 13:58:18 INFO - 'TERM': 'linux', 13:58:18 INFO - 'TMOUT': '86400', 13:58:18 INFO - 'USER': 'cltbld', 13:58:18 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736', 13:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:18 INFO - '_': '/tools/buildbot/bin/python'} 13:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:18 INFO - Downloading/unpacking jsonschema==2.5.1 13:58:18 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 13:58:18 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 13:58:18 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 13:58:18 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 13:58:18 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 13:58:18 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 13:58:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:58:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:58:19 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 13:58:19 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 13:58:19 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 13:58:19 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 13:58:19 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 13:58:19 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 13:58:19 INFO - Downloading functools32-3.2.3-2.tar.gz 13:58:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:58:19 INFO - warning: no files found matching '*.txt' 13:58:19 INFO - no previously-included directories found matching 'build' 13:58:19 INFO - no previously-included directories found matching 'dist' 13:58:19 INFO - no previously-included directories found matching '.git*' 13:58:19 INFO - Installing collected packages: jsonschema, functools32 13:58:19 INFO - Running setup.py install for functools32 13:58:19 INFO - warning: no files found matching '*.txt' 13:58:19 INFO - no previously-included directories found matching 'build' 13:58:19 INFO - no previously-included directories found matching 'dist' 13:58:19 INFO - no previously-included directories found matching '.git*' 13:58:20 INFO - Successfully installed jsonschema functools32 13:58:20 INFO - Cleaning up... 13:58:20 INFO - Return code: 0 13:58:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:58:20 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')]} 13:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:20 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')]} 13:58:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:20 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 0x270e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2806a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29abb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a9290>, '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 0x29a9b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa040>, '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': '8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736', '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 13:58:20 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 13:58:20 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 13:58:20 INFO - Using env: {'DISPLAY': ':0', 13:58:20 INFO - 'HOME': '/home/cltbld', 13:58:20 INFO - 'LANG': 'en_US.UTF-8', 13:58:20 INFO - 'LANGUAGE': 'en_US:en', 13:58:20 INFO - 'LOGNAME': 'cltbld', 13:58:20 INFO - 'MAIL': '/var/mail/cltbld', 13:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:20 INFO - 'MOZ_NO_REMOTE': '1', 13:58:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:20 INFO - 'NO_EM_RESTART': '1', 13:58:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:20 INFO - 'PWD': '/builds/slave/test', 13:58:20 INFO - 'SHELL': '/bin/bash', 13:58:20 INFO - 'SHLVL': '1', 13:58:20 INFO - 'TERM': 'linux', 13:58:20 INFO - 'TMOUT': '86400', 13:58:20 INFO - 'USER': 'cltbld', 13:58:20 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736', 13:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:20 INFO - '_': '/tools/buildbot/bin/python'} 13:58:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:58:20 INFO - Cleaning up... 13:58:20 INFO - Return code: 0 13:58:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:58:20 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')]} 13:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:20 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')]} 13:58:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:20 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 0x270e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2806a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29abb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a9290>, '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 0x29a9b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa040>, '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': '8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736', '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 13:58:20 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 13:58:20 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 13:58:20 INFO - Using env: {'DISPLAY': ':0', 13:58:20 INFO - 'HOME': '/home/cltbld', 13:58:20 INFO - 'LANG': 'en_US.UTF-8', 13:58:20 INFO - 'LANGUAGE': 'en_US:en', 13:58:20 INFO - 'LOGNAME': 'cltbld', 13:58:20 INFO - 'MAIL': '/var/mail/cltbld', 13:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:20 INFO - 'MOZ_NO_REMOTE': '1', 13:58:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:20 INFO - 'NO_EM_RESTART': '1', 13:58:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:20 INFO - 'PWD': '/builds/slave/test', 13:58:20 INFO - 'SHELL': '/bin/bash', 13:58:20 INFO - 'SHLVL': '1', 13:58:20 INFO - 'TERM': 'linux', 13:58:20 INFO - 'TMOUT': '86400', 13:58:20 INFO - 'USER': 'cltbld', 13:58:20 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736', 13:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:20 INFO - '_': '/tools/buildbot/bin/python'} 13:58:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:20 INFO - Downloading/unpacking blobuploader==1.2.4 13:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:21 INFO - Downloading blobuploader-1.2.4.tar.gz 13:58:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:58:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:58:21 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 13:58:21 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 13:58:21 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 13:58:21 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 13:58:21 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 13:58:21 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 13:58:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:58:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:58:21 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 13:58:21 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 13:58:21 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 13:58:21 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 13:58:21 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 13:58:21 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 13:58:22 INFO - Downloading docopt-0.6.1.tar.gz 13:58:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:58:22 INFO - Installing collected packages: blobuploader, requests, docopt 13:58:22 INFO - Running setup.py install for blobuploader 13:58:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:58:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:58:22 INFO - Running setup.py install for requests 13:58:22 INFO - Running setup.py install for docopt 13:58:22 INFO - Successfully installed blobuploader requests docopt 13:58:22 INFO - Cleaning up... 13:58:22 INFO - Return code: 0 13:58:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:22 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 0x270e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2806a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29abb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a9290>, '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 0x29a9b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa040>, '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': '8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736', '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 13:58:22 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 13:58:22 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 13:58:22 INFO - Using env: {'DISPLAY': ':0', 13:58:22 INFO - 'HOME': '/home/cltbld', 13:58:22 INFO - 'LANG': 'en_US.UTF-8', 13:58:22 INFO - 'LANGUAGE': 'en_US:en', 13:58:22 INFO - 'LOGNAME': 'cltbld', 13:58:22 INFO - 'MAIL': '/var/mail/cltbld', 13:58:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:22 INFO - 'MOZ_NO_REMOTE': '1', 13:58:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:22 INFO - 'NO_EM_RESTART': '1', 13:58:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:22 INFO - 'PWD': '/builds/slave/test', 13:58:22 INFO - 'SHELL': '/bin/bash', 13:58:22 INFO - 'SHLVL': '1', 13:58:22 INFO - 'TERM': 'linux', 13:58:22 INFO - 'TMOUT': '86400', 13:58:22 INFO - 'USER': 'cltbld', 13:58:22 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736', 13:58:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:22 INFO - '_': '/tools/buildbot/bin/python'} 13:58:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:58:22 INFO - Running setup.py (path:/tmp/pip-aZ9wVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:58:23 INFO - Running setup.py (path:/tmp/pip-WhBrDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:58:23 INFO - Running setup.py (path:/tmp/pip-5M5XmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:58:23 INFO - Running setup.py (path:/tmp/pip-cF9J0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:58:23 INFO - Running setup.py (path:/tmp/pip-IPqwhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:58:23 INFO - Running setup.py (path:/tmp/pip-FLhi0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:58:23 INFO - Running setup.py (path:/tmp/pip-df5Jlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:58:23 INFO - Running setup.py (path:/tmp/pip-zkkF6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:58:23 INFO - Running setup.py (path:/tmp/pip-bruE_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:58:23 INFO - Running setup.py (path:/tmp/pip-Iugt22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:58:23 INFO - Running setup.py (path:/tmp/pip-O6Qp7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:58:23 INFO - Running setup.py (path:/tmp/pip-hXhd2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:58:23 INFO - Running setup.py (path:/tmp/pip-VR2oXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:58:23 INFO - Running setup.py (path:/tmp/pip-ym7Fhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:58:23 INFO - Running setup.py (path:/tmp/pip-59G6na-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:58:24 INFO - Running setup.py (path:/tmp/pip-4JZ_Ve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:58:24 INFO - Running setup.py (path:/tmp/pip-GSCeJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:58:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:58:24 INFO - Running setup.py install for manifestparser 13:58:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:58:24 INFO - Running setup.py install for mozcrash 13:58:24 INFO - Running setup.py install for mozdebug 13:58:24 INFO - Running setup.py install for mozdevice 13:58:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:58:24 INFO - Running setup.py install for mozfile 13:58:24 INFO - Running setup.py install for mozhttpd 13:58:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:58:24 INFO - Running setup.py install for mozinfo 13:58:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:58:24 INFO - Running setup.py install for mozInstall 13:58:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:58:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:58:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:58:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:58:24 INFO - Running setup.py install for mozleak 13:58:25 INFO - Running setup.py install for mozlog 13:58:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:58:25 INFO - Running setup.py install for moznetwork 13:58:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:58:25 INFO - Running setup.py install for mozprocess 13:58:25 INFO - Running setup.py install for mozprofile 13:58:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:58:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:58:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:58:25 INFO - Running setup.py install for mozrunner 13:58:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:58:25 INFO - Running setup.py install for mozscreenshot 13:58:25 INFO - Running setup.py install for moztest 13:58:25 INFO - Running setup.py install for mozversion 13:58:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:58:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:58:25 INFO - Cleaning up... 13:58:25 INFO - Return code: 0 13:58:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:25 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 0x270e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2806a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29abb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a9290>, '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 0x29a9b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa040>, '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': '8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736', '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 13:58:25 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 13:58:25 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 13:58:25 INFO - Using env: {'DISPLAY': ':0', 13:58:25 INFO - 'HOME': '/home/cltbld', 13:58:25 INFO - 'LANG': 'en_US.UTF-8', 13:58:25 INFO - 'LANGUAGE': 'en_US:en', 13:58:25 INFO - 'LOGNAME': 'cltbld', 13:58:25 INFO - 'MAIL': '/var/mail/cltbld', 13:58:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:25 INFO - 'MOZ_NO_REMOTE': '1', 13:58:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:25 INFO - 'NO_EM_RESTART': '1', 13:58:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:25 INFO - 'PWD': '/builds/slave/test', 13:58:25 INFO - 'SHELL': '/bin/bash', 13:58:25 INFO - 'SHLVL': '1', 13:58:25 INFO - 'TERM': 'linux', 13:58:25 INFO - 'TMOUT': '86400', 13:58:25 INFO - 'USER': 'cltbld', 13:58:25 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736', 13:58:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:25 INFO - '_': '/tools/buildbot/bin/python'} 13:58:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:58:26 INFO - Running setup.py (path:/tmp/pip-zMlUiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:58:26 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)) 13:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:58:26 INFO - Running setup.py (path:/tmp/pip-jKe9HY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:58:26 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)) 13:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:58:26 INFO - Running setup.py (path:/tmp/pip-q5ZE8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:58:26 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)) 13:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:58:26 INFO - Running setup.py (path:/tmp/pip-ZI6wtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:58:26 INFO - Running setup.py (path:/tmp/pip-WbCaBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:58:26 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)) 13:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:58:26 INFO - Running setup.py (path:/tmp/pip-NaUm5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:58:26 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)) 13:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:58:26 INFO - Running setup.py (path:/tmp/pip-fH5Oxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:58:26 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)) 13:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:58:26 INFO - Running setup.py (path:/tmp/pip-uykXn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:58:26 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)) 13:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:58:26 INFO - Running setup.py (path:/tmp/pip-BIjSzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:58:26 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)) 13:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:58:26 INFO - Running setup.py (path:/tmp/pip-C5A6A6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:58:26 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)) 13:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:58:26 INFO - Running setup.py (path:/tmp/pip-5bz583-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:58:27 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)) 13:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:58:27 INFO - Running setup.py (path:/tmp/pip-bEP8zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:58:27 INFO - Running setup.py (path:/tmp/pip-n0DeY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:58:27 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)) 13:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:58:27 INFO - Running setup.py (path:/tmp/pip-5x2hkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:58:27 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)) 13:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:58:27 INFO - Running setup.py (path:/tmp/pip-iK3jCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:58:27 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)) 13:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:58:27 INFO - Running setup.py (path:/tmp/pip-tHRBv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:58:27 INFO - Running setup.py (path:/tmp/pip-RpYZ7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:58:27 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)) 13:58:27 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)) 13:58:27 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)) 13:58:27 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)) 13:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:58:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:58:27 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 13:58:27 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 13:58:27 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 13:58:27 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 13:58:27 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 13:58:27 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 13:58:28 INFO - Downloading blessings-1.6.tar.gz 13:58:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:58:28 INFO - Installing collected packages: blessings 13:58:28 INFO - Running setup.py install for blessings 13:58:28 INFO - Successfully installed blessings 13:58:28 INFO - Cleaning up... 13:58:28 INFO - Return code: 0 13:58:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:58:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:58:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:58:28 INFO - Reading from file tmpfile_stdout 13:58:28 INFO - Current package versions: 13:58:28 INFO - argparse == 1.2.1 13:58:28 INFO - blessings == 1.6 13:58:28 INFO - blobuploader == 1.2.4 13:58:28 INFO - docopt == 0.6.1 13:58:28 INFO - functools32 == 3.2.3-2 13:58:28 INFO - jsonschema == 2.5.1 13:58:28 INFO - manifestparser == 1.1 13:58:28 INFO - mozInstall == 1.12 13:58:28 INFO - mozcrash == 1.0 13:58:28 INFO - mozdebug == 0.1 13:58:28 INFO - mozdevice == 0.50 13:58:28 INFO - mozfile == 1.2 13:58:28 INFO - mozhttpd == 0.7 13:58:28 INFO - mozinfo == 0.9 13:58:28 INFO - mozleak == 0.1 13:58:28 INFO - mozlog == 3.4 13:58:28 INFO - moznetwork == 0.27 13:58:28 INFO - mozprocess == 0.25 13:58:28 INFO - mozprofile == 0.28 13:58:28 INFO - mozrunner == 6.13 13:58:28 INFO - mozscreenshot == 0.1 13:58:28 INFO - mozsystemmonitor == 0.3 13:58:28 INFO - moztest == 0.8 13:58:28 INFO - mozversion == 1.4 13:58:28 INFO - psutil == 3.1.1 13:58:28 INFO - requests == 1.2.3 13:58:28 INFO - wsgiref == 0.1.2 13:58:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:58:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:28 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 0x270e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2806a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29abb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a9290>, '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 0x29a9b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa040>, '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': '8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736', '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 13:58:28 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 13:58:28 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 13:58:28 INFO - Using env: {'DISPLAY': ':0', 13:58:28 INFO - 'HOME': '/home/cltbld', 13:58:28 INFO - 'LANG': 'en_US.UTF-8', 13:58:28 INFO - 'LANGUAGE': 'en_US:en', 13:58:28 INFO - 'LOGNAME': 'cltbld', 13:58:28 INFO - 'MAIL': '/var/mail/cltbld', 13:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:29 INFO - 'MOZ_NO_REMOTE': '1', 13:58:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:29 INFO - 'NO_EM_RESTART': '1', 13:58:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:29 INFO - 'PWD': '/builds/slave/test', 13:58:29 INFO - 'SHELL': '/bin/bash', 13:58:29 INFO - 'SHLVL': '1', 13:58:29 INFO - 'TERM': 'linux', 13:58:29 INFO - 'TMOUT': '86400', 13:58:29 INFO - 'USER': 'cltbld', 13:58:29 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736', 13:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:29 INFO - '_': '/tools/buildbot/bin/python'} 13:58:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:29 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)) 13:58:29 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)) 13:58:29 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)) 13:58:29 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)) 13:58:29 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)) 13:58:29 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)) 13:58:29 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)) 13:58:29 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)) 13:58:29 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)) 13:58:29 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)) 13:58:29 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)) 13:58:29 INFO - Cleaning up... 13:58:29 INFO - Return code: 0 13:58:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:58:29 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')]} 13:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:29 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')]} 13:58:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:29 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 0x270e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2806a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29abb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a9290>, '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 0x29a9b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa040>, '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': '8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736', '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 13:58:29 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 13:58:29 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 13:58:29 INFO - Using env: {'DISPLAY': ':0', 13:58:29 INFO - 'HOME': '/home/cltbld', 13:58:29 INFO - 'LANG': 'en_US.UTF-8', 13:58:29 INFO - 'LANGUAGE': 'en_US:en', 13:58:29 INFO - 'LOGNAME': 'cltbld', 13:58:29 INFO - 'MAIL': '/var/mail/cltbld', 13:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:29 INFO - 'MOZ_NO_REMOTE': '1', 13:58:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:29 INFO - 'NO_EM_RESTART': '1', 13:58:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:29 INFO - 'PWD': '/builds/slave/test', 13:58:29 INFO - 'SHELL': '/bin/bash', 13:58:29 INFO - 'SHLVL': '1', 13:58:29 INFO - 'TERM': 'linux', 13:58:29 INFO - 'TMOUT': '86400', 13:58:29 INFO - 'USER': 'cltbld', 13:58:29 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736', 13:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:29 INFO - '_': '/tools/buildbot/bin/python'} 13:58:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:58:29 INFO - Cleaning up... 13:58:29 INFO - Return code: 0 13:58:29 INFO - Running post-action listener: _resource_record_post_action 13:58:29 INFO - Running post-action listener: _start_resource_monitoring 13:58:29 INFO - Starting resource monitoring. 13:58:29 INFO - [mozharness: 2017-05-03 20:58:29.496446Z] Finished create-virtualenv step (success) 13:58:29 INFO - [mozharness: 2017-05-03 20:58:29.496952Z] Running install step. 13:58:29 INFO - Running pre-action listener: _resource_record_pre_action 13:58:29 INFO - Running main action method: install 13:58:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:58:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:58:29 INFO - Reading from file tmpfile_stdout 13:58:29 INFO - Detecting whether we're running mozinstall >=1.0... 13:58:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:58:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:58:29 INFO - Reading from file tmpfile_stdout 13:58:29 INFO - Output received: 13:58:29 INFO - Usage: mozinstall [options] installer 13:58:29 INFO - Options: 13:58:29 INFO - -h, --help show this help message and exit 13:58:29 INFO - -d DEST, --destination=DEST 13:58:29 INFO - Directory to install application into. [default: 13:58:29 INFO - "/builds/slave/test"] 13:58:29 INFO - --app=APP Application being installed. [default: firefox] 13:58:29 INFO - mkdir: /builds/slave/test/build/application 13:58:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:58:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:58:45 INFO - Reading from file tmpfile_stdout 13:58:45 INFO - Output received: 13:58:45 INFO - /builds/slave/test/build/application/firefox/firefox 13:58:45 INFO - Running post-action listener: _resource_record_post_action 13:58:45 INFO - [mozharness: 2017-05-03 20:58:45.100427Z] Finished install step (success) 13:58:45 INFO - [mozharness: 2017-05-03 20:58:45.100672Z] Running run-tests step. 13:58:45 INFO - Running pre-action listener: _resource_record_pre_action 13:58:45 INFO - Running main action method: run_tests 13:58:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:58:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:58:45 INFO - Python 2.7.3 13:58:45 INFO - Return code: 0 13:58:45 INFO - grabbing minidump binary from tooltool 13:58: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')]} 13:58:45 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 0x29a9290>, '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 0x29a9b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:58:45 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 13:58:45 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 13:58:45 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 13:58:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:58:45 INFO - Return code: 0 13:58:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:58:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:58:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:58:45 INFO - ENV: RUST_BACKTRACE is now 1 13:58:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:58:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:58:45 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/MzyTuWZaSjquOpKDjW7FAw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 13:58:45 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/MzyTuWZaSjquOpKDjW7FAw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 13:58:45 INFO - Using env: {'DISPLAY': ':0', 13:58:45 INFO - 'HOME': '/home/cltbld', 13:58:45 INFO - 'LANG': 'en_US.UTF-8', 13:58:45 INFO - 'LANGUAGE': 'en_US:en', 13:58:45 INFO - 'LOGNAME': 'cltbld', 13:58:45 INFO - 'MAIL': '/var/mail/cltbld', 13:58:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:58:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:58:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:45 INFO - 'MOZ_NO_REMOTE': '1', 13:58:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:58:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:45 INFO - 'NO_EM_RESTART': '1', 13:58:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:45 INFO - 'PWD': '/builds/slave/test', 13:58:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:58:45 INFO - 'RUST_BACKTRACE': '1', 13:58:45 INFO - 'SHELL': '/bin/bash', 13:58:45 INFO - 'SHLVL': '1', 13:58:45 INFO - 'TERM': 'linux', 13:58:45 INFO - 'TMOUT': '86400', 13:58:45 INFO - 'USER': 'cltbld', 13:58:45 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736', 13:58:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:45 INFO - '_': '/tools/buildbot/bin/python'} 13:58:45 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/MzyTuWZaSjquOpKDjW7FAw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 13:58:45 INFO - mozversion application_buildid: 20170503203128 13:58:45 INFO - mozversion application_changeset: 96605941c0021795376d9c6ec1e458de2fac329e 13:58:45 INFO - mozversion application_display_name: Nightly 13:58:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:58:45 INFO - mozversion application_name: Firefox 13:58:45 INFO - mozversion application_remotingname: firefox 13:58:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:58:45 INFO - mozversion application_vendor: Mozilla 13:58:45 INFO - mozversion application_version: 55.0a1 13:58:45 INFO - mozversion platform_buildid: 20170503203128 13:58:45 INFO - mozversion platform_changeset: 96605941c0021795376d9c6ec1e458de2fac329e 13:58:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:58:45 INFO - mozversion platform_version: 55.0a1 13:58:45 INFO - using testdate: 1493845125 13:58:45 INFO - actual date: 1493845125 13:58:45 INFO - starting webserver on 'localhost:46943' 13:58:45 INFO - SUITE-START | Running 2 tests 13:58:45 INFO - TEST-START | dromaeo_css 13:58:45 INFO - operating with platform_type : linux_ 13:58:45 INFO - Initialising browser for dromaeo_css test... 13:58:45 INFO - TEST-INFO | started process 8323 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJI2yGl/profile http://localhost:46943/getInfo.html) 13:58:49 INFO - PID 8323 | __metrics Screen width/height:1600/1200 13:58:49 INFO - PID 8323 | colorDepth:24 13:58:49 INFO - PID 8323 | Browser inner width/height: 1024/695 13:58:49 INFO - PID 8323 | __metrics 13:58:51 INFO - TEST-INFO | 8323: exit 0 13:58:51 INFO - Browser initialized. 13:58:51 INFO - Running cycle 1/1 for dromaeo_css test... 13:58:51 INFO - TEST-INFO | started process 8453 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJI2yGl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:59:03 INFO - PID 8453 | RSS: Main: 161071104 13:59:03 INFO - PID 8453 | 14:02:07 INFO - PID 8453 | Cycle 1(1): loaded http://localhost:46943/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46943/tests/dromaeo/cssquery-ext.html) 14:02:10 INFO - PID 8453 | RSS: Main: 163172352 14:02:10 INFO - PID 8453 | 14:05:13 INFO - PID 8453 | Cycle 1(1): loaded http://localhost:46943/tests/dromaeo/cssquery-ext.html (next: http://localhost:46943/tests/dromaeo/cssquery-jquery.html) 14:05:13 INFO - PID 8453 | RSS: Main: 159195136 14:05:13 INFO - PID 8453 | 14:08:15 INFO - PID 8453 | Cycle 1(1): loaded http://localhost:46943/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46943/tests/dromaeo/cssquery-mootools.html) 14:08:16 INFO - PID 8453 | RSS: Main: 164737024 14:08:16 INFO - PID 8453 | 14:11:17 INFO - PID 8453 | Cycle 1(1): loaded http://localhost:46943/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46943/tests/dromaeo/cssquery-prototype.html) 14:11:18 INFO - PID 8453 | RSS: Main: 159227904 14:11:18 INFO - PID 8453 | 14:14:21 INFO - PID 8453 | Cycle 1(1): loaded http://localhost:46943/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46943/tests/dromaeo/cssquery-yui.html) 14:14:22 INFO - PID 8453 | RSS: Main: 162750464 14:14:22 INFO - PID 8453 | 14:17:23 INFO - PID 8453 | Cycle 1(1): loaded http://localhost:46943/tests/dromaeo/cssquery-yui.html (next: http://localhost:46943/tests/dromaeo/cssquery-dojo.html) 14:17:24 INFO - PID 8453 | RSS: Main: 166023168 14:17:24 INFO - PID 8453 | 14:17:24 INFO - PID 8453 | __start_tp_report 14:17:24 INFO - PID 8453 | _x_x_mozilla_page_load 14:17:24 INFO - PID 8453 | _x_x_mozilla_page_load_details 14:17:24 INFO - PID 8453 | |i|pagename|runs| 14:17:24 INFO - PID 8453 | |0;dojo.html;2701.6217729517866;2717.605947137664;2728.672559292885;2743.8628068596577;2748.8900443982243;5188.37739471263;5262.263283140359;5272.051030814452;5279.181726832342;5331.546818520425;5211.114110601197;5281.973590132044;5300.681959082448;5335.359756829176;5387;4635.930461043087;4637.304404339342;4641.257398816173;4659.301104834268;4661.5804577588015;4650.441946966352;4699.90600187996;4702.858914232578;4705.082508910764;4718.882027949311;4630.791614377361;4685.648576356787;4693.6010439112715;4701.224297990828;4732.668713190078;4743.952560474386;4745.193317136095;4759.048190361941;4772.5943294819635;4791.856244312677;4682.391289132391;4724.173269677827;4729.172394830925;4729.858104256878;4738.857834264978;5183.714895680736;5237.738113094369;5245.842624721265;5315.282436871012;5322.547583455411;5737.3975732548315;5758.337791154029;5788.82633520995;5808.8838223235725;5838.036723940587;5771.105478650816;5781.421857814227;5783.71081445926;5789.942100578983;5806.65160090396;5210.166373380241;5277.920831187535;5310.176922577007;5324.494173053554;5325.573954083741;5770.105633626795;5813.651180929073;5824.708764561755;5845.1232315153065;5852.063669812809;5579.414161513064;5593.049181639131;5631.662100273997;5651.971740141273;5662.235598194274;5763.221965034667;5766.740496677659;5771.971140144273;5785.8553536161935;5791.362950075572;5700.287464066992;5715.742791574389;5724.141378793214;5740.167675687002;5740.913886291709;5570.916436253459;5616.943830561642;5659.830205093854;5696.202531645573;5708.54331653475;4784.832530861403;4794.400699912511;4795.088933102769;4816.710997340171;4822.469528351879;4070.8371665133063;4091.8363265469047;4093.5906409358827;4095.9795201023803;4142.730722503027;4842.878928026827;4905.55849973497;4921.335619691367;4922.950770492249;4943.4809345018975;5709.514691251207;5739.483446489836;5747.8563035924435;5797.130430435384;5807.01280782268;4934.4572097069295;4961.677490963076;4974.1543937530705;4975.154223781893;4978.178600530944;5116.9744151279;5129.435762066244;5133.383993920679;5137.743112844418;5161.096808058574;5206.349206349207;5305.257263983045;5317.787288508416;5324.9733751331;5359.517643412034;5657.60396772222;5719.199312096227;5730.111832665943;5779.075347944308;5817.5345972321265;5285.973570132125;5307.363116426053;5319.813806516753;5326.97336513315;5347.839564813062;5638.633488823213;5662.952353814558;5676.290463692038;5692.0608099663095;5749.482546570829;5644.6330988485615;5701.4298570142655;5716.228309178207;5733.111367738007;5788.421157884178;5515.22786809855;5525.309336332958;5526.668399896019;5532.2254884317035;5532.751026203911;5520.641158324696;5521.723913804213;5534.667919924817;5548;5548.528375088163;5387.111126664056;5411.350637923474;5464.1257398816;5465.398806131402;5475.917861232005;5560.165975103605;5576.749046293007;5578.051731205624;5582.469665381782;5587.916181257203;5341.118715411913;5392.029434701792;5397.379301380392;5430.239766432624;5454 14:17:24 INFO - PID 8453 | |1;ext.html;632.1150389454764;649.8602800397915;1046.5813674530186;1056.8097742406364;1133.1331531378503;29625.111246662582;33111.33777324452;33274.33451330975;33570.83214583924;33572.66427335726;30469.84765076177;30719.232019199477;30738.231544211405;30798.230044248907;30825.845870770616;6201.069839524062;6405.423511883918;6517.608943463384;6524.673766311689;6904.4131248843905;6915.585064896122;7036.542624729376;7060.435165186773;7063.117110361205;7092.361687448129;6997.580145191305;7049.541779784297;7057.364837164654;7062.646867656622;7103.751368702096;7062.5056246062795;7068.222495525488;7077.079979602619;7084.114485689289;7086.362227399533;6807.5575087619645;6894.069300644399;6970.756023539152;6983.3714965653335;6988.860222795515;31802.840985795156;31944.520832187303;32062.679373206203;32104.678953210638;32135.196620084684;3010.1571559963245;3022.123584160591;3037.7569794416395;3040.331127152045;3045.5888455058507;24236.636450453258;24245.151419700225;24365.269041928594;24404.511909761706;24457.143999959917;2730.358365784039;2742.9588556171475;2744.31392151962;2759.806813523054;2770.3074231442138;148599;149372;149853.25073374563;149989;150162;38590;39449.40825887614;39585.20829583392;40898.1820363591;41313.586864131576;41230.38154427686;41230.79384603058;41316.79341603333;41364.172716546105;41502.79248603798;11154.832677509843;11257.380844053656;11265.605703800327;11277.154213433862;11282.661520154408;8677.349198810114;8739.38824282294;8742.956285218534;8784;8808.11918808114;12532.185407948455;12548.498060077494;12588.244705317711;12624.368781560885;12786.10497265201;5307.7080760557765;5365.141577347606;5399.37907140676;5414.3232095988005;5418.376886658006;869.5912920927154;901.9594118264694;904.9592768325441;913.4519288427024;931.5714771205186;20672.966351682357;21422.678659820114;21511.67732484014;21535.13859445636;21562.353129406143;962.4946902875906;979.2900147393225;986.7483791633088;1003.7440452684665;1008.9142422893989;10982.835257471144;11237.157213209042;11519.30884146954;11528.423578821026;11532.423378831025;177603;179535;179635;179744.10127949275;181158;41677;41759;41830.79084604557;42084;42086.36870446946;1186.526485492816;1227.4292454008928;1227.5703503773786;1230.723087305367;1237.4802582915197;19894.801051989874;20327.695084573446;20736.896315518326;20965.475863103544;21265.574688505832;29971.70028299689;29979.550306745852;30122;30174.09477715672;30181.849090754407;139754.30122849322;142417.28791355976;151831;152653;153238;31360;31400.842995784875;31573.36853262876;31601.20996975094;31636.305465015597;35347.64652353444;35597;36504.81747591245;36791.63208367882;36827.447588286734;27294.31764205831;27875.44249115047;27892.44215115727;27894.721052790024;29603.259918502208;27650.5852412218;27925.301867452665;28165.15504534867;28482.430351393272;29553;31348.37303253968;31540.842295788374;31827.522587161675;31849.203769905936;32004;25973.870130649226;26945.461090777684;27076.45847083087;27095.72904270932;28540.143795686163;20571.4857128573;22413.87930603431;22639.660405093608;22773.772262277827;22806.657900131842 14:17:24 INFO - PID 8453 | |2;jquery.html;414.3825699707433;425.65390838722857;430.93535969604557;440.45603679455866;446.76321549578734;17125.82874171258;17319.30722771089;17746.378876739316;18293;18387.724184137216;18405.171767270473;18773.718394224063;18962;19122.61754764904;19201.42395728127;5351.759170837302;5363.329583802025;5466.01611709894;5466.590005749565;5524.8342549723575;5300;5397.811076612319;5456;5458.344998600153;5492.835214943558;5447.455254474541;5447.645903016291;5457.263269458632;5463.153211252243;5479.0959491683825;5341.866453338659;5343.171808369709;5456.127019676833;5464.508194262516;5469.890602187954;4867.610591152699;4926.088673595396;4938.333325001151;4940.333055037596;4942.085714142859;20848.583028339348;22069;22261.332160035225;22279.443013924618;22374.55250894989;1634.5831812887757;1677.9244933978;1678.1189875315436;1679.0597265531342;1680.420255012019;14536.491222807152;14786.852131478656;15073.47242846506;15157.545273641808;15182;1986.2352994097232;2050.7436570428695;2091.5294058836794;2099.086897199708;2106.9157233710635;81475;89120.55439722825;89623.34896463483;99750.50124749403;103695.48152259341;10918.672439826818;11093.33439993603;11270.661880143609;11335.14986376025;11351.432428378548;15505.069695818287;15539.300731466885;15546;15551.455699050479;15568.730566580918;7184.784456466315;7429;7537.170911199763;7649.923500764921;7715.575643339558;6828.351306625863;6832;6857.27998560154;6995.440364770806;7111.439881642605;6686.197656281277;6783.93216067833;6811.4550835933005;6811.863762724718;6865.759698410531;2128.223198532555;2140.7003019577273;2165.577712346109;2234.5530893820974;2473.8639374834197;815.5392203405057;846.3144852669358;847.1443841719907;866.925012983908;882.6557642519423;16687.415940442028;16766;17118.828811711974;17245.482635520955;17449.563760905825;858.2318824651902;881.3213825354442;887.1527691055027;899.8515244984504;904.0642934562827;8812.295016398673;9212.63149474027;9316.534173291444;9384.8592271116;9516.095970882756;394119;397271;400800;403591;404620;79625.60187199026;79958.60020699976;80073.59963200147;80615;82753;1011.8532812742111;1048.816457120001;1056.2553399853084;1060.4432672846663;1061.7133373989134;14082.225477598831;14238.572842814732;14425.63935901569;14453.927730361282;14864.108153510824;36878.63121368859;37025;37640.43539346857;37889.81055094707;38174;48308.938397396036;50067;50355.74110647263;50638.2404263929;50755.49244507508;8259;8317.542535160625;8525.888050861267;8584.527850968258;8647.610857511552;13400.597982060553;13563.457461701422;13669.521566745116;13744.312784360542;13806.723865522432;10955.397453140155;11000.394978276272;11223.887761122285;11415.344775007412;11521.135914806255;9895.50522473859;10042.748931276485;10044.49777511107;10164.13604843567;10216.1827053837;10754.892451075702;10772.569097236023;10833.458327083772;11111.666650000512;11271.211015229183;8513.702020429255;8536.829263414822;8688.174623410765;8751.343649226206;8793.516356600448;11263.211575189658;11269.549218031187;11300.94349528247;11414.771704565695;11556.133290003452 14:17:24 INFO - PID 8453 | |3;mootools.html;1173.7405494423238;1177.6467059882036;1191.3804821492818;1195.3545085653745;1203.6028110723462;9002.549872506374;9475.24198064155;9492.382995105314;9527.904720952789;9671.468069256189;9546.90453095469;9697.175740062086;9729.562169702363;9743.805123897519;9753.804923901518;2139.475828422039;2170.218721260345;2181.5091604388963;2183.1922188790168;2185.7814218578096;2102.180149741602;2120.07776617172;2121.66053431451;2135.882526461044;2151.032035583986;2125.8830764308036;2149.1725685610995;2162.697222388867;2171.7936796004433;2179.1174574297356;2053.3634573282256;2094.0472085201272;2102.1906565972135;2111.5776844631137;2112.324056301984;1988.6619274723332;2015.516276093727;2070.254708305009;2120.5016821047043;2126.2239282661717;9613.375130616487;9656.565454554491;9674;9707.029297070307;9733.659321923698;5310.468953104697;5504.587155963319;5563.13771365439;5579.274694289757;5589.888202235973;3085.3674996625637;3289.917752056194;3310.817905015223;3341.799492030486;3379.509971054208;1009.1220638044948;1052.878918924326;1054.9630762923337;1075.542894269932;1094.4691824465128;13469.191848489025;13484;13530.526431574848;13650;13681.657958551017;4548.545145485425;4578.107269082497;4711;4868.464468908417;4874.975625121851;9997.700068997941;10080.092791648787;10084.193264538819;10086.798264034678;10093.646722364681;5198.532132108128;5231.71225582589;5260;5271.841844744664;5272.710000949908;4789.592884604778;4803.255495398219;4909.337239472697;4924.507549245047;4933.654644174873;3767.1335592813807;3774.7735135891385;3825.254075455315;3900.6684431823046;3920.882373528799;1124.651358078998;1127.5997021057572;1128.0355296221776;1138.3340745663713;1141.0700279272367;699.8355386484172;712.1454254894044;725.7133432294214;726.5604309392742;740.6407892172292;5164;5173.198154286091;5354.063038968243;5398.1093119634825;5438.102713052302;560.842963970089;567.3475503171386;567.5119397318302;573.6758731316793;573.7618888161367;3448.637893021247;3512.613612502623;3721.5348081489815;3884.533855937306;3923.509561304837;12043.277403355827;12284.570040048735;12446.875531244752;12589.685257868627;12616.936915315364;12020.158588898694;12167.513299468099;12339.814902776287;12342.382880856101;12393.256404615751;6960.234374218832;7066.717331306793;7246.601436920914;7271.2365201653065;7298.416126709851;5673.4114447954635;5673.659580425187;5761.567882408753;5892.086726557391;5895.14520394549;10945.452727363441;10953.507092180711;10967.177461690246;11037.448127593749;11085.944570277097;11120;11245.606403775828;11348.375839328915;11481.885181148082;11534.365609891536;6968.721251149897;7127.429805615642;7129.465290103367;7159.677814498256;7178.461615378972;8922.152395522415;9020.774480638036;9062.592183351633;9087;9096;7610.238976102567;7776;7819.530828150329;7876.881846772418;8002.879956800536;7625.809354766176;7631.3894888407685;7678.500897441649;7861.213878612093;7920.366370690215;6794.422474089758;6948.992396102638;6992.510524263253;7002.894956575554;7004.964975175091;5159.2003239497935;5187.948120518747;5230.686158830483;5279.683219006872;5313.867153321198;5193.117170081171;5411.675299482044;5492;5498.697571633598;5584.888302234014 14:17:24 INFO - PID 8453 | |4;prototype.html;375.8834761224021;395.12479857116483;397.2075708960624;402.49084907591885;403.8626866865265;5324.227986941891;5484;5549.556035517159;5593.440655934404;5607.299087614048;5341.492558206974;5470.261514695515;5483.259759932408;5501.5323697485765;5513.228148059265;4322.762248076362;4324.84863029794;4337.826486940535;4346.326319420495;4351.3690514875325;4243.405923170759;4335.872673104999;4350.80421381037;4360.956390436103;4377.687977342315;4297.183535128332;4303.33298338758;4308.784560771965;4317.568243175689;4327.783610819462;4315.223259813232;4316.97841510792;4323.524412314643;4339.717918335314;4340.848070317524;3768.3028639701743;3936.9212615747524;3948.802559871995;3957.168994511156;3957.6438120569;5340.786368545254;5361.785528578891;5363.436839131874;5364.490373414519;5381.650192737459;5118.38579370478;5125.282460455539;5125.692458452505;5131.639445854911;5146.459621739701;5681.630694004876;5831.970840145815;5837.270341207349;5839.328477225088;5853.912191317134;4352.956470435287;4366.541513141106;4374.759388233646;4386.232409328355;4387.495438024636;5927.762889484416;6107.480864126599;6110.114033465167;6206.596571222856;6244.6253224806205;4284.807183676742;4311.676624253194;4321.546237645002;4322.24360736876;4341.891452713708;4386.517483076859;4393.253146965024;4396.472423309159;4400.361947517592;4403.977980110143;4923.630727695438;4956.281339205795;4985.52637499437;4987.202047672355;4990.850274491771;5790.42095790426;5808.477237048602;5811.564132690065;5822.301323841166;5843.5325173985975;1571.7642353647045;1578.5106616948783;1578.8657964073182;1581.675756469921;1588.1662127382986;1141.6746227325173;1159.9154790271123;1163.7148898519747;1174.9177557570888;1185.271058299157;5074.441811400743;5078.644494885397;5081.4918508148885;5097.413797413271;5102.923456148161;5846.736896839652;5956.374580668968;5992.760289588367;5998.910016349758;6017.578769486094;5027.421846487628;5082.1360368737405;5096.388433387943;5127;5135.101357262464;3172.682731726855;3173.6826317368077;3199.7600179986594;3201.599800024997;3203.5354873543206;5369.328833895763;5454.536364409069;5504.4770746778995;5531.865967476738;5544.805931792449;6099.359567245376;6137.202163718688;6152;6152.600080994721;6159.5072394208355;5415.052365836042;5504.697241651747;5516.558675306046;5528.612997090246;5559.277293951841;5915.36766139064;5961.2846458425265;6015.699215039143;6016.398360163948;6040.909386359121;5669.177969194526;5902.4097590240635;5914.2311499504785;5918.467337939606;5953.196318496947;5496.422875598005;5532.723363831873;5541.612087153861;5545.584081194007;5559.33288005442;4014.9397759033054;4077.368007958771;4080.2451546464;4092.7544347339253;4105.199486100182;5969.164316995537;5987.700614969147;6060.1212824139375;6101.29835068955;6110.26676798787;5763.8559036024435;5778.306603207642;5799.333076696234;5802.868440654032;5812.360640329645;5738.942610574008;5760.33756118035;5765.94234057654;5812.18629391894;5841.912371314519;5715.399688087342;5749.223854779551;5753.827385178452;5768.2501274834;5780.364159942487;5823.7379317931645;5825.300963884361;5842.591018628826;5856.385079566584;5870.5010074144175;5595.524380427709;5643.125315576092;5650.886982260414;5686.516646084963;5698.948378583624 14:17:24 INFO - PID 8453 | |5;yui.html;735.1105162753068;760.0765070439415;761.6191904047976;775.5385545600369;779.6647441600112;11431.256968297075;11737.47181376838;12643.873561264385;13418.798718019225;13447.932760336196;14880.553583392515;15030;15378.615534611641;15395.538133856002;15418.383264669428;858.4891989266392;877.8727084572765;878.8462019146656;880.102295658428;882.5190271302156;893.5889490834192;893.6157452295511;893.6916763716507;893.8927328720563;895.7133717210495;944.6504793226516;949.0936155971066;949.5679465843059;950.5579905344014;953.980920381592;940.261894412886;941.8728471656307;943.7546237978175;945.0738276489079;945.1682519382933;685.5372623479182;687.6321168175052;687.9140107486564;689.1420181873549;694.1739330197049;13091.672708182276;13345.599632011055;13443.462261509529;13464.730705385935;13763.105398149088;15388.692226155414;15466.376030516747;15683;15777.68444631101;16394.918025409796;11881.465334059989;11932.10509211804;11937.164398492108;11964.102692298113;12052.638420847301;2905.186547766629;2907.592936988823;2926.736593706555;2927.2681829542616;2933.2226959855657;71650.28349716541;72811;73263;73445;74445.62777186134;11807.763844723057;11816.409179540988;11867.347295898635;11874.821877671842;11914.16600837933;20594.27920022822;21141.577168456854;21265.68101478479;21313.68029479559;22589.887050564972;6037.6679282639;6212.254529456494;6256.937430625636;6306.432421082033;6307.369263073656;2882.827030378142;2944.16091413946;2948.9262768430963;2958.275222570484;2965.0808249442744;3488.8604455821483;3531.646835316448;3545.3441113393587;3546.627604101532;3611.494390785292;715.0275625149792;717.1680850213831;718.5509056839476;719.6905330707741;722.9819254518574;577.5033471214751;590.3299754778358;591.482452853753;594.9702514874239;603.6891001134419;9664.71005869825;10461.215408844368;10709.78580428387;10843.295185813055;11103.666889993314;606.5723664816294;615.8675884684815;619.1084837833505;624.1418050181001;625.0093601641358;4512.5261847505535;4620.330052142421;4634.026854360554;4694.741789201558;4781.402324709411;59504.70247648821;59991.400085999456;60639;62692.686536567024;63165;53065.2040219397;54485.72757136189;54793;55112.17331740027;56540.43459565434;46866.5313346869;48218.75890620524;48301.275480867815;49284.75357623189;50398.49601504012;9213.953930230306;10421.561989724643;10462.790744185226;10902.454877256265;11011.28426652265;24474.877625611756;24682.259532214062;25145.87427062853;25196;26483.07309244167;43447;43498.782506087264;44493;44787;44850;13484.258365789976;13714.725705485635;13833.446662133805;13979.860201397856;14044.78932815988;15542.5337239883;15581.610459738597;15761.824864173876;15974.920125399298;16435;13956.2324072177;13975.161490310615;14749.552772808842;14891.851081489047;14899.925500372428;13755.656108597364;13829.308534573433;13992.09051411655;14025;14255.786163207767;13676.589702308947;13706.588802335946;13897.16617002983;13928.860711392756;13936.581902542533;9172.44965302084;9498.287628427757;9847.409155450696;9975.551100200364;9994.400335979864;10948.45257737126;11270.323780573191;11687.88312116868;11864.288142711464;12379 14:17:24 INFO - PID 8453 | __end_tp_report 14:17:24 INFO - PID 8453 | __start_cc_report 14:17:24 INFO - PID 8453 | _x_x_mozilla_cycle_collect,352 14:17:24 INFO - PID 8453 | __end_cc_report 14:17:24 INFO - PID 8453 | __startTimestamp1493846244102__endTimestamp 14:17:24 INFO - PID 8453 | 14:17:24 INFO - PID 8453 | ------- Summary: start ------- 14:17:24 INFO - PID 8453 | Number of tests: 6 14:17:24 INFO - PID 8453 | 14:17:24 INFO - PID 8453 | [#0] dojo.html Cycles:165 Average:5225.60 Median:5341.12 stddev:618.88 (11.6%) stddev-sans-first:588.25 14:17:24 INFO - PID 8453 | Values: 2701.6 2717.6 2728.7 2743.9 2748.9 5188.4 5262.3 5272.1 5279.2 5331.5 5211.1 5282.0 5300.7 5335.4 5387.0 4635.9 4637.3 4641.3 4659.3 4661.6 4650.4 4699.9 4702.9 4705.1 4718.9 4630.8 4685.6 4693.6 4701.2 4732.7 4744.0 4745.2 4759.0 4772.6 4791.9 4682.4 4724.2 4729.2 4729.9 4738.9 5183.7 5237.7 5245.8 5315.3 5322.5 5737.4 5758.3 5788.8 5808.9 5838.0 5771.1 5781.4 5783.7 5789.9 5806.7 5210.2 5277.9 5310.2 5324.5 5325.6 5770.1 5813.7 5824.7 5845.1 5852.1 5579.4 5593.0 5631.7 5652.0 5662.2 5763.2 5766.7 5772.0 5785.9 5791.4 5700.3 5715.7 5724.1 5740.2 5740.9 5570.9 5616.9 5659.8 5696.2 5708.5 4784.8 4794.4 4795.1 4816.7 4822.5 4070.8 4091.8 4093.6 4096.0 4142.7 4842.9 4905.6 4921.3 4923.0 4943.5 5709.5 5739.5 5747.9 5797.1 5807.0 4934.5 4961.7 4974.2 4975.2 4978.2 5117.0 5129.4 5133.4 5137.7 5161.1 5206.3 5305.3 5317.8 5325.0 5359.5 5657.6 5719.2 5730.1 5779.1 5817.5 5286.0 5307.4 5319.8 5327.0 5347.8 5638.6 5663.0 5676.3 5692.1 5749.5 5644.6 5701.4 5716.2 5733.1 5788.4 5515.2 5525.3 5526.7 5532.2 5532.8 5520.6 5521.7 5534.7 5548.0 5548.5 5387.1 5411.4 5464.1 5465.4 5475.9 5560.2 5576.7 5578.1 5582.5 5587.9 5341.1 5392.0 5397.4 5430.2 5454.0 14:17:24 INFO - PID 8453 | 14:17:24 INFO - PID 8453 | [#1] ext.html Cycles:180 Average:30307.88 Median:16757.72 stddev:41234.21 (246.1%) stddev-sans-first:41289.67 14:17:24 INFO - PID 8453 | Values: 632.1 649.9 1046.6 1056.8 1133.1 29625.1 33111.3 33274.3 33570.8 33572.7 30469.8 30719.2 30738.2 30798.2 30825.8 6201.1 6405.4 6517.6 6524.7 6904.4 6915.6 7036.5 7060.4 7063.1 7092.4 6997.6 7049.5 7057.4 7062.6 7103.8 7062.5 7068.2 7077.1 7084.1 7086.4 6807.6 6894.1 6970.8 6983.4 6988.9 31802.8 31944.5 32062.7 32104.7 32135.2 3010.2 3022.1 3037.8 3040.3 3045.6 24236.6 24245.2 24365.3 24404.5 24457.1 2730.4 2743.0 2744.3 2759.8 2770.3 148599.0 149372.0 149853.3 149989.0 150162.0 38590.0 39449.4 39585.2 40898.2 41313.6 41230.4 41230.8 41316.8 41364.2 41502.8 11154.8 11257.4 11265.6 11277.2 11282.7 8677.3 8739.4 8743.0 8784.0 8808.1 12532.2 12548.5 12588.2 12624.4 12786.1 5307.7 5365.1 5399.4 5414.3 5418.4 869.6 902.0 905.0 913.5 931.6 20673.0 21422.7 21511.7 21535.1 21562.4 962.5 979.3 986.7 1003.7 1008.9 10982.8 11237.2 11519.3 11528.4 11532.4 177603.0 179535.0 179635.0 179744.1 181158.0 41677.0 41759.0 41830.8 42084.0 42086.4 1186.5 1227.4 1227.6 1230.7 1237.5 19894.8 20327.7 20736.9 20965.5 21265.6 29971.7 29979.6 30122.0 30174.1 30181.8 139754.3 142417.3 151831.0 152653.0 153238.0 31360.0 31400.8 31573.4 31601.2 31636.3 35347.6 35597.0 36504.8 36791.6 36827.4 27294.3 27875.4 27892.4 27894.7 29603.3 27650.6 27925.3 28165.2 28482.4 29553.0 31348.4 31540.8 31827.5 31849.2 32004.0 25973.9 26945.5 27076.5 27095.7 28540.1 20571.5 22413.9 22639.7 22773.8 22806.7 14:17:24 INFO - PID 8453 | 14:17:24 INFO - PID 8453 | [#2] jquery.html Cycles:180 Average:25928.29 Median:395695.00 stddev:66517.12 (16.8%) stddev-sans-first:66676.13 14:17:24 INFO - PID 8453 | Values: 414.4 425.7 430.9 440.5 446.8 17125.8 17319.3 17746.4 18293.0 18387.7 18405.2 18773.7 18962.0 19122.6 19201.4 5351.8 5363.3 5466.0 5466.6 5524.8 5300.0 5397.8 5456.0 5458.3 5492.8 5447.5 5447.6 5457.3 5463.2 5479.1 5341.9 5343.2 5456.1 5464.5 5469.9 4867.6 4926.1 4938.3 4940.3 4942.1 20848.6 22069.0 22261.3 22279.4 22374.6 1634.6 1677.9 1678.1 1679.1 1680.4 14536.5 14786.9 15073.5 15157.5 15182.0 1986.2 2050.7 2091.5 2099.1 2106.9 81475.0 89120.6 89623.3 99750.5 103695.5 10918.7 11093.3 11270.7 11335.1 11351.4 15505.1 15539.3 15546.0 15551.5 15568.7 7184.8 7429.0 7537.2 7649.9 7715.6 6828.4 6832.0 6857.3 6995.4 7111.4 6686.2 6783.9 6811.5 6811.9 6865.8 2128.2 2140.7 2165.6 2234.6 2473.9 815.5 846.3 847.1 866.9 882.7 16687.4 16766.0 17118.8 17245.5 17449.6 858.2 881.3 887.2 899.9 904.1 8812.3 9212.6 9316.5 9384.9 9516.1 394119.0 397271.0 400800.0 403591.0 404620.0 79625.6 79958.6 80073.6 80615.0 82753.0 1011.9 1048.8 1056.3 1060.4 1061.7 14082.2 14238.6 14425.6 14453.9 14864.1 36878.6 37025.0 37640.4 37889.8 38174.0 48308.9 50067.0 50355.7 50638.2 50755.5 8259.0 8317.5 8525.9 8584.5 8647.6 13400.6 13563.5 13669.5 13744.3 13806.7 10955.4 11000.4 11223.9 11415.3 11521.1 9895.5 10042.7 10044.5 10164.1 10216.2 10754.9 10772.6 10833.5 11111.7 11271.2 8513.7 8536.8 8688.2 8751.3 8793.5 11263.2 11269.5 11300.9 11414.8 11556.1 14:17:24 INFO - PID 8453 | 14:17:24 INFO - PID 8453 | [#3] mootools.html Cycles:180 Average:5929.37 Median:4892.16 stddev:3706.67 (75.8%) stddev-sans-first:3699.84 14:17:24 INFO - PID 8453 | Values: 1173.7 1177.6 1191.4 1195.4 1203.6 9002.5 9475.2 9492.4 9527.9 9671.5 9546.9 9697.2 9729.6 9743.8 9753.8 2139.5 2170.2 2181.5 2183.2 2185.8 2102.2 2120.1 2121.7 2135.9 2151.0 2125.9 2149.2 2162.7 2171.8 2179.1 2053.4 2094.0 2102.2 2111.6 2112.3 1988.7 2015.5 2070.3 2120.5 2126.2 9613.4 9656.6 9674.0 9707.0 9733.7 5310.5 5504.6 5563.1 5579.3 5589.9 3085.4 3289.9 3310.8 3341.8 3379.5 1009.1 1052.9 1055.0 1075.5 1094.5 13469.2 13484.0 13530.5 13650.0 13681.7 4548.5 4578.1 4711.0 4868.5 4875.0 9997.7 10080.1 10084.2 10086.8 10093.6 5198.5 5231.7 5260.0 5271.8 5272.7 4789.6 4803.3 4909.3 4924.5 4933.7 3767.1 3774.8 3825.3 3900.7 3920.9 1124.7 1127.6 1128.0 1138.3 1141.1 699.8 712.1 725.7 726.6 740.6 5164.0 5173.2 5354.1 5398.1 5438.1 560.8 567.3 567.5 573.7 573.8 3448.6 3512.6 3721.5 3884.5 3923.5 12043.3 12284.6 12446.9 12589.7 12616.9 12020.2 12167.5 12339.8 12342.4 12393.3 6960.2 7066.7 7246.6 7271.2 7298.4 5673.4 5673.7 5761.6 5892.1 5895.1 10945.5 10953.5 10967.2 11037.4 11085.9 11120.0 11245.6 11348.4 11481.9 11534.4 6968.7 7127.4 7129.5 7159.7 7178.5 8922.2 9020.8 9062.6 9087.0 9096.0 7610.2 7776.0 7819.5 7876.9 8002.9 7625.8 7631.4 7678.5 7861.2 7920.4 6794.4 6949.0 6992.5 7002.9 7005.0 5159.2 5187.9 5230.7 5279.7 5313.9 5193.1 5411.7 5492.0 5498.7 5584.9 14:17:24 INFO - PID 8453 | 14:17:24 INFO - PID 8453 | [#4] prototype.html Cycles:180 Average:4845.25 Median:5366.91 stddev:1369.71 (25.5%) stddev-sans-first:1331.84 14:17:24 INFO - PID 8453 | Values: 375.9 395.1 397.2 402.5 403.9 5324.2 5484.0 5549.6 5593.4 5607.3 5341.5 5470.3 5483.3 5501.5 5513.2 4322.8 4324.8 4337.8 4346.3 4351.4 4243.4 4335.9 4350.8 4361.0 4377.7 4297.2 4303.3 4308.8 4317.6 4327.8 4315.2 4317.0 4323.5 4339.7 4340.8 3768.3 3936.9 3948.8 3957.2 3957.6 5340.8 5361.8 5363.4 5364.5 5381.7 5118.4 5125.3 5125.7 5131.6 5146.5 5681.6 5832.0 5837.3 5839.3 5853.9 4353.0 4366.5 4374.8 4386.2 4387.5 5927.8 6107.5 6110.1 6206.6 6244.6 4284.8 4311.7 4321.5 4322.2 4341.9 4386.5 4393.3 4396.5 4400.4 4404.0 4923.6 4956.3 4985.5 4987.2 4990.9 5790.4 5808.5 5811.6 5822.3 5843.5 1571.8 1578.5 1578.9 1581.7 1588.2 1141.7 1159.9 1163.7 1174.9 1185.3 5074.4 5078.6 5081.5 5097.4 5102.9 5846.7 5956.4 5992.8 5998.9 6017.6 5027.4 5082.1 5096.4 5127.0 5135.1 3172.7 3173.7 3199.8 3201.6 3203.5 5369.3 5454.5 5504.5 5531.9 5544.8 6099.4 6137.2 6152.0 6152.6 6159.5 5415.1 5504.7 5516.6 5528.6 5559.3 5915.4 5961.3 6015.7 6016.4 6040.9 5669.2 5902.4 5914.2 5918.5 5953.2 5496.4 5532.7 5541.6 5545.6 5559.3 4014.9 4077.4 4080.2 4092.8 4105.2 5969.2 5987.7 6060.1 6101.3 6110.3 5763.9 5778.3 5799.3 5802.9 5812.4 5738.9 5760.3 5765.9 5812.2 5841.9 5715.4 5749.2 5753.8 5768.3 5780.4 5823.7 5825.3 5842.6 5856.4 5870.5 5595.5 5643.1 5650.9 5686.5 5698.9 14:17:24 INFO - PID 8453 | 14:17:24 INFO - PID 8453 | [#5] yui.html Cycles:180 Average:15300.81 Median:3545.99 stddev:18132.29 (511.3%) stddev-sans-first:18150.17 14:17:24 INFO - PID 8453 | Values: 735.1 760.1 761.6 775.5 779.7 11431.3 11737.5 12643.9 13418.8 13447.9 14880.6 15030.0 15378.6 15395.5 15418.4 858.5 877.9 878.8 880.1 882.5 893.6 893.6 893.7 893.9 895.7 944.7 949.1 949.6 950.6 954.0 940.3 941.9 943.8 945.1 945.2 685.5 687.6 687.9 689.1 694.2 13091.7 13345.6 13443.5 13464.7 13763.1 15388.7 15466.4 15683.0 15777.7 16394.9 11881.5 11932.1 11937.2 11964.1 12052.6 2905.2 2907.6 2926.7 2927.3 2933.2 71650.3 72811.0 73263.0 73445.0 74445.6 11807.8 11816.4 11867.3 11874.8 11914.2 20594.3 21141.6 21265.7 21313.7 22589.9 6037.7 6212.3 6256.9 6306.4 6307.4 2882.8 2944.2 2948.9 2958.3 2965.1 3488.9 3531.6 3545.3 3546.6 3611.5 715.0 717.2 718.6 719.7 723.0 577.5 590.3 591.5 595.0 603.7 9664.7 10461.2 10709.8 10843.3 11103.7 606.6 615.9 619.1 624.1 625.0 4512.5 4620.3 4634.0 4694.7 4781.4 59504.7 59991.4 60639.0 62692.7 63165.0 53065.2 54485.7 54793.0 55112.2 56540.4 46866.5 48218.8 48301.3 49284.8 50398.5 9214.0 10421.6 10462.8 10902.5 11011.3 24474.9 24682.3 25145.9 25196.0 26483.1 43447.0 43498.8 44493.0 44787.0 44850.0 13484.3 13714.7 13833.4 13979.9 14044.8 15542.5 15581.6 15761.8 15974.9 16435.0 13956.2 13975.2 14749.6 14891.9 14899.9 13755.7 13829.3 13992.1 14025.0 14255.8 13676.6 13706.6 13897.2 13928.9 13936.6 9172.4 9498.3 9847.4 9975.6 9994.4 10948.5 11270.3 11687.9 11864.3 12379.0 14:17:24 INFO - PID 8453 | -------- Summary: end -------- 14:17:24 INFO - PID 8453 | 14:17:24 INFO - TEST-INFO | 8453: exit 0 14:17:24 INFO - TEST-OK | dromaeo_css | took 1119530ms 14:17:24 INFO - TEST-START | kraken 14:17:24 INFO - operating with platform_type : linux_ 14:17:24 INFO - Initialising browser for kraken test... 14:17:24 INFO - TEST-INFO | started process 8843 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppKWlH2/profile http://localhost:46943/getInfo.html) 14:17:29 INFO - PID 8843 | __metrics Screen width/height:1600/1200 14:17:29 INFO - PID 8843 | colorDepth:24 14:17:29 INFO - PID 8843 | Browser inner width/height: 1024/695 14:17:29 INFO - PID 8843 | __metrics 14:17:31 INFO - TEST-INFO | 8843: exit 0 14:17:31 INFO - Browser initialized. 14:17:31 INFO - Running cycle 1/1 for kraken test... 14:17:31 INFO - TEST-INFO | started process 8975 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppKWlH2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:17:43 INFO - PID 8975 | RSS: Main: 161292288 14:17:43 INFO - PID 8975 | 14:17:45 INFO - PID 8975 | Cycle 1(1): loaded http://localhost:46943/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46943/tests/kraken/driver.html?testName=audio-beat-detection) 14:17:46 INFO - PID 8975 | RSS: Main: 166182912 14:17:46 INFO - PID 8975 | 14:17:49 INFO - PID 8975 | Cycle 1(1): loaded http://localhost:46943/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46943/tests/kraken/driver.html?testName=audio-dft) 14:17:50 INFO - PID 8975 | RSS: Main: 164450304 14:17:50 INFO - PID 8975 | 14:17:53 INFO - PID 8975 | Cycle 1(1): loaded http://localhost:46943/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46943/tests/kraken/driver.html?testName=audio-fft) 14:17:53 INFO - PID 8975 | RSS: Main: 161734656 14:17:53 INFO - PID 8975 | 14:17:55 INFO - PID 8975 | Cycle 1(1): loaded http://localhost:46943/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46943/tests/kraken/driver.html?testName=audio-oscillator) 14:17:56 INFO - PID 8975 | RSS: Main: 162029568 14:17:56 INFO - PID 8975 | 14:17:58 INFO - PID 8975 | Cycle 1(1): loaded http://localhost:46943/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46943/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:17:59 INFO - PID 8975 | RSS: Main: 162787328 14:17:59 INFO - PID 8975 | 14:18:02 INFO - PID 8975 | Cycle 1(1): loaded http://localhost:46943/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46943/tests/kraken/driver.html?testName=imaging-darkroom) 14:18:03 INFO - PID 8975 | RSS: Main: 168038400 14:18:03 INFO - PID 8975 | 14:18:06 INFO - PID 8975 | Cycle 1(1): loaded http://localhost:46943/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46943/tests/kraken/driver.html?testName=imaging-desaturate) 14:18:07 INFO - PID 8975 | RSS: Main: 165789696 14:18:07 INFO - PID 8975 | 14:18:10 INFO - PID 8975 | Cycle 1(1): loaded http://localhost:46943/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46943/tests/kraken/driver.html?testName=json-parse-financial) 14:18:10 INFO - PID 8975 | RSS: Main: 166707200 14:18:10 INFO - PID 8975 | 14:18:12 INFO - PID 8975 | Cycle 1(1): loaded http://localhost:46943/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46943/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:18:12 INFO - PID 8975 | RSS: Main: 166494208 14:18:12 INFO - PID 8975 | 14:18:14 INFO - PID 8975 | Cycle 1(1): loaded http://localhost:46943/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46943/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:18:15 INFO - PID 8975 | RSS: Main: 166547456 14:18:15 INFO - PID 8975 | 14:18:17 INFO - PID 8975 | Cycle 1(1): loaded http://localhost:46943/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46943/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:18:18 INFO - PID 8975 | RSS: Main: 166465536 14:18:18 INFO - PID 8975 | 14:18:20 INFO - PID 8975 | Cycle 1(1): loaded http://localhost:46943/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46943/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:18:21 INFO - PID 8975 | RSS: Main: 167129088 14:18:21 INFO - PID 8975 | 14:18:24 INFO - PID 8975 | Cycle 1(1): loaded http://localhost:46943/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46943/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:18:25 INFO - PID 8975 | RSS: Main: 166838272 14:18:25 INFO - PID 8975 | 14:18:27 INFO - PID 8975 | Cycle 1(1): loaded http://localhost:46943/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46943/tests/kraken/driver.html?testName=ai-astar) 14:18:27 INFO - PID 8975 | RSS: Main: 168337408 14:18:27 INFO - PID 8975 | 14:18:27 INFO - PID 8975 | __start_tp_report 14:18:27 INFO - PID 8975 | _x_x_mozilla_page_load 14:18:27 INFO - PID 8975 | _x_x_mozilla_page_load_details 14:18:27 INFO - PID 8975 | |i|pagename|runs| 14:18:27 INFO - PID 8975 | |0;ai-astar;104;111;111;112;113;112;112;112;112;112 14:18:27 INFO - PID 8975 | |1;audio-beat-detection;155;124;131;171;124;124;124;124;147;122 14:18:27 INFO - PID 8975 | |2;audio-dft;163;165;164;165;166;168;166;167;164;162 14:18:27 INFO - PID 8975 | |3;audio-fft;75;76;74;113;76;75;75;76;99;76 14:18:27 INFO - PID 8975 | |4;audio-oscillator;86;87;100;83;82;82;112;84;83;111 14:18:27 INFO - PID 8975 | |5;imaging-gaussian-blur;114;114;114;114;113;115;114;116;115;115 14:18:27 INFO - PID 8975 | |6;imaging-darkroom;151;150;151;150;150;152;151;150;152;151 14:18:27 INFO - PID 8975 | |7;imaging-desaturate;94;94;95;95;94;95;94;94;95;94 14:18:27 INFO - PID 8975 | |8;json-parse-financial;54;57;54;56;55;56;56;54;56;55 14:18:27 INFO - PID 8975 | |9;json-stringify-tinderbox;55;54;55;55;57;62;55;57;57;55 14:18:27 INFO - PID 8975 | |10;stanford-crypto-aes;81;82;81;89;84;91;84;85;82;89 14:18:27 INFO - PID 8975 | |11;stanford-crypto-ccm;132;132;154;147;133;137;139;133;182;135 14:18:27 INFO - PID 8975 | |12;stanford-crypto-pbkdf2;189;191;190;199;187;207;194;187;192;189 14:18:27 INFO - PID 8975 | |13;stanford-crypto-sha256-iterative;73;72;72;74;72;73;71;72;72;75 14:18:27 INFO - PID 8975 | __end_tp_report 14:18:27 INFO - PID 8975 | __start_cc_report 14:18:27 INFO - PID 8975 | _x_x_mozilla_cycle_collect,834 14:18:27 INFO - PID 8975 | __end_cc_report 14:18:27 INFO - PID 8975 | __startTimestamp1493846307495__endTimestamp 14:18:27 INFO - PID 8975 | 14:18:27 INFO - PID 8975 | ------- Summary: start ------- 14:18:27 INFO - PID 8975 | Number of tests: 14 14:18:27 INFO - PID 8975 | 14:18:27 INFO - PID 8975 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.56 (2.3%) stddev-sans-first:0.60 14:18:27 INFO - PID 8975 | Values: 104.0 111.0 111.0 112.0 113.0 112.0 112.0 112.0 112.0 112.0 14:18:27 INFO - PID 8975 | 14:18:27 INFO - PID 8975 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:127.50 stddev:17.09 (13.4%) stddev-sans-first:16.45 14:18:27 INFO - PID 8975 | Values: 155.0 124.0 131.0 171.0 124.0 124.0 124.0 124.0 147.0 122.0 14:18:27 INFO - PID 8975 | 14:18:27 INFO - PID 8975 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.50 stddev:1.83 (1.1%) stddev-sans-first:1.79 14:18:27 INFO - PID 8975 | Values: 163.0 165.0 164.0 165.0 166.0 168.0 166.0 167.0 164.0 162.0 14:18:27 INFO - PID 8975 | 14:18:27 INFO - PID 8975 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.00 stddev:13.34 (17.6%) stddev-sans-first:13.94 14:18:27 INFO - PID 8975 | Values: 75.0 76.0 74.0 113.0 76.0 75.0 75.0 76.0 99.0 76.0 14:18:27 INFO - PID 8975 | 14:18:27 INFO - PID 8975 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:83.00 stddev:12.03 (14.5%) stddev-sans-first:12.62 14:18:27 INFO - PID 8975 | Values: 86.0 87.0 100.0 83.0 82.0 82.0 112.0 84.0 83.0 111.0 14:18:27 INFO - PID 8975 | 14:18:27 INFO - PID 8975 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:0.84 (0.7%) stddev-sans-first:0.88 14:18:27 INFO - PID 8975 | Values: 114.0 114.0 114.0 114.0 113.0 115.0 114.0 116.0 115.0 115.0 14:18:27 INFO - PID 8975 | 14:18:27 INFO - PID 8975 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 14:18:27 INFO - PID 8975 | Values: 151.0 150.0 151.0 150.0 150.0 152.0 151.0 150.0 152.0 151.0 14:18:27 INFO - PID 8975 | 14:18:27 INFO - PID 8975 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:18:27 INFO - PID 8975 | Values: 94.0 94.0 95.0 95.0 94.0 95.0 94.0 94.0 95.0 94.0 14:18:27 INFO - PID 8975 | 14:18:27 INFO - PID 8975 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:56.00 stddev:1.06 (1.9%) stddev-sans-first:1.01 14:18:27 INFO - PID 8975 | Values: 54.0 57.0 54.0 56.0 55.0 56.0 56.0 54.0 56.0 55.0 14:18:27 INFO - PID 8975 | 14:18:27 INFO - PID 8975 | [#9] json-stringify-tinderbox Cycles:10 Average:56.20 Median:56.00 stddev:2.30 (4.1%) stddev-sans-first:2.40 14:18:27 INFO - PID 8975 | Values: 55.0 54.0 55.0 55.0 57.0 62.0 55.0 57.0 57.0 55.0 14:18:27 INFO - PID 8975 | 14:18:27 INFO - PID 8975 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:84.50 stddev:3.65 (4.3%) stddev-sans-first:3.60 14:18:27 INFO - PID 8975 | Values: 81.0 82.0 81.0 89.0 84.0 91.0 84.0 85.0 82.0 89.0 14:18:27 INFO - PID 8975 | 14:18:27 INFO - PID 8975 | [#11] stanford-crypto-ccm Cycles:10 Average:142.40 Median:138.00 stddev:15.68 (11.4%) stddev-sans-first:16.17 14:18:27 INFO - PID 8975 | Values: 132.0 132.0 154.0 147.0 133.0 137.0 139.0 133.0 182.0 135.0 14:18:27 INFO - PID 8975 | 14:18:27 INFO - PID 8975 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.50 Median:191.50 stddev:6.22 (3.2%) stddev-sans-first:6.47 14:18:27 INFO - PID 8975 | Values: 189.0 191.0 190.0 199.0 187.0 207.0 194.0 187.0 192.0 189.0 14:18:27 INFO - PID 8975 | 14:18:27 INFO - PID 8975 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:72.50 stddev:1.17 (1.6%) stddev-sans-first:1.24 14:18:27 INFO - PID 8975 | Values: 73.0 72.0 72.0 74.0 72.0 73.0 71.0 72.0 72.0 75.0 14:18:27 INFO - PID 8975 | -------- Summary: end -------- 14:18:27 INFO - PID 8975 | 14:18:28 INFO - TEST-INFO | 8975: exit 0 14:18:28 INFO - TEST-OK | kraken | took 63910ms 14:18:28 INFO - SUITE-END | took 1183s 14:18:29 INFO - Completed test suite (00:19:43) 14:18:29 INFO - javascript benchmark 14:18:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6693.875671826004, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2701.6217729517866, 2717.605947137664, 2728.672559292885, 2743.8628068596577, 2748.8900443982243, 5188.37739471263, 5262.263283140359, 5272.051030814452, 5279.181726832342, 5331.546818520425, 5211.114110601197, 5281.973590132044, 5300.681959082448, 5335.359756829176, 5387.0, 4635.930461043087, 4637.304404339342, 4641.257398816173, 4659.301104834268, 4661.5804577588015, 4650.441946966352, 4699.90600187996, 4702.858914232578, 4705.082508910764, 4718.882027949311, 4630.791614377361, 4685.648576356787, 4693.6010439112715, 4701.224297990828, 4732.668713190078, 4743.952560474386, 4745.193317136095, 4759.048190361941, 4772.5943294819635, 4791.856244312677, 4682.391289132391, 4724.173269677827, 4729.172394830925, 4729.858104256878, 4738.857834264978, 5183.714895680736, 5237.738113094369, 5245.842624721265, 5315.282436871012, 5322.547583455411, 5737.3975732548315, 5758.337791154029, 5788.82633520995, 5808.8838223235725, 5838.036723940587, 5771.105478650816, 5781.421857814227, 5783.71081445926, 5789.942100578983, 5806.65160090396, 5210.166373380241, 5277.920831187535, 5310.176922577007, 5324.494173053554, 5325.573954083741, 5770.105633626795, 5813.651180929073, 5824.708764561755, 5845.1232315153065, 5852.063669812809, 5579.414161513064, 5593.049181639131, 5631.662100273997, 5651.971740141273, 5662.235598194274, 5763.221965034667, 5766.740496677659, 5771.971140144273, 5785.8553536161935, 5791.362950075572, 5700.287464066992, 5715.742791574389, 5724.141378793214, 5740.167675687002, 5740.913886291709, 5570.916436253459, 5616.943830561642, 5659.830205093854, 5696.202531645573, 5708.54331653475, 4784.832530861403, 4794.400699912511, 4795.088933102769, 4816.710997340171, 4822.469528351879, 4070.8371665133063, 4091.8363265469047, 4093.5906409358827, 4095.9795201023803, 4142.730722503027, 4842.878928026827, 4905.55849973497, 4921.335619691367, 4922.950770492249, 4943.4809345018975, 5709.514691251207, 5739.483446489836, 5747.8563035924435, 5797.130430435384, 5807.01280782268, 4934.4572097069295, 4961.677490963076, 4974.1543937530705, 4975.154223781893, 4978.178600530944, 5116.9744151279, 5129.435762066244, 5133.383993920679, 5137.743112844418, 5161.096808058574, 5206.349206349207, 5305.257263983045, 5317.787288508416, 5324.9733751331, 5359.517643412034, 5657.60396772222, 5719.199312096227, 5730.111832665943, 5779.075347944308, 5817.5345972321265, 5285.973570132125, 5307.363116426053, 5319.813806516753, 5326.97336513315, 5347.839564813062, 5638.633488823213, 5662.952353814558, 5676.290463692038, 5692.0608099663095, 5749.482546570829, 5644.6330988485615, 5701.4298570142655, 5716.228309178207, 5733.111367738007, 5788.421157884178, 5515.22786809855, 5525.309336332958, 5526.668399896019, 5532.2254884317035, 5532.751026203911, 5520.641158324696, 5521.723913804213, 5534.667919924817, 5548.0, 5548.528375088163, 5387.111126664056, 5411.350637923474, 5464.1257398816, 5465.398806131402, 5475.917861232005, 5560.165975103605, 5576.749046293007, 5578.051731205624, 5582.469665381782, 5587.916181257203, 5341.118715411913, 5392.029434701792, 5397.379301380392, 5430.239766432624, 5454.0], "value": 5179.923746042658, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.1150389454764, 649.8602800397915, 1046.5813674530186, 1056.8097742406364, 1133.1331531378503, 29625.111246662582, 33111.33777324452, 33274.33451330975, 33570.83214583924, 33572.66427335726, 30469.84765076177, 30719.232019199477, 30738.231544211405, 30798.230044248907, 30825.845870770616, 6201.069839524062, 6405.423511883918, 6517.608943463384, 6524.673766311689, 6904.4131248843905, 6915.585064896122, 7036.542624729376, 7060.435165186773, 7063.117110361205, 7092.361687448129, 6997.580145191305, 7049.541779784297, 7057.364837164654, 7062.646867656622, 7103.751368702096, 7062.5056246062795, 7068.222495525488, 7077.079979602619, 7084.114485689289, 7086.362227399533, 6807.5575087619645, 6894.069300644399, 6970.756023539152, 6983.3714965653335, 6988.860222795515, 31802.840985795156, 31944.520832187303, 32062.679373206203, 32104.678953210638, 32135.196620084684, 3010.1571559963245, 3022.123584160591, 3037.7569794416395, 3040.331127152045, 3045.5888455058507, 24236.636450453258, 24245.151419700225, 24365.269041928594, 24404.511909761706, 24457.143999959917, 2730.358365784039, 2742.9588556171475, 2744.31392151962, 2759.806813523054, 2770.3074231442138, 148599.0, 149372.0, 149853.25073374563, 149989.0, 150162.0, 38590.0, 39449.40825887614, 39585.20829583392, 40898.1820363591, 41313.586864131576, 41230.38154427686, 41230.79384603058, 41316.79341603333, 41364.172716546105, 41502.79248603798, 11154.832677509843, 11257.380844053656, 11265.605703800327, 11277.154213433862, 11282.661520154408, 8677.349198810114, 8739.38824282294, 8742.956285218534, 8784.0, 8808.11918808114, 12532.185407948455, 12548.498060077494, 12588.244705317711, 12624.368781560885, 12786.10497265201, 5307.7080760557765, 5365.141577347606, 5399.37907140676, 5414.3232095988005, 5418.376886658006, 869.5912920927154, 901.9594118264694, 904.9592768325441, 913.4519288427024, 931.5714771205186, 20672.966351682357, 21422.678659820114, 21511.67732484014, 21535.13859445636, 21562.353129406143, 962.4946902875906, 979.2900147393225, 986.7483791633088, 1003.7440452684665, 1008.9142422893989, 10982.835257471144, 11237.157213209042, 11519.30884146954, 11528.423578821026, 11532.423378831025, 177603.0, 179535.0, 179635.0, 179744.10127949275, 181158.0, 41677.0, 41759.0, 41830.79084604557, 42084.0, 42086.36870446946, 1186.526485492816, 1227.4292454008928, 1227.5703503773786, 1230.723087305367, 1237.4802582915197, 19894.801051989874, 20327.695084573446, 20736.896315518326, 20965.475863103544, 21265.574688505832, 29971.70028299689, 29979.550306745852, 30122.0, 30174.09477715672, 30181.849090754407, 139754.30122849322, 142417.28791355976, 151831.0, 152653.0, 153238.0, 31360.0, 31400.842995784875, 31573.36853262876, 31601.20996975094, 31636.305465015597, 35347.64652353444, 35597.0, 36504.81747591245, 36791.63208367882, 36827.447588286734, 27294.31764205831, 27875.44249115047, 27892.44215115727, 27894.721052790024, 29603.259918502208, 27650.5852412218, 27925.301867452665, 28165.15504534867, 28482.430351393272, 29553.0, 31348.37303253968, 31540.842295788374, 31827.522587161675, 31849.203769905936, 32004.0, 25973.870130649226, 26945.461090777684, 27076.45847083087, 27095.72904270932, 28540.143795686163, 20571.4857128573, 22413.87930603431, 22639.660405093608, 22773.772262277827, 22806.657900131842], "value": 14391.341625006587, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.3825699707433, 425.65390838722857, 430.93535969604557, 440.45603679455866, 446.76321549578734, 17125.82874171258, 17319.30722771089, 17746.378876739316, 18293.0, 18387.724184137216, 18405.171767270473, 18773.718394224063, 18962.0, 19122.61754764904, 19201.42395728127, 5351.759170837302, 5363.329583802025, 5466.01611709894, 5466.590005749565, 5524.8342549723575, 5300.0, 5397.811076612319, 5456.0, 5458.344998600153, 5492.835214943558, 5447.455254474541, 5447.645903016291, 5457.263269458632, 5463.153211252243, 5479.0959491683825, 5341.866453338659, 5343.171808369709, 5456.127019676833, 5464.508194262516, 5469.890602187954, 4867.610591152699, 4926.088673595396, 4938.333325001151, 4940.333055037596, 4942.085714142859, 20848.583028339348, 22069.0, 22261.332160035225, 22279.443013924618, 22374.55250894989, 1634.5831812887757, 1677.9244933978, 1678.1189875315436, 1679.0597265531342, 1680.420255012019, 14536.491222807152, 14786.852131478656, 15073.47242846506, 15157.545273641808, 15182.0, 1986.2352994097232, 2050.7436570428695, 2091.5294058836794, 2099.086897199708, 2106.9157233710635, 81475.0, 89120.55439722825, 89623.34896463483, 99750.50124749403, 103695.48152259341, 10918.672439826818, 11093.33439993603, 11270.661880143609, 11335.14986376025, 11351.432428378548, 15505.069695818287, 15539.300731466885, 15546.0, 15551.455699050479, 15568.730566580918, 7184.784456466315, 7429.0, 7537.170911199763, 7649.923500764921, 7715.575643339558, 6828.351306625863, 6832.0, 6857.27998560154, 6995.440364770806, 7111.439881642605, 6686.197656281277, 6783.93216067833, 6811.4550835933005, 6811.863762724718, 6865.759698410531, 2128.223198532555, 2140.7003019577273, 2165.577712346109, 2234.5530893820974, 2473.8639374834197, 815.5392203405057, 846.3144852669358, 847.1443841719907, 866.925012983908, 882.6557642519423, 16687.415940442028, 16766.0, 17118.828811711974, 17245.482635520955, 17449.563760905825, 858.2318824651902, 881.3213825354442, 887.1527691055027, 899.8515244984504, 904.0642934562827, 8812.295016398673, 9212.63149474027, 9316.534173291444, 9384.8592271116, 9516.095970882756, 394119.0, 397271.0, 400800.0, 403591.0, 404620.0, 79625.60187199026, 79958.60020699976, 80073.59963200147, 80615.0, 82753.0, 1011.8532812742111, 1048.816457120001, 1056.2553399853084, 1060.4432672846663, 1061.7133373989134, 14082.225477598831, 14238.572842814732, 14425.63935901569, 14453.927730361282, 14864.108153510824, 36878.63121368859, 37025.0, 37640.43539346857, 37889.81055094707, 38174.0, 48308.938397396036, 50067.0, 50355.74110647263, 50638.2404263929, 50755.49244507508, 8259.0, 8317.542535160625, 8525.888050861267, 8584.527850968258, 8647.610857511552, 13400.597982060553, 13563.457461701422, 13669.521566745116, 13744.312784360542, 13806.723865522432, 10955.397453140155, 11000.394978276272, 11223.887761122285, 11415.344775007412, 11521.135914806255, 9895.50522473859, 10042.748931276485, 10044.49777511107, 10164.13604843567, 10216.1827053837, 10754.892451075702, 10772.569097236023, 10833.458327083772, 11111.666650000512, 11271.211015229183, 8513.702020429255, 8536.829263414822, 8688.174623410765, 8751.343649226206, 8793.516356600448, 11263.211575189658, 11269.549218031187, 11300.94349528247, 11414.771704565695, 11556.133290003452], "value": 8877.34310472129, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1173.7405494423238, 1177.6467059882036, 1191.3804821492818, 1195.3545085653745, 1203.6028110723462, 9002.549872506374, 9475.24198064155, 9492.382995105314, 9527.904720952789, 9671.468069256189, 9546.90453095469, 9697.175740062086, 9729.562169702363, 9743.805123897519, 9753.804923901518, 2139.475828422039, 2170.218721260345, 2181.5091604388963, 2183.1922188790168, 2185.7814218578096, 2102.180149741602, 2120.07776617172, 2121.66053431451, 2135.882526461044, 2151.032035583986, 2125.8830764308036, 2149.1725685610995, 2162.697222388867, 2171.7936796004433, 2179.1174574297356, 2053.3634573282256, 2094.0472085201272, 2102.1906565972135, 2111.5776844631137, 2112.324056301984, 1988.6619274723332, 2015.516276093727, 2070.254708305009, 2120.5016821047043, 2126.2239282661717, 9613.375130616487, 9656.565454554491, 9674.0, 9707.029297070307, 9733.659321923698, 5310.468953104697, 5504.587155963319, 5563.13771365439, 5579.274694289757, 5589.888202235973, 3085.3674996625637, 3289.917752056194, 3310.817905015223, 3341.799492030486, 3379.509971054208, 1009.1220638044948, 1052.878918924326, 1054.9630762923337, 1075.542894269932, 1094.4691824465128, 13469.191848489025, 13484.0, 13530.526431574848, 13650.0, 13681.657958551017, 4548.545145485425, 4578.107269082497, 4711.0, 4868.464468908417, 4874.975625121851, 9997.700068997941, 10080.092791648787, 10084.193264538819, 10086.798264034678, 10093.646722364681, 5198.532132108128, 5231.71225582589, 5260.0, 5271.841844744664, 5272.710000949908, 4789.592884604778, 4803.255495398219, 4909.337239472697, 4924.507549245047, 4933.654644174873, 3767.1335592813807, 3774.7735135891385, 3825.254075455315, 3900.6684431823046, 3920.882373528799, 1124.651358078998, 1127.5997021057572, 1128.0355296221776, 1138.3340745663713, 1141.0700279272367, 699.8355386484172, 712.1454254894044, 725.7133432294214, 726.5604309392742, 740.6407892172292, 5164.0, 5173.198154286091, 5354.063038968243, 5398.1093119634825, 5438.102713052302, 560.842963970089, 567.3475503171386, 567.5119397318302, 573.6758731316793, 573.7618888161367, 3448.637893021247, 3512.613612502623, 3721.5348081489815, 3884.533855937306, 3923.509561304837, 12043.277403355827, 12284.570040048735, 12446.875531244752, 12589.685257868627, 12616.936915315364, 12020.158588898694, 12167.513299468099, 12339.814902776287, 12342.382880856101, 12393.256404615751, 6960.234374218832, 7066.717331306793, 7246.601436920914, 7271.2365201653065, 7298.416126709851, 5673.4114447954635, 5673.659580425187, 5761.567882408753, 5892.086726557391, 5895.14520394549, 10945.452727363441, 10953.507092180711, 10967.177461690246, 11037.448127593749, 11085.944570277097, 11120.0, 11245.606403775828, 11348.375839328915, 11481.885181148082, 11534.365609891536, 6968.721251149897, 7127.429805615642, 7129.465290103367, 7159.677814498256, 7178.461615378972, 8922.152395522415, 9020.774480638036, 9062.592183351633, 9087.0, 9096.0, 7610.238976102567, 7776.0, 7819.530828150329, 7876.881846772418, 8002.879956800536, 7625.809354766176, 7631.3894888407685, 7678.500897441649, 7861.213878612093, 7920.366370690215, 6794.422474089758, 6948.992396102638, 6992.510524263253, 7002.894956575554, 7004.964975175091, 5159.2003239497935, 5187.948120518747, 5230.686158830483, 5279.683219006872, 5313.867153321198, 5193.117170081171, 5411.675299482044, 5492.0, 5498.697571633598, 5584.888302234014], "value": 4489.877562197704, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.8834761224021, 395.12479857116483, 397.2075708960624, 402.49084907591885, 403.8626866865265, 5324.227986941891, 5484.0, 5549.556035517159, 5593.440655934404, 5607.299087614048, 5341.492558206974, 5470.261514695515, 5483.259759932408, 5501.5323697485765, 5513.228148059265, 4322.762248076362, 4324.84863029794, 4337.826486940535, 4346.326319420495, 4351.3690514875325, 4243.405923170759, 4335.872673104999, 4350.80421381037, 4360.956390436103, 4377.687977342315, 4297.183535128332, 4303.33298338758, 4308.784560771965, 4317.568243175689, 4327.783610819462, 4315.223259813232, 4316.97841510792, 4323.524412314643, 4339.717918335314, 4340.848070317524, 3768.3028639701743, 3936.9212615747524, 3948.802559871995, 3957.168994511156, 3957.6438120569, 5340.786368545254, 5361.785528578891, 5363.436839131874, 5364.490373414519, 5381.650192737459, 5118.38579370478, 5125.282460455539, 5125.692458452505, 5131.639445854911, 5146.459621739701, 5681.630694004876, 5831.970840145815, 5837.270341207349, 5839.328477225088, 5853.912191317134, 4352.956470435287, 4366.541513141106, 4374.759388233646, 4386.232409328355, 4387.495438024636, 5927.762889484416, 6107.480864126599, 6110.114033465167, 6206.596571222856, 6244.6253224806205, 4284.807183676742, 4311.676624253194, 4321.546237645002, 4322.24360736876, 4341.891452713708, 4386.517483076859, 4393.253146965024, 4396.472423309159, 4400.361947517592, 4403.977980110143, 4923.630727695438, 4956.281339205795, 4985.52637499437, 4987.202047672355, 4990.850274491771, 5790.42095790426, 5808.477237048602, 5811.564132690065, 5822.301323841166, 5843.5325173985975, 1571.7642353647045, 1578.5106616948783, 1578.8657964073182, 1581.675756469921, 1588.1662127382986, 1141.6746227325173, 1159.9154790271123, 1163.7148898519747, 1174.9177557570888, 1185.271058299157, 5074.441811400743, 5078.644494885397, 5081.4918508148885, 5097.413797413271, 5102.923456148161, 5846.736896839652, 5956.374580668968, 5992.760289588367, 5998.910016349758, 6017.578769486094, 5027.421846487628, 5082.1360368737405, 5096.388433387943, 5127.0, 5135.101357262464, 3172.682731726855, 3173.6826317368077, 3199.7600179986594, 3201.599800024997, 3203.5354873543206, 5369.328833895763, 5454.536364409069, 5504.4770746778995, 5531.865967476738, 5544.805931792449, 6099.359567245376, 6137.202163718688, 6152.0, 6152.600080994721, 6159.5072394208355, 5415.052365836042, 5504.697241651747, 5516.558675306046, 5528.612997090246, 5559.277293951841, 5915.36766139064, 5961.2846458425265, 6015.699215039143, 6016.398360163948, 6040.909386359121, 5669.177969194526, 5902.4097590240635, 5914.2311499504785, 5918.467337939606, 5953.196318496947, 5496.422875598005, 5532.723363831873, 5541.612087153861, 5545.584081194007, 5559.33288005442, 4014.9397759033054, 4077.368007958771, 4080.2451546464, 4092.7544347339253, 4105.199486100182, 5969.164316995537, 5987.700614969147, 6060.1212824139375, 6101.29835068955, 6110.26676798787, 5763.8559036024435, 5778.306603207642, 5799.333076696234, 5802.868440654032, 5812.360640329645, 5738.942610574008, 5760.33756118035, 5765.94234057654, 5812.18629391894, 5841.912371314519, 5715.399688087342, 5749.223854779551, 5753.827385178452, 5768.2501274834, 5780.364159942487, 5823.7379317931645, 5825.300963884361, 5842.591018628826, 5856.385079566584, 5870.5010074144175, 5595.524380427709, 5643.125315576092, 5650.886982260414, 5686.516646084963, 5698.948378583624], "value": 4436.64299747904, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.1105162753068, 760.0765070439415, 761.6191904047976, 775.5385545600369, 779.6647441600112, 11431.256968297075, 11737.47181376838, 12643.873561264385, 13418.798718019225, 13447.932760336196, 14880.553583392515, 15030.0, 15378.615534611641, 15395.538133856002, 15418.383264669428, 858.4891989266392, 877.8727084572765, 878.8462019146656, 880.102295658428, 882.5190271302156, 893.5889490834192, 893.6157452295511, 893.6916763716507, 893.8927328720563, 895.7133717210495, 944.6504793226516, 949.0936155971066, 949.5679465843059, 950.5579905344014, 953.980920381592, 940.261894412886, 941.8728471656307, 943.7546237978175, 945.0738276489079, 945.1682519382933, 685.5372623479182, 687.6321168175052, 687.9140107486564, 689.1420181873549, 694.1739330197049, 13091.672708182276, 13345.599632011055, 13443.462261509529, 13464.730705385935, 13763.105398149088, 15388.692226155414, 15466.376030516747, 15683.0, 15777.68444631101, 16394.918025409796, 11881.465334059989, 11932.10509211804, 11937.164398492108, 11964.102692298113, 12052.638420847301, 2905.186547766629, 2907.592936988823, 2926.736593706555, 2927.2681829542616, 2933.2226959855657, 71650.28349716541, 72811.0, 73263.0, 73445.0, 74445.62777186134, 11807.763844723057, 11816.409179540988, 11867.347295898635, 11874.821877671842, 11914.16600837933, 20594.27920022822, 21141.577168456854, 21265.68101478479, 21313.68029479559, 22589.887050564972, 6037.6679282639, 6212.254529456494, 6256.937430625636, 6306.432421082033, 6307.369263073656, 2882.827030378142, 2944.16091413946, 2948.9262768430963, 2958.275222570484, 2965.0808249442744, 3488.8604455821483, 3531.646835316448, 3545.3441113393587, 3546.627604101532, 3611.494390785292, 715.0275625149792, 717.1680850213831, 718.5509056839476, 719.6905330707741, 722.9819254518574, 577.5033471214751, 590.3299754778358, 591.482452853753, 594.9702514874239, 603.6891001134419, 9664.71005869825, 10461.215408844368, 10709.78580428387, 10843.295185813055, 11103.666889993314, 606.5723664816294, 615.8675884684815, 619.1084837833505, 624.1418050181001, 625.0093601641358, 4512.5261847505535, 4620.330052142421, 4634.026854360554, 4694.741789201558, 4781.402324709411, 59504.70247648821, 59991.400085999456, 60639.0, 62692.686536567024, 63165.0, 53065.2040219397, 54485.72757136189, 54793.0, 55112.17331740027, 56540.43459565434, 46866.5313346869, 48218.75890620524, 48301.275480867815, 49284.75357623189, 50398.49601504012, 9213.953930230306, 10421.561989724643, 10462.790744185226, 10902.454877256265, 11011.28426652265, 24474.877625611756, 24682.259532214062, 25145.87427062853, 25196.0, 26483.07309244167, 43447.0, 43498.782506087264, 44493.0, 44787.0, 44850.0, 13484.258365789976, 13714.725705485635, 13833.446662133805, 13979.860201397856, 14044.78932815988, 15542.5337239883, 15581.610459738597, 15761.824864173876, 15974.920125399298, 16435.0, 13956.2324072177, 13975.161490310615, 14749.552772808842, 14891.851081489047, 14899.925500372428, 13755.656108597364, 13829.308534573433, 13992.09051411655, 14025.0, 14255.786163207767, 13676.589702308947, 13706.588802335946, 13897.16617002983, 13928.860711392756, 13936.581902542533, 9172.44965302084, 9498.287628427757, 9847.409155450696, 9975.551100200364, 9994.400335979864, 10948.45257737126, 11270.323780573191, 11687.88312116868, 11864.288142711464, 12379.0], "value": 6823.973010863736, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 111.0, 112.0, 113.0, 112.0, 112.0, 112.0, 112.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 131.0, 171.0, 124.0, 124.0, 124.0, 124.0, 147.0, 122.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 164.0, 165.0, 166.0, 168.0, 166.0, 167.0, 164.0, 162.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 113.0, 76.0, 75.0, 75.0, 76.0, 99.0, 76.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 100.0, 83.0, 82.0, 82.0, 112.0, 84.0, 83.0, 111.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 115.0, 114.0, 116.0, 115.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 150.0, 150.0, 152.0, 151.0, 150.0, 152.0, 151.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 54.0, 56.0, 55.0, 56.0, 56.0, 54.0, 56.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 55.0, 57.0, 62.0, 55.0, 57.0, 57.0, 55.0], "value": 56.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 81.0, 89.0, 84.0, 91.0, 84.0, 85.0, 82.0, 89.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 132.0, 154.0, 147.0, 133.0, 137.0, 139.0, 133.0, 182.0, 135.0], "value": 142.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 191.0, 190.0, 199.0, 187.0, 207.0, 194.0, 187.0, 192.0, 189.0], "value": 192.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 72.0, 74.0, 72.0, 73.0, 71.0, 72.0, 72.0, 75.0], "value": 72.6, "unit": "score"}]}]} 14:18:29 INFO - Return code: 0 14:18:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:18:29 INFO - # TBPL SUCCESS # 14:18:29 INFO - Running post-action listener: _resource_record_post_action 14:18:29 INFO - [mozharness: 2017-05-03 21:18:29.299319Z] Finished run-tests step (success) 14:18:29 INFO - Running post-run listener: _resource_record_post_run 14:18:29 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 196608; Write bytes: 354177024; Read time: 68; Write time: 201452 14:18:29 INFO - TinderboxPrint: CPU usage
13.3% 14:18:29 INFO - TinderboxPrint: I/O read bytes / time
196,608 / 68 14:18:29 INFO - TinderboxPrint: I/O write bytes / time
354,177,024 / 201,452 14:18:29 INFO - TinderboxPrint: CPU idle
8,299.0 (86.7%) 14:18:29 INFO - TinderboxPrint: CPU user
1,214.8 (12.7%) 14:18:29 INFO - TinderboxPrint: Swap in / out
0 / 0 14:18:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105160704; Read time: 0; Write time: 89544 14:18:29 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 192512; Write bytes: 248442880; Read time: 60; Write time: 111880 14:18:29 INFO - Running post-run listener: _upload_blobber_files 14:18:29 INFO - Blob upload gear active. 14:18:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:18:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:18:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:18:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:18:30 INFO - (blobuploader) - INFO - Open directory for files ... 14:18:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:18:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:18:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:18:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:18:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:18:33 INFO - (blobuploader) - INFO - Done attempting. 14:18:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:18:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:18:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:18:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:18:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:18:34 INFO - (blobuploader) - INFO - Done attempting. 14:18:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:18:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:18:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:18:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:18:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:18:35 INFO - (blobuploader) - INFO - Done attempting. 14:18:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:18:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:18:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:18:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:18:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:18:36 INFO - (blobuploader) - INFO - Done attempting. 14:18:36 INFO - (blobuploader) - INFO - Iteration through files over. 14:18:36 INFO - Return code: 0 14:18:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:18:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:18:36 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/49c499e1213cb135252f938fed59226eabb245bf940fe90db60cfe5ecb245d1a1b98015ce74e2bbd158aabf1d72e51de2d04cb3992f10732127dd228ac2ff4f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a358b9e9abb8d13674b8ff2e49be1d855117241796d648cf578e58ee899dff67fce71a749fd4ee6245ef6cf1ce9d177ebb6e0f26a600dcdc0eb508d18b75c5b9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b429639cce154a17efc99c0f3fde0defef01c71c56ab8b73f9b0aff42e6bdf19dbc06d685e669d24f05ba8a0c564d3c3c974fe49111b4fe36d9a6335af73977", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/901f9cb0696d861b8e6ae16f28d19fbdb8851a64f9fd88e87e7d26abe480d62696033ae5afe9c5e9dfe263679bcd0298ab27f17c3c8be3428e6cd24e852940a7"} 14:18:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:18:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:18:36 INFO - Contents: 14:18:36 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/49c499e1213cb135252f938fed59226eabb245bf940fe90db60cfe5ecb245d1a1b98015ce74e2bbd158aabf1d72e51de2d04cb3992f10732127dd228ac2ff4f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a358b9e9abb8d13674b8ff2e49be1d855117241796d648cf578e58ee899dff67fce71a749fd4ee6245ef6cf1ce9d177ebb6e0f26a600dcdc0eb508d18b75c5b9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b429639cce154a17efc99c0f3fde0defef01c71c56ab8b73f9b0aff42e6bdf19dbc06d685e669d24f05ba8a0c564d3c3c974fe49111b4fe36d9a6335af73977", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/901f9cb0696d861b8e6ae16f28d19fbdb8851a64f9fd88e87e7d26abe480d62696033ae5afe9c5e9dfe263679bcd0298ab27f17c3c8be3428e6cd24e852940a7"} 14:18:36 INFO - Running post-run listener: copy_logs_to_upload_dir 14:18:36 INFO - Copying logs to upload dir... 14:18:36 INFO - mkdir: /builds/slave/test/build/upload/logs 14:18:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.440760 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-05-03 14:18:36.409110) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-03 14:18:36.413279) ========= 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=8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736 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/49c499e1213cb135252f938fed59226eabb245bf940fe90db60cfe5ecb245d1a1b98015ce74e2bbd158aabf1d72e51de2d04cb3992f10732127dd228ac2ff4f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a358b9e9abb8d13674b8ff2e49be1d855117241796d648cf578e58ee899dff67fce71a749fd4ee6245ef6cf1ce9d177ebb6e0f26a600dcdc0eb508d18b75c5b9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b429639cce154a17efc99c0f3fde0defef01c71c56ab8b73f9b0aff42e6bdf19dbc06d685e669d24f05ba8a0c564d3c3c974fe49111b4fe36d9a6335af73977", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/901f9cb0696d861b8e6ae16f28d19fbdb8851a64f9fd88e87e7d26abe480d62696033ae5afe9c5e9dfe263679bcd0298ab27f17c3c8be3428e6cd24e852940a7"} build_url:https://queue.taskcluster.net/v1/task/MzyTuWZaSjquOpKDjW7FAw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011361 build_url: 'https://queue.taskcluster.net/v1/task/MzyTuWZaSjquOpKDjW7FAw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/49c499e1213cb135252f938fed59226eabb245bf940fe90db60cfe5ecb245d1a1b98015ce74e2bbd158aabf1d72e51de2d04cb3992f10732127dd228ac2ff4f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a358b9e9abb8d13674b8ff2e49be1d855117241796d648cf578e58ee899dff67fce71a749fd4ee6245ef6cf1ce9d177ebb6e0f26a600dcdc0eb508d18b75c5b9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b429639cce154a17efc99c0f3fde0defef01c71c56ab8b73f9b0aff42e6bdf19dbc06d685e669d24f05ba8a0c564d3c3c974fe49111b4fe36d9a6335af73977", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/901f9cb0696d861b8e6ae16f28d19fbdb8851a64f9fd88e87e7d26abe480d62696033ae5afe9c5e9dfe263679bcd0298ab27f17c3c8be3428e6cd24e852940a7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-03 14:18:36.445706) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 14:18:36.446267) ========= 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=8887e36bb8e381bfd44124ac000001a8-1493845061.623505-870836736 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 14:18:36.528656) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-03 14:18:36.529003) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-03 14:18:36.529319) ========= ========= Total master_lag: 0.19 =========