builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-005 starttime: 1493991747.44 results: success (0) revision: 8872ad4d52b6b517dc9d2a9f62c5c75ceda18790 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 06:42:27.441386) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 06:42:27.441833) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 06:42:27.442110) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 06:42:27.457101) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 06:42:27.457494) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-05 06:42:27-- 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% 24.8M=0s 2017-05-05 06:42:28 (24.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126222 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 06:42:27.598091) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 06:42:27.601452) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018048 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 06:42:27.650883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 06:42:27.654240) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8872ad4d52b6b517dc9d2a9f62c5c75ceda18790 --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 8872ad4d52b6b517dc9d2a9f62c5c75ceda18790 --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=7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-05 06:42:28,146 truncating revision to first 12 chars 2017-05-05 06:42:28,146 Setting DEBUG logging. 2017-05-05 06:42:28,146 attempt 1/10 2017-05-05 06:42:28,146 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8872ad4d52b6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-05 06:42:28,638 unpacking tar archive at: mozilla-central-8872ad4d52b6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.804436 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 06:42:28.475228) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 06:42:28.475577) ========= script_repo_revision: 8872ad4d52b6b517dc9d2a9f62c5c75ceda18790 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 06:42:28.475986) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 06:42:28.476264) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 06:42:28.487582) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-05-05 06:42:28.487957) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:42:29 INFO - MultiFileLogger online at 20170505 06:42:29 in /builds/slave/test 06:42:29 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 06:42:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:42:29 INFO - {'append_to_log': False, 06:42:29 INFO - 'base_work_dir': '/builds/slave/test', 06:42:29 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:42:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:42:29 INFO - 'branch': 'Firefox-Non-PGO', 06:42:29 INFO - 'buildbot_json_path': 'buildprops.json', 06:42:29 INFO - 'config_files': ('talos/linux_config.py',), 06:42:29 INFO - 'default_actions': ('clobber', 06:42:29 INFO - 'read-buildbot-config', 06:42:29 INFO - 'download-and-extract', 06:42:29 INFO - 'populate-webroot', 06:42:29 INFO - 'create-virtualenv', 06:42:29 INFO - 'install', 06:42:29 INFO - 'run-tests'), 06:42:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:42:29 INFO - 'download_minidump_stackwalk': True, 06:42:29 INFO - 'download_symbols': 'ondemand', 06:42:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:42:29 INFO - 'tooltool.py': '/tools/tooltool.py', 06:42:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:42:29 INFO - '/tools/misc-python/virtualenv.py')}, 06:42:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:42:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:42:29 INFO - 'gecko_profile': False, 06:42:29 INFO - 'gecko_profile_interval': 0, 06:42:29 INFO - 'installer_path': 'installer.exe', 06:42:29 INFO - 'log_level': 'info', 06:42:29 INFO - 'log_name': 'talos', 06:42:29 INFO - 'log_to_console': True, 06:42:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:42:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:42:29 INFO - 'opt_config_files': (), 06:42:29 INFO - 'pip_index': False, 06:42:29 INFO - 'suite': 'dromaeojs-e10s', 06:42:29 INFO - 'system_bits': '32', 06:42:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:42:29 INFO - 'title': 'talos-linux64-ix-005', 06:42:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:42:29 INFO - 'use_talos_json': True, 06:42:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:42:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:42:29 INFO - 'work_dir': 'build'} 06:42:29 INFO - [mozharness: 2017-05-05 13:42:29.079080Z] Running clobber step. 06:42:29 INFO - Running pre-action listener: _resource_record_pre_action 06:42:29 INFO - Running main action method: clobber 06:42:29 INFO - rmtree: /builds/slave/test/build 06:42:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:42:29 INFO - Running post-action listener: _resource_record_post_action 06:42:29 INFO - [mozharness: 2017-05-05 13:42:29.998542Z] Finished clobber step (success) 06:42:29 INFO - [mozharness: 2017-05-05 13:42:29.998642Z] Running read-buildbot-config step. 06:42:29 INFO - Running pre-action listener: _resource_record_pre_action 06:42:29 INFO - Running main action method: read_buildbot_config 06:42:29 INFO - Using buildbot properties: 06:42:29 INFO - { 06:42:29 INFO - "project": "", 06:42:29 INFO - "product": "firefox", 06:42:29 INFO - "who": "cbook@mozilla.com", 06:42:29 INFO - "installer_path": "public/build/target.tar.bz2", 06:42:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:42:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:42:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 06:42:29 INFO - "stage_platform": "linux64", 06:42:29 INFO - "basedir": "/builds/slave/test", 06:42:29 INFO - "buildnumber": 582, 06:42:30 INFO - "platform": "ubuntu64_hw", 06:42:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:42:30 INFO - "slavebuilddir": "test", 06:42:30 INFO - "taskId": "Ui8sdod5S7K8bXcym2RgWg", 06:42:30 INFO - "branch": "mozilla-central", 06:42:30 INFO - "script_repo_revision": "production", 06:42:30 INFO - "revision": "8872ad4d52b6b517dc9d2a9f62c5c75ceda18790", 06:42:30 INFO - "slavename": "talos-linux64-ix-005", 06:42:30 INFO - "repo_path": "mozilla-central" 06:42:30 INFO - } 06:42:30 INFO - Finding installer, test and symbols from parent task. 06:42:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ui8sdod5S7K8bXcym2RgWg'}, attempt #1 06:42:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ui8sdod5S7K8bXcym2RgWg'}, attempt #1 06:42:30 INFO - Task dependencies: Kv1P-eslQbm4klZWpzN4LQ 06:42:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kv1P-eslQbm4klZWpzN4LQ'}, attempt #1 06:42:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Kv1P-eslQbm4klZWpzN4LQ/artifacts/public/build/target.tar.bz2 06:42:31 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Kv1P-eslQbm4klZWpzN4LQ/artifacts/public/build/test_packages.json 06:42:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Kv1P-eslQbm4klZWpzN4LQ/artifacts/public/build/target.crashreporter-symbols.zip 06:42:31 INFO - Running post-action listener: _resource_record_post_action 06:42:31 INFO - [mozharness: 2017-05-05 13:42:31.368074Z] Finished read-buildbot-config step (success) 06:42:31 INFO - [mozharness: 2017-05-05 13:42:31.368290Z] Running download-and-extract step. 06:42:31 INFO - Running pre-action listener: _resource_record_pre_action 06:42:31 INFO - Running main action method: download_and_extract 06:42:31 INFO - mkdir: /builds/slave/test/build/tests 06:42:31 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')]} 06:42:31 INFO - trying https://queue.taskcluster.net/v1/task/Kv1P-eslQbm4klZWpzN4LQ/artifacts/public/build/target.test_packages.json 06:42:31 INFO - Downloading https://queue.taskcluster.net/v1/task/Kv1P-eslQbm4klZWpzN4LQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:42:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kv1P-eslQbm4klZWpzN4LQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:42:31 INFO - Downloaded 986 bytes. 06:42:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:42:31 INFO - Using the following test package requirements: 06:42:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:42:31 INFO - u'common': [u'target.common.tests.zip'], 06:42:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:42:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:42:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:42:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:42:31 INFO - u'mozbase': [u'target.common.tests.zip'], 06:42:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:42:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:42:31 INFO - u'web-platform': [u'target.common.tests.zip', 06:42:31 INFO - u'target.web-platform.tests.zip'], 06:42:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:42:31 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:42:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kv1P-eslQbm4klZWpzN4LQ/artifacts/public/build/target.common.tests.zip 06:42:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kv1P-eslQbm4klZWpzN4LQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:42:31 INFO - Fetch https://queue.taskcluster.net/v1/task/Kv1P-eslQbm4klZWpzN4LQ/artifacts/public/build/target.common.tests.zip into memory 06:42:33 INFO - Content-Length response header: 58436727 06:42:33 INFO - Bytes received: 58436727 06:42:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:42:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kv1P-eslQbm4klZWpzN4LQ/artifacts/public/build/target.common.tests.zip 06:42:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kv1P-eslQbm4klZWpzN4LQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:42:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Kv1P-eslQbm4klZWpzN4LQ/artifacts/public/build/target.common.tests.zip into memory 06:42:44 INFO - Content-Length response header: 58436727 06:42:44 INFO - Bytes received: 58436727 06:42:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kv1P-eslQbm4klZWpzN4LQ/artifacts/public/build/target.talos.tests.zip 06:42:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kv1P-eslQbm4klZWpzN4LQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:42:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Kv1P-eslQbm4klZWpzN4LQ/artifacts/public/build/target.talos.tests.zip into memory 06:42:55 INFO - Content-Length response header: 14408809 06:42:55 INFO - Bytes received: 14408809 06:42:55 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')]} 06:42:55 INFO - trying https://queue.taskcluster.net/v1/task/Kv1P-eslQbm4klZWpzN4LQ/artifacts/public/build/target.tar.bz2 06:42:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Kv1P-eslQbm4klZWpzN4LQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:42:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kv1P-eslQbm4klZWpzN4LQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:42:56 INFO - Downloaded 58322414 bytes. 06:42:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kv1P-eslQbm4klZWpzN4LQ/artifacts/public/build/target.tar.bz2 06:42:56 INFO - mkdir: /builds/slave/test/properties 06:42:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:42:56 INFO - Writing to file /builds/slave/test/properties/build_url 06:42:56 INFO - Contents: 06:42:56 INFO - build_url:https://queue.taskcluster.net/v1/task/Kv1P-eslQbm4klZWpzN4LQ/artifacts/public/build/target.tar.bz2 06:42:56 INFO - Running post-action listener: _resource_record_post_action 06:42:56 INFO - Running post-action listener: set_extra_try_arguments 06:42:56 INFO - [mozharness: 2017-05-05 13:42:56.829500Z] Finished download-and-extract step (success) 06:42:56 INFO - [mozharness: 2017-05-05 13:42:56.829596Z] Running populate-webroot step. 06:42:56 INFO - Running pre-action listener: _resource_record_pre_action 06:42:56 INFO - Running main action method: populate_webroot 06:42:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:42:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:42:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:42:56 INFO - '--tppagecycles', 06:42:56 INFO - '7'], 06:42:56 INFO - 'tests': ['tsvgm']}}, 06:42:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:42:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:42:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:42:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:42:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:42:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:42:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:42:56 INFO - 'talos_options': ['--disable-e10s'], 06:42:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:42:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:42:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:42:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:42:56 INFO - 'talos_options': ['--disable-e10s'], 06:42:56 INFO - 'tests': ['damp', 'tps']}, 06:42:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:42:56 INFO - 'tests': ['damp', 'tps']}, 06:42:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:42:56 INFO - 'tests': ['dromaeo_dom']}, 06:42:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:42:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:42:56 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 06:42:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:42:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:42:56 INFO - 'tests': ['a11yr', 06:42:56 INFO - 'ts_paint', 06:42:56 INFO - 'tpaint', 06:42:56 INFO - 'sessionrestore', 06:42:56 INFO - 'sessionrestore_no_auto_restore', 06:42:56 INFO - 'tabpaint']}, 06:42:56 INFO - 'other-e10s': {'tests': ['a11yr', 06:42:56 INFO - 'ts_paint', 06:42:56 INFO - 'tpaint', 06:42:56 INFO - 'sessionrestore', 06:42:56 INFO - 'sessionrestore_no_auto_restore', 06:42:56 INFO - 'tabpaint']}, 06:42:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:42:56 INFO - 'ts_paint', 06:42:56 INFO - 'tpaint', 06:42:56 INFO - 'sessionrestore', 06:42:56 INFO - 'sessionrestore_no_auto_restore', 06:42:56 INFO - 'tabpaint']}, 06:42:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:42:56 INFO - 'ts_paint', 06:42:56 INFO - 'tpaint', 06:42:56 INFO - 'sessionrestore', 06:42:56 INFO - 'sessionrestore_no_auto_restore', 06:42:56 INFO - 'tabpaint']}, 06:42:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:42:56 INFO - 'tests': ['a11yr', 06:42:56 INFO - 'ts_paint', 06:42:56 INFO - 'tpaint', 06:42:56 INFO - 'sessionrestore', 06:42:56 INFO - 'sessionrestore_no_auto_restore', 06:42:56 INFO - 'tabpaint']}, 06:42:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:42:56 INFO - 'tests': ['a11yr', 06:42:56 INFO - 'ts_paint', 06:42:56 INFO - 'tpaint', 06:42:56 INFO - 'sessionrestore', 06:42:56 INFO - 'sessionrestore_no_auto_restore', 06:42:56 INFO - 'tabpaint']}, 06:42:56 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 06:42:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 06:42:56 INFO - 'bloom_basic_ref']}, 06:42:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:42:56 INFO - 'tests': ['tsvgx', 06:42:56 INFO - 'tsvgr_opacity', 06:42:56 INFO - 'tart', 06:42:56 INFO - 'tscrollx', 06:42:56 INFO - 'cart', 06:42:56 INFO - 'tsvg_static']}, 06:42:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:42:56 INFO - 'tsvgr_opacity', 06:42:56 INFO - 'tart', 06:42:56 INFO - 'tscrollx', 06:42:56 INFO - 'cart', 06:42:56 INFO - 'tsvg_static']}, 06:42:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:42:56 INFO - 'talos_options': ['--disable-e10s'], 06:42:56 INFO - 'tests': ['tp5o']}, 06:42:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:42:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:42:56 INFO - 'talos_options': ['--disable-e10s', 06:42:56 INFO - '--xperf_path', 06:42:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:42:56 INFO - 'tests': ['tp5n']}, 06:42:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:42:56 INFO - 'talos_options': ['--xperf_path', 06:42:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:42:56 INFO - 'tests': ['tp5n']}}, 06:42:56 INFO - 'talos.zip': {'path': '', 06:42:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:42:56 INFO - Running post-action listener: _resource_record_post_action 06:42:56 INFO - [mozharness: 2017-05-05 13:42:56.843171Z] Finished populate-webroot step (success) 06:42:56 INFO - [mozharness: 2017-05-05 13:42:56.843259Z] Running create-virtualenv step. 06:42:56 INFO - Running pre-action listener: _resource_record_pre_action 06:42:56 INFO - Running main action method: create_virtualenv 06:42:56 INFO - Creating virtualenv /builds/slave/test/build/venv 06:42:56 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 06:42:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:42:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:42:56 INFO - Using real prefix '/usr' 06:42:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:42:57 INFO - Installing distribute.............................................................................................................................................................................................done. 06:42:59 INFO - Installing pip.................done. 06:42:59 INFO - Return code: 0 06:42:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:42:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:42:59 INFO - Reading from file tmpfile_stdout 06:42:59 INFO - Output received: 06:42:59 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) 06:42:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2257a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa290>, '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 0x23fab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fb040>, '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': '7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171', '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 06:42:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:42:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:42:59 INFO - Using env: {'DISPLAY': ':0', 06:42:59 INFO - 'HOME': '/home/cltbld', 06:42:59 INFO - 'LANG': 'en_US.UTF-8', 06:42:59 INFO - 'LANGUAGE': 'en_US:en', 06:42:59 INFO - 'LOGNAME': 'cltbld', 06:42:59 INFO - 'MAIL': '/var/mail/cltbld', 06:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:59 INFO - 'MOZ_NO_REMOTE': '1', 06:42:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:59 INFO - 'NO_EM_RESTART': '1', 06:42:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:59 INFO - 'PWD': '/builds/slave/test', 06:42:59 INFO - 'SHELL': '/bin/bash', 06:42:59 INFO - 'SHLVL': '1', 06:42:59 INFO - 'TERM': 'linux', 06:42:59 INFO - 'TMOUT': '86400', 06:42:59 INFO - 'USER': 'cltbld', 06:42:59 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171', 06:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:59 INFO - '_': '/tools/buildbot/bin/python'} 06:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:59 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 06:42:59 INFO - Cleaning up... 06:42:59 INFO - Return code: 0 06:42:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x215f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2257a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa290>, '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 0x23fab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fb040>, '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': '7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171', '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 06:42:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:42:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:42:59 INFO - Using env: {'DISPLAY': ':0', 06:42:59 INFO - 'HOME': '/home/cltbld', 06:42:59 INFO - 'LANG': 'en_US.UTF-8', 06:42:59 INFO - 'LANGUAGE': 'en_US:en', 06:42:59 INFO - 'LOGNAME': 'cltbld', 06:42:59 INFO - 'MAIL': '/var/mail/cltbld', 06:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:59 INFO - 'MOZ_NO_REMOTE': '1', 06:42:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:59 INFO - 'NO_EM_RESTART': '1', 06:42:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:59 INFO - 'PWD': '/builds/slave/test', 06:42:59 INFO - 'SHELL': '/bin/bash', 06:42:59 INFO - 'SHLVL': '1', 06:42:59 INFO - 'TERM': 'linux', 06:42:59 INFO - 'TMOUT': '86400', 06:42:59 INFO - 'USER': 'cltbld', 06:42:59 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171', 06:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:59 INFO - '_': '/tools/buildbot/bin/python'} 06:43:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:00 INFO - Downloading/unpacking psutil>=3.1.1 06:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:43:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:43:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:43:01 INFO - Installing collected packages: psutil 06:43:01 INFO - Running setup.py install for psutil 06:43:01 INFO - building 'psutil._psutil_linux' extension 06:43:01 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 06:43:01 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 06:43:01 INFO - building 'psutil._psutil_posix' extension 06:43:01 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 06:43:01 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 06:43:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:43:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:43:01 INFO - Successfully installed psutil 06:43:01 INFO - Cleaning up... 06:43:01 INFO - Return code: 0 06:43:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:43:01 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')]} 06:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:01 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')]} 06:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:01 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 0x215f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2257a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa290>, '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 0x23fab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fb040>, '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': '7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171', '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 06:43:01 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 06:43:01 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 06:43:01 INFO - Using env: {'DISPLAY': ':0', 06:43:01 INFO - 'HOME': '/home/cltbld', 06:43:01 INFO - 'LANG': 'en_US.UTF-8', 06:43:01 INFO - 'LANGUAGE': 'en_US:en', 06:43:01 INFO - 'LOGNAME': 'cltbld', 06:43:01 INFO - 'MAIL': '/var/mail/cltbld', 06:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:01 INFO - 'MOZ_NO_REMOTE': '1', 06:43:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:01 INFO - 'NO_EM_RESTART': '1', 06:43:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:01 INFO - 'PWD': '/builds/slave/test', 06:43:01 INFO - 'SHELL': '/bin/bash', 06:43:01 INFO - 'SHLVL': '1', 06:43:01 INFO - 'TERM': 'linux', 06:43:01 INFO - 'TMOUT': '86400', 06:43:01 INFO - 'USER': 'cltbld', 06:43:01 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171', 06:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:01 INFO - '_': '/tools/buildbot/bin/python'} 06:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:43:01 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 06:43:01 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 06:43:01 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 06:43:01 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 06:43:01 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 06:43:01 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 06:43:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:43:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:43:03 INFO - Installing collected packages: mozsystemmonitor 06:43:03 INFO - Running setup.py install for mozsystemmonitor 06:43:03 INFO - Successfully installed mozsystemmonitor 06:43:03 INFO - Cleaning up... 06:43:03 INFO - Return code: 0 06:43:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:03 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 0x215f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2257a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa290>, '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 0x23fab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fb040>, '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': '7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171', '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 06:43:03 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 06:43:03 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 06:43:03 INFO - Using env: {'DISPLAY': ':0', 06:43:03 INFO - 'HOME': '/home/cltbld', 06:43:03 INFO - 'LANG': 'en_US.UTF-8', 06:43:03 INFO - 'LANGUAGE': 'en_US:en', 06:43:03 INFO - 'LOGNAME': 'cltbld', 06:43:03 INFO - 'MAIL': '/var/mail/cltbld', 06:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:03 INFO - 'MOZ_NO_REMOTE': '1', 06:43:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:03 INFO - 'NO_EM_RESTART': '1', 06:43:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:03 INFO - 'PWD': '/builds/slave/test', 06:43:03 INFO - 'SHELL': '/bin/bash', 06:43:03 INFO - 'SHLVL': '1', 06:43:03 INFO - 'TERM': 'linux', 06:43:03 INFO - 'TMOUT': '86400', 06:43:03 INFO - 'USER': 'cltbld', 06:43:03 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171', 06:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:03 INFO - '_': '/tools/buildbot/bin/python'} 06:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:03 INFO - Downloading/unpacking jsonschema==2.5.1 06:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:43:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:43:04 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 06:43:04 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 06:43:04 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 06:43:04 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 06:43:04 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 06:43:04 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 06:43:04 INFO - Downloading functools32-3.2.3-2.tar.gz 06:43:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:43:04 INFO - warning: no files found matching '*.txt' 06:43:04 INFO - no previously-included directories found matching 'build' 06:43:04 INFO - no previously-included directories found matching 'dist' 06:43:04 INFO - no previously-included directories found matching '.git*' 06:43:04 INFO - Installing collected packages: jsonschema, functools32 06:43:04 INFO - Running setup.py install for functools32 06:43:04 INFO - warning: no files found matching '*.txt' 06:43:04 INFO - no previously-included directories found matching 'build' 06:43:04 INFO - no previously-included directories found matching 'dist' 06:43:04 INFO - no previously-included directories found matching '.git*' 06:43:04 INFO - Successfully installed jsonschema functools32 06:43:04 INFO - Cleaning up... 06:43:04 INFO - Return code: 0 06:43:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:43:04 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')]} 06:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:04 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')]} 06:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:04 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 0x215f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2257a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa290>, '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 0x23fab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fb040>, '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': '7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171', '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 06:43:04 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 06:43:04 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 06:43:04 INFO - Using env: {'DISPLAY': ':0', 06:43:04 INFO - 'HOME': '/home/cltbld', 06:43:04 INFO - 'LANG': 'en_US.UTF-8', 06:43:04 INFO - 'LANGUAGE': 'en_US:en', 06:43:04 INFO - 'LOGNAME': 'cltbld', 06:43:04 INFO - 'MAIL': '/var/mail/cltbld', 06:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:04 INFO - 'MOZ_NO_REMOTE': '1', 06:43:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:04 INFO - 'NO_EM_RESTART': '1', 06:43:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:04 INFO - 'PWD': '/builds/slave/test', 06:43:04 INFO - 'SHELL': '/bin/bash', 06:43:04 INFO - 'SHLVL': '1', 06:43:04 INFO - 'TERM': 'linux', 06:43:04 INFO - 'TMOUT': '86400', 06:43:04 INFO - 'USER': 'cltbld', 06:43:04 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171', 06:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:04 INFO - '_': '/tools/buildbot/bin/python'} 06:43:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:43:05 INFO - Cleaning up... 06:43:05 INFO - Return code: 0 06:43:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:43:05 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')]} 06:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:05 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')]} 06:43:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:05 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 0x215f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2257a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa290>, '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 0x23fab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fb040>, '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': '7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171', '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 06:43:05 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 06:43:05 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 06:43:05 INFO - Using env: {'DISPLAY': ':0', 06:43:05 INFO - 'HOME': '/home/cltbld', 06:43:05 INFO - 'LANG': 'en_US.UTF-8', 06:43:05 INFO - 'LANGUAGE': 'en_US:en', 06:43:05 INFO - 'LOGNAME': 'cltbld', 06:43:05 INFO - 'MAIL': '/var/mail/cltbld', 06:43:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:05 INFO - 'MOZ_NO_REMOTE': '1', 06:43:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:05 INFO - 'NO_EM_RESTART': '1', 06:43:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:05 INFO - 'PWD': '/builds/slave/test', 06:43:05 INFO - 'SHELL': '/bin/bash', 06:43:05 INFO - 'SHLVL': '1', 06:43:05 INFO - 'TERM': 'linux', 06:43:05 INFO - 'TMOUT': '86400', 06:43:05 INFO - 'USER': 'cltbld', 06:43:05 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171', 06:43:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:05 INFO - '_': '/tools/buildbot/bin/python'} 06:43:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:05 INFO - Downloading/unpacking blobuploader==1.2.4 06:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:06 INFO - Downloading blobuploader-1.2.4.tar.gz 06:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:43:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:43:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:06 INFO - Downloading docopt-0.6.1.tar.gz 06:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:43:07 INFO - Installing collected packages: blobuploader, requests, docopt 06:43:07 INFO - Running setup.py install for blobuploader 06:43:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:43:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:43:07 INFO - Running setup.py install for requests 06:43:07 INFO - Running setup.py install for docopt 06:43:07 INFO - Successfully installed blobuploader requests docopt 06:43:07 INFO - Cleaning up... 06:43:07 INFO - Return code: 0 06:43:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:43:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:43:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:07 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 0x215f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2257a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa290>, '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 0x23fab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fb040>, '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': '7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171', '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 06:43:07 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 06:43:07 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 06:43:07 INFO - Using env: {'DISPLAY': ':0', 06:43:07 INFO - 'HOME': '/home/cltbld', 06:43:07 INFO - 'LANG': 'en_US.UTF-8', 06:43:07 INFO - 'LANGUAGE': 'en_US:en', 06:43:07 INFO - 'LOGNAME': 'cltbld', 06:43:07 INFO - 'MAIL': '/var/mail/cltbld', 06:43:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:07 INFO - 'MOZ_NO_REMOTE': '1', 06:43:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:07 INFO - 'NO_EM_RESTART': '1', 06:43:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:07 INFO - 'PWD': '/builds/slave/test', 06:43:07 INFO - 'SHELL': '/bin/bash', 06:43:07 INFO - 'SHLVL': '1', 06:43:07 INFO - 'TERM': 'linux', 06:43:07 INFO - 'TMOUT': '86400', 06:43:07 INFO - 'USER': 'cltbld', 06:43:07 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171', 06:43:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:07 INFO - '_': '/tools/buildbot/bin/python'} 06:43:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:43:07 INFO - Running setup.py (path:/tmp/pip-Z9kNBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:43:07 INFO - Running setup.py (path:/tmp/pip-W76asE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:43:07 INFO - Running setup.py (path:/tmp/pip-LwwSGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:43:08 INFO - Running setup.py (path:/tmp/pip-Asnrnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:43:08 INFO - Running setup.py (path:/tmp/pip-1yG813-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:43:08 INFO - Running setup.py (path:/tmp/pip-AomBX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:43:08 INFO - Running setup.py (path:/tmp/pip-GHClYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:43:08 INFO - Running setup.py (path:/tmp/pip-rU9XuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:43:08 INFO - Running setup.py (path:/tmp/pip-joIxmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:43:08 INFO - Running setup.py (path:/tmp/pip-gpNWCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:43:08 INFO - Running setup.py (path:/tmp/pip-a8fu1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:43:08 INFO - Running setup.py (path:/tmp/pip-epjzOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:43:08 INFO - Running setup.py (path:/tmp/pip-36jE6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:43:08 INFO - Running setup.py (path:/tmp/pip-suKRiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:43:08 INFO - Running setup.py (path:/tmp/pip-yTAWEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:43:08 INFO - Running setup.py (path:/tmp/pip-FsJnIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:43:08 INFO - Running setup.py (path:/tmp/pip-ocfU8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:43:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:43:09 INFO - Running setup.py install for manifestparser 06:43:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:43:09 INFO - Running setup.py install for mozcrash 06:43:09 INFO - Running setup.py install for mozdebug 06:43:09 INFO - Running setup.py install for mozdevice 06:43:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:43:09 INFO - Running setup.py install for mozfile 06:43:09 INFO - Running setup.py install for mozhttpd 06:43:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:43:09 INFO - Running setup.py install for mozinfo 06:43:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:43:09 INFO - Running setup.py install for mozInstall 06:43:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:43:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:43:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:43:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:43:09 INFO - Running setup.py install for mozleak 06:43:09 INFO - Running setup.py install for mozlog 06:43:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:43:10 INFO - Running setup.py install for moznetwork 06:43:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:43:10 INFO - Running setup.py install for mozprocess 06:43:10 INFO - Running setup.py install for mozprofile 06:43:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:43:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:43:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:43:10 INFO - Running setup.py install for mozrunner 06:43:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:43:10 INFO - Running setup.py install for mozscreenshot 06:43:10 INFO - Running setup.py install for moztest 06:43:10 INFO - Running setup.py install for mozversion 06:43:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:43:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:43:10 INFO - Cleaning up... 06:43:10 INFO - Return code: 0 06:43:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:43: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')]} 06:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43: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')]} 06:43:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:10 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 0x215f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2257a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa290>, '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 0x23fab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fb040>, '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': '7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171', '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 06:43:10 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 06:43:10 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 06:43:10 INFO - Using env: {'DISPLAY': ':0', 06:43:10 INFO - 'HOME': '/home/cltbld', 06:43:10 INFO - 'LANG': 'en_US.UTF-8', 06:43:10 INFO - 'LANGUAGE': 'en_US:en', 06:43:10 INFO - 'LOGNAME': 'cltbld', 06:43:10 INFO - 'MAIL': '/var/mail/cltbld', 06:43:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:10 INFO - 'MOZ_NO_REMOTE': '1', 06:43:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:10 INFO - 'NO_EM_RESTART': '1', 06:43:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:10 INFO - 'PWD': '/builds/slave/test', 06:43:10 INFO - 'SHELL': '/bin/bash', 06:43:10 INFO - 'SHLVL': '1', 06:43:10 INFO - 'TERM': 'linux', 06:43:10 INFO - 'TMOUT': '86400', 06:43:10 INFO - 'USER': 'cltbld', 06:43:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171', 06:43:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:10 INFO - '_': '/tools/buildbot/bin/python'} 06:43:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:43:11 INFO - Running setup.py (path:/tmp/pip-8ynW5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:43:11 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)) 06:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:43:11 INFO - Running setup.py (path:/tmp/pip-c2iwmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:43:11 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)) 06:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:43:11 INFO - Running setup.py (path:/tmp/pip-JHLAfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:43:11 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)) 06:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:43:11 INFO - Running setup.py (path:/tmp/pip-pW_UY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:43:11 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)) 06:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:43:11 INFO - Running setup.py (path:/tmp/pip-oFr6I_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:43:11 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)) 06:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:43:11 INFO - Running setup.py (path:/tmp/pip-x1eywu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:43:11 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)) 06:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:43:11 INFO - Running setup.py (path:/tmp/pip-nDDS_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:43:11 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)) 06:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:43:11 INFO - Running setup.py (path:/tmp/pip-P3aR7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:43:11 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)) 06:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:43:11 INFO - Running setup.py (path:/tmp/pip-uRe6Ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:43:11 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)) 06:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:43:11 INFO - Running setup.py (path:/tmp/pip-ZJxoqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:43:11 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)) 06:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:43:11 INFO - Running setup.py (path:/tmp/pip-SRYHZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:43:11 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)) 06:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:43:11 INFO - Running setup.py (path:/tmp/pip-pq09UJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:43:11 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)) 06:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:43:11 INFO - Running setup.py (path:/tmp/pip-ZZv6Jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:43:11 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)) 06:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:43:11 INFO - Running setup.py (path:/tmp/pip-_7iBPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:43:12 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)) 06:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:43:12 INFO - Running setup.py (path:/tmp/pip-OwNg6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:43:12 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)) 06:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:43:12 INFO - Running setup.py (path:/tmp/pip-tpGKl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:43:12 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)) 06:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:43:12 INFO - Running setup.py (path:/tmp/pip-dp9Yvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:43:12 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)) 06:43:12 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)) 06:43:12 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)) 06:43:12 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)) 06:43:12 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)) 06:43:12 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)) 06:43:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:13 INFO - Downloading blessings-1.6.tar.gz 06:43:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:43:13 INFO - Installing collected packages: blessings 06:43:13 INFO - Running setup.py install for blessings 06:43:13 INFO - Successfully installed blessings 06:43:13 INFO - Cleaning up... 06:43:13 INFO - Return code: 0 06:43:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:43:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:43:13 INFO - Reading from file tmpfile_stdout 06:43:13 INFO - Current package versions: 06:43:13 INFO - argparse == 1.2.1 06:43:13 INFO - blessings == 1.6 06:43:13 INFO - blobuploader == 1.2.4 06:43:13 INFO - docopt == 0.6.1 06:43:13 INFO - functools32 == 3.2.3-2 06:43:13 INFO - jsonschema == 2.5.1 06:43:13 INFO - manifestparser == 1.1 06:43:13 INFO - mozInstall == 1.12 06:43:13 INFO - mozcrash == 1.0 06:43:13 INFO - mozdebug == 0.1 06:43:13 INFO - mozdevice == 0.50 06:43:13 INFO - mozfile == 1.2 06:43:13 INFO - mozhttpd == 0.7 06:43:13 INFO - mozinfo == 0.9 06:43:13 INFO - mozleak == 0.1 06:43:13 INFO - mozlog == 3.4 06:43:13 INFO - moznetwork == 0.27 06:43:13 INFO - mozprocess == 0.25 06:43:13 INFO - mozprofile == 0.28 06:43:13 INFO - mozrunner == 6.13 06:43:13 INFO - mozscreenshot == 0.1 06:43:13 INFO - mozsystemmonitor == 0.3 06:43:13 INFO - moztest == 0.8 06:43:13 INFO - mozversion == 1.4 06:43:13 INFO - psutil == 3.1.1 06:43:13 INFO - requests == 1.2.3 06:43:13 INFO - wsgiref == 0.1.2 06:43:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:43:13 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')]} 06:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:13 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')]} 06:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:13 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 0x215f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2257a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa290>, '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 0x23fab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fb040>, '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': '7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171', '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 06:43:13 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 06:43:13 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 06:43:13 INFO - Using env: {'DISPLAY': ':0', 06:43:13 INFO - 'HOME': '/home/cltbld', 06:43:13 INFO - 'LANG': 'en_US.UTF-8', 06:43:13 INFO - 'LANGUAGE': 'en_US:en', 06:43:13 INFO - 'LOGNAME': 'cltbld', 06:43:13 INFO - 'MAIL': '/var/mail/cltbld', 06:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:13 INFO - 'MOZ_NO_REMOTE': '1', 06:43:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:13 INFO - 'NO_EM_RESTART': '1', 06:43:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:13 INFO - 'PWD': '/builds/slave/test', 06:43:13 INFO - 'SHELL': '/bin/bash', 06:43:13 INFO - 'SHLVL': '1', 06:43:13 INFO - 'TERM': 'linux', 06:43:13 INFO - 'TMOUT': '86400', 06:43:13 INFO - 'USER': 'cltbld', 06:43:13 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171', 06:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:13 INFO - '_': '/tools/buildbot/bin/python'} 06:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:13 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)) 06:43:13 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)) 06:43:13 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)) 06:43:13 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)) 06:43:13 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)) 06:43:13 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)) 06:43:13 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)) 06:43:13 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)) 06:43:13 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)) 06:43:13 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)) 06:43:13 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)) 06:43:13 INFO - Cleaning up... 06:43:14 INFO - Return code: 0 06:43:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:43: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')]} 06:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43: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')]} 06:43:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2257a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fa290>, '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 0x23fab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fb040>, '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': '7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171', '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 06:43: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', 'jsonschema'] in /builds/slave/test/build 06:43: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 jsonschema 06:43:14 INFO - Using env: {'DISPLAY': ':0', 06:43:14 INFO - 'HOME': '/home/cltbld', 06:43:14 INFO - 'LANG': 'en_US.UTF-8', 06:43:14 INFO - 'LANGUAGE': 'en_US:en', 06:43:14 INFO - 'LOGNAME': 'cltbld', 06:43:14 INFO - 'MAIL': '/var/mail/cltbld', 06:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:14 INFO - 'MOZ_NO_REMOTE': '1', 06:43:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:14 INFO - 'NO_EM_RESTART': '1', 06:43:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:14 INFO - 'PWD': '/builds/slave/test', 06:43:14 INFO - 'SHELL': '/bin/bash', 06:43:14 INFO - 'SHLVL': '1', 06:43:14 INFO - 'TERM': 'linux', 06:43:14 INFO - 'TMOUT': '86400', 06:43:14 INFO - 'USER': 'cltbld', 06:43:14 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171', 06:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:14 INFO - '_': '/tools/buildbot/bin/python'} 06:43:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:43:14 INFO - Cleaning up... 06:43:14 INFO - Return code: 0 06:43:14 INFO - Running post-action listener: _resource_record_post_action 06:43:14 INFO - Running post-action listener: _start_resource_monitoring 06:43:14 INFO - Starting resource monitoring. 06:43:14 INFO - [mozharness: 2017-05-05 13:43:14.276357Z] Finished create-virtualenv step (success) 06:43:14 INFO - [mozharness: 2017-05-05 13:43:14.276866Z] Running install step. 06:43:14 INFO - Running pre-action listener: _resource_record_pre_action 06:43:14 INFO - Running main action method: install 06:43:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:43:14 INFO - Reading from file tmpfile_stdout 06:43:14 INFO - Detecting whether we're running mozinstall >=1.0... 06:43:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:43:14 INFO - Reading from file tmpfile_stdout 06:43:14 INFO - Output received: 06:43:14 INFO - Usage: mozinstall [options] installer 06:43:14 INFO - Options: 06:43:14 INFO - -h, --help show this help message and exit 06:43:14 INFO - -d DEST, --destination=DEST 06:43:14 INFO - Directory to install application into. [default: 06:43:14 INFO - "/builds/slave/test"] 06:43:14 INFO - --app=APP Application being installed. [default: firefox] 06:43:14 INFO - mkdir: /builds/slave/test/build/application 06:43:14 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'] 06:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:43:29 INFO - Reading from file tmpfile_stdout 06:43:29 INFO - Output received: 06:43:29 INFO - /builds/slave/test/build/application/firefox/firefox 06:43:29 INFO - Running post-action listener: _resource_record_post_action 06:43:29 INFO - [mozharness: 2017-05-05 13:43:29.460055Z] Finished install step (success) 06:43:29 INFO - [mozharness: 2017-05-05 13:43:29.460328Z] Running run-tests step. 06:43:29 INFO - Running pre-action listener: _resource_record_pre_action 06:43:29 INFO - Running main action method: run_tests 06:43:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:43:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:43:29 INFO - Python 2.7.3 06:43:29 INFO - Return code: 0 06:43:29 INFO - grabbing minidump binary from tooltool 06:43: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')]} 06:43:29 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 0x23fa290>, '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 0x23fab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fb040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:43:29 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 06:43:29 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 06:43:29 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 06:43:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:43:29 INFO - Return code: 0 06:43:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:43:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:43:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:43:29 INFO - ENV: RUST_BACKTRACE is now 1 06:43:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:43:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:43:29 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/Kv1P-eslQbm4klZWpzN4LQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 06:43:29 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/Kv1P-eslQbm4klZWpzN4LQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 06:43:29 INFO - Using env: {'DISPLAY': ':0', 06:43:29 INFO - 'HOME': '/home/cltbld', 06:43:29 INFO - 'LANG': 'en_US.UTF-8', 06:43:29 INFO - 'LANGUAGE': 'en_US:en', 06:43:29 INFO - 'LOGNAME': 'cltbld', 06:43:29 INFO - 'MAIL': '/var/mail/cltbld', 06:43:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:43:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:43:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:29 INFO - 'MOZ_NO_REMOTE': '1', 06:43:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:43:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:29 INFO - 'NO_EM_RESTART': '1', 06:43:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:29 INFO - 'PWD': '/builds/slave/test', 06:43:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:43:29 INFO - 'RUST_BACKTRACE': '1', 06:43:29 INFO - 'SHELL': '/bin/bash', 06:43:29 INFO - 'SHLVL': '1', 06:43:29 INFO - 'TERM': 'linux', 06:43:29 INFO - 'TMOUT': '86400', 06:43:29 INFO - 'USER': 'cltbld', 06:43:29 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171', 06:43:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:29 INFO - '_': '/tools/buildbot/bin/python'} 06:43:29 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/Kv1P-eslQbm4klZWpzN4LQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 06:43:29 INFO - mozversion application_buildid: 20170505131846 06:43:29 INFO - mozversion application_changeset: 8872ad4d52b6b517dc9d2a9f62c5c75ceda18790 06:43:29 INFO - mozversion application_display_name: Nightly 06:43:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:43:29 INFO - mozversion application_name: Firefox 06:43:29 INFO - mozversion application_remotingname: firefox 06:43:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:43:29 INFO - mozversion application_vendor: Mozilla 06:43:29 INFO - mozversion application_version: 55.0a1 06:43:29 INFO - mozversion platform_buildid: 20170505131846 06:43:29 INFO - mozversion platform_changeset: 8872ad4d52b6b517dc9d2a9f62c5c75ceda18790 06:43:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:43:29 INFO - mozversion platform_version: 55.0a1 06:43:29 INFO - using testdate: 1493991809 06:43:29 INFO - actual date: 1493991809 06:43:29 INFO - starting webserver on 'localhost:54929' 06:43:29 INFO - SUITE-START | Running 2 tests 06:43:29 INFO - TEST-START | dromaeo_css 06:43:29 INFO - operating with platform_type : linux_ 06:43:29 INFO - Initialising browser for dromaeo_css test... 06:43:29 INFO - TEST-INFO | started process 18486 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgRmY8P/profile http://localhost:54929/getInfo.html) 06:43:34 INFO - PID 18486 | __metrics Screen width/height:1600/1200 06:43:34 INFO - PID 18486 | colorDepth:24 06:43:34 INFO - PID 18486 | Browser inner width/height: 1024/695 06:43:34 INFO - PID 18486 | __metrics 06:43:36 INFO - TEST-INFO | 18486: exit 0 06:43:36 INFO - Browser initialized. 06:43:36 INFO - Running cycle 1/1 for dromaeo_css test... 06:43:36 INFO - TEST-INFO | started process 18659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgRmY8P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:43:48 INFO - PID 18659 | RSS: Main: 160591872 06:43:48 INFO - PID 18659 | 06:46:52 INFO - PID 18659 | Cycle 1(1): loaded http://localhost:54929/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54929/tests/dromaeo/cssquery-ext.html) 06:46:55 INFO - PID 18659 | RSS: Main: 165236736 06:46:55 INFO - PID 18659 | 06:49:57 INFO - PID 18659 | Cycle 1(1): loaded http://localhost:54929/tests/dromaeo/cssquery-ext.html (next: http://localhost:54929/tests/dromaeo/cssquery-jquery.html) 06:49:58 INFO - PID 18659 | RSS: Main: 158519296 06:49:58 INFO - PID 18659 | 06:53:00 INFO - PID 18659 | Cycle 1(1): loaded http://localhost:54929/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54929/tests/dromaeo/cssquery-mootools.html) 06:53:00 INFO - PID 18659 | RSS: Main: 166514688 06:53:00 INFO - PID 18659 | 06:56:02 INFO - PID 18659 | Cycle 1(1): loaded http://localhost:54929/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54929/tests/dromaeo/cssquery-prototype.html) 06:56:03 INFO - PID 18659 | RSS: Main: 158863360 06:56:03 INFO - PID 18659 | 06:59:05 INFO - PID 18659 | Cycle 1(1): loaded http://localhost:54929/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54929/tests/dromaeo/cssquery-yui.html) 06:59:06 INFO - PID 18659 | RSS: Main: 164278272 06:59:06 INFO - PID 18659 | 07:02:08 INFO - PID 18659 | Cycle 1(1): loaded http://localhost:54929/tests/dromaeo/cssquery-yui.html (next: http://localhost:54929/tests/dromaeo/cssquery-dojo.html) 07:02:08 INFO - PID 18659 | RSS: Main: 165933056 07:02:08 INFO - PID 18659 | 07:02:08 INFO - PID 18659 | __start_tp_report 07:02:08 INFO - PID 18659 | _x_x_mozilla_page_load 07:02:08 INFO - PID 18659 | _x_x_mozilla_page_load_details 07:02:08 INFO - PID 18659 | |i|pagename|runs| 07:02:08 INFO - PID 18659 | |0;dojo.html;2679.67843858737;2692.30000199948;2707.634469346639;2726.8772905219253;2737.876795544201;5299.682019078858;5304.840854774353;5331.7334133293325;5340.412554618999;5382.730863456826;5347.197920311955;5418.729063546826;5435.239066530679;5436.864078398042;5536.75084621192;4744.691595046311;4801.90396192076;4833.3958255218095;4847.418309802829;4892.094962431944;4878.731669758162;4886.1204983103025;4889.168841296988;4894.755262236892;4898.995705880304;4721.740304283263;4748.477667456577;4781.665283430161;4809.278608208761;4867.756612169377;4768.260919557474;4771.475137734847;4806.975965120187;4810.254410566367;4820.493848145929;4696.412948381452;4723.669343145981;4748.169070412664;4763.476017638057;4797.544233297831;5291.4708529147165;5321.201819727034;5341.43914888935;5360.463953604647;5370.033393989081;5790.420957904218;5791.189233507313;5791.8552036199435;5883.411658834125;5892.204552385416;5880.5883588148845;5903.0555111182;5906.025505791539;5910.083936989773;5911.852203694899;5379.354477462652;5388.057090009311;5392.595555333366;5397.271368365299;5411.269478620415;5823.417658234227;5891.351951285355;5934.643921364732;5947.5539334550085;5954.970225148846;5652.74562644682;5719.542436605062;5725.398833122462;5726.77092916287;5729.7708091676695;5773.797917072882;5798.391168927286;5830.533557315404;5844.357120716718;5870.412958704095;5763.7118144093465;5777.191193232867;5807.738651760681;5817.127430885316;5826.533877289807;5784.248047753849;5812.622179558315;5826;5837.270341207349;5865.648061116347;4986.152354099811;4990.950090499121;4993.875153121128;5001.44984051754;5035.84892453227;4125.484314460692;4197.9370309445385;4220.746755194698;4269.743815371087;4287.142571485715;4967.105920934194;4999.700017998932;5007.298978143063;5007.799688012438;5023.648344615842;5847.8245652630485;5848.064309710426;5934.3175534814045;5955.851103722442;5956.493698035629;4976.62675299354;5043.823466178666;5047.747612619354;5052.065367906949;5061.8734531637;5228.607854410934;5253.50091741284;5262.526372626482;5279.709615971082;5300.337457817773;5404.891902162013;5410.783568657288;5413.945860541423;5415.972920135532;5477.863053423696;5738.540916726735;5792.9710351447975;5802.245708058094;5896.086106653475;5901.557383196192;5410.702411367255;5431.185322201702;5451.7001564912725;5479.150731636602;5502.339719233718;5714.142878568248;5722.370539240597;5723.599348045597;5728.942710572841;5742.712864356849;5765.077587585966;5854.531637468907;5866.882662346815;5868.501177399798;5869.413058694096;5650.378458369494;5677.290338707661;5681.687507187145;5684.971575142098;5686.175504551734;5644.604877658525;5671.035923892866;5672.290963629546;5675.091985282335;5675.971620141873;5413.53984911287;5458.836234912959;5510.063289240758;5515.834524964257;5524.558035357242;5660.632058916157;5701.173329867063;5709.9714501427225;5716.857078573069;5719.970405326914;5508.338999320107;5510.1459273812625;5561.277033985556;5576.804811831566;5597 07:02:08 INFO - PID 18659 | |1;ext.html;732.103173612325;750.2984709296808;1039.6049501189548;1054.8839627640964;1135.7955567997758;30209.395812083745;32657.51013734796;32896.835515822415;32969.17577060575;33060;30877.38245235094;31138.862087755493;31205.687943120563;31205.84397078017;31471.21321966952;6381.074744162093;6384.5211609129265;6415.486761059127;6431.967840160793;6974.721011159548;7075.893861592081;7135.8216044598785;7191.856162876739;7210.963945180293;7212.134543854719;7157.964210178942;7182.389496892744;7202.53183543068;7209.855802883939;7224.7110115595315;7095.7161713531395;7173.89239161413;7184.497085204038;7216.134063912312;7219.8917016244795;7039;7092.858142837166;7093.432525398008;7099.254578269259;7107.360337569644;33091.6690833091;33093;33150.502742458884;33349.6665033349;33548;3125.8124512529093;3159.7314228290625;3162.304293055524;3164.4462219111565;3169.9683003169903;24857.378565535826;24869;24916.252512424657;25069.122580709587;25166.874165629055;2651.469706058777;2670.3991601889616;2701.405690748032;2717.2120085175275;2724.6730392352847;150932;151030.24484877614;151256;151299;151879.24060379626;38749.80625096913;40662;40663.59336406598;41725.58274417217;42309;41710.37434438486;41812.163756724694;41861.1627767449;41884;41943;12745.936270318589;12888.80666789999;12941.611751647277;12972.416241268977;12978.870211297955;10324.638637647646;10330.845037324447;10340.896591034143;10363.533640986174;10375.118114960313;12660.683482913;12804.80792788109;12845.614631561068;12896.80654790179;12926.870731292754;5237.869053273698;5285.286486324297;5287.9735601321745;5322.414534401213;5371.677699338053;878.2754227762122;906.2297047509564;919.5218486387041;931.1573026411108;958.4393130018877;20593.794062059187;22185.334439966828;26016.73983260143;27218.72781272162;27261.727382726316;969.8545218217324;982.3909176310733;986.3982970388057;997.945113018791;1005.7133716890651;11526.88473115275;11835.940820296015;11896.762064758655;12024.819627705592;12105.09211809118;189397;190606.26815380022;190795;191011;191060;41558.79220603938;41715.37426938598;41725.79137104295;41860;41980.37029444561;1204.6145233525363;1231.8460192475761;1242.6706922665321;1243.6828608704902;1251.380566619511;20687.68968465444;20986.265480708713;21602.13591456324;21672.34982950514;21689.783102169407;30607.387852243275;30768.84615576908;30854.53718194184;30866.228344291572;30902.690973089982;162835;163712;164208;164678;165089.17455412645;29073.12780616585;29967.250818728833;29985.15141061683;30730.231744206572;31276.530852036783;36017.459738103425;36513.08717281983;36516.63483365239;36553.63446365502;36954.6304536962;27847.86076069607;28346.71653283523;28789.712102878704;29036;29589.408211835213;27614.723852762017;28087.157385278475;28197.43605127927;29371.412571748016;29400.852995734884;30460.84769576138;30486.542701859933;30525;30815;30940.53589196119;26225.329111151674;26995.190144295702;27031.594526082517;27264.454710906066;28609;21467;23004.769952300932;23043.308700739006;23112.884435577715;23382.53234935326 07:02:08 INFO - PID 18659 | |2;jquery.html;398.73683368976447;415.2069547164914;418.27638185938326;422.282120395328;432.33636368174837;14317.713645727104;17472;17878.195481203344;18182.181801818933;18196.727049094257;18105.185266663;18262.543436414097;18271.269149234016;18351.724724129148;18412.35556755514;5395.81114660987;5441.782328706847;5645.096784514479;5661.490465858072;5683.914741278884;5527.419620939803;5623.381428042912;5628;5629.268195134627;5640.097584386499;5430.681704760947;5496;5539.335279766434;5557.3331200256025;5560.138178582326;5434.91847622284;5436.293281873351;5450.291462109901;5455.727213639322;5464.6994415307145;4845.152098382769;4863.465018847924;4956.8760780980765;4981.900361992776;4986.850394488171;20645.72896981346;20902.059407326706;21129.366119016453;21587.920603969895;21690.132394704193;1635.255958538862;1635.3540351561066;1664.4340924085748;1672.046933248049;1673.5481420016526;14406.135631862122;14739.631509212248;14902;14943.850561494462;15064.623384415368;2124.8406369522195;2141.3361857824125;2176.92380766674;2185.9562808743894;2189.408859607897;79597;79847;79864.60067699624;80837;80983.19016809815;10692.198085143646;10842.512086956105;10934.945325273322;11097.278676885977;11174.441277936234;14536.854631453762;14980.850191498164;15003.474878379204;15019.849801502063;15023.09861408319;7846.568438735924;7890.171531989058;7973.880391794128;8139.110615731449;8150.551719655476;7311.853762924712;7397.223291554417;7522.172561018284;7610.086789585285;7634;6718.294579069225;6814.352636499525;6867.690953907087;6889.793306200822;6965.930340696629;1973.6447439461035;1979.683250679913;1984.474114359696;1985.7716362618196;2163.9026243818753;837.1703641691166;851.4040171879709;891.6656253904786;895.6462197431978;899.3120262998812;16545.50363489097;17360.739588906177;17410.65178696419;17588.560285992953;17650.823491765175;891.5765011619429;894.3203165594196;906.2659246010752;911.7583840282331;921.9815603687889;8959.23846473044;9433.29250306216;9543.9045609543;9648.71053868385;9668.613255469843;370180;379162;380229;381700;389780;78845.60577197078;79191.60404197942;79655.60172199101;80688.19311806925;81275.5936220315;1075.4622688655672;1094.2121672395863;1097.3251450358132;1106.330669944688;1109.2512554026;17267.65464690674;17391.391301304393;18089.36687215941;18187.45437636873;18452.26190952347;39461.605383945796;39564.20871582495;40017;40421.393679095425;42006.15987680291;49060.509394905595;49095.50904491052;49196.508034920626;49394.75302623464;52255;8064.919350806417;8066.556339401389;8383.119772423808;8453.365997550085;8618.052014278299;12458.688532786753;12519.311437871005;12564.811527826907;12623.495060197489;12950.417231224807;10790.89209107899;10949.56201751921;10986.725331866768;11019.449027548751;11131.944340278247;10592.099671528007;10652.520636571218;10704;10741.785164296827;10769.676909692722;10969.067629251604;11030.44847757625;11212;11388.886111139114;11545.480453379787;7978.920210797818;8218.383621228311;8243.505389676639;8368.790780230544;8392.538410387488;10607.840882386616;10816.729581760204;10870.549147754396;11470.967612914877;11505.482253298454 07:02:08 INFO - PID 18659 | |3;mootools.html;1251.1117106854135;1299.4802079168333;1311.475409836065;1321.7752981993058;1329.9933500332497;9818;10314.638987635435;10316.58733650654;10389.116925061378;10611.204159688015;10425;10543.41848722692;10577.841332380001;10606.098481629051;10612.416317102556;2255.4023183856293;2282.47503074293;2291.9770802291932;2297.3797074789795;2297.9195728149516;2218.866867987926;2269.841111122222;2280.2361208994926;2280.6579013147993;2282.897269622871;2197.571473562656;2219.223271854854;2242.618754811686;2244.4837687331924;2277.6697378880053;2145.1419432227076;2194.550117225973;2205.680176374433;2208.182972300251;2208.9005994730355;2100.810927016576;2153.569286142762;2167.4581354661336;2233.106757297078;2234.4302202938147;10094.29339946204;10173.033561811617;10271.589136434608;10279.280450368477;10304.330218535772;5618.269624948772;5829.88340233193;5831.970840145772;5832.300123985106;5846.912296315559;3214.4696125139326;3408.727301815849;3499.212677147647;3506.0533655913014;3511.3855075361707;1021.918246540275;1028.7890982348677;1030.0986636692894;1034.3586976074882;1042.796654652343;14810.703785924221;14941.70116597662;15058.171800550965;15112.622184445367;15154.393824247018;4672.602828759525;4747.786349614206;4925.827596034122;5059.494050594911;5061.5950723942;10261.435621040915;10297.433641149659;10301.53643086063;10301.9484902575;10306.484675766182;5426.972865135649;5470.398256191816;5475.123980163155;5482.0406428874785;5499.037668408093;5007.799688012438;5050.318207042076;5079.8984020319385;5315.893682126336;5345.946540534623;3721.776693398405;3865.304245235828;3867.845286188577;3948.2103579284258;3967.2462232175794;1159.565163063851;1170.3504554972071;1170.6780635325183;1184.0705046538426;1184.620921305174;691.4330249195611;701.2916953876621;702.3433090060707;710.5878590417545;721.0158134146957;5187.870303242374;5275.657082289639;5278.973605132027;5340.332458442695;5427.050266203478;825.3603457320625;840.7351684219574;844.3161039557978;846.2003406780657;851.974440766778;3740.401535754321;3774.735768496179;3864.574896761354;3939.842406303716;4205.222033923734;13642.317884105754;13860.584182474542;14023.85976140246;14117.576472705836;14119.576412707429;12941;13621.727565448833;13704.45182192721;13885.37515811791;14018.088824226392;7563.584002879785;7732.4200684948855;7748.612569371621;7769.067711874612;7792.337651299589;5574.944250557604;5712.885742285214;5975.611585246945;6169.876602468015;6313.337099604475;11925.403729813648;11955.103367247317;12220.572279970158;12238.816417753562;12292;12050.51797928073;12111.515539378326;12470.875291246972;12512;12527.812082818582;8224.671013159406;8553.144685531397;8653.35099867525;8669.653213871374;8675.392722509363;9480.814888184386;9508.429494230368;9514.286428518028;9520.095590918852;9521;7885;7960.920390796249;7965.800854978672;8111.269985701315;8243.25810677042;7901.841963160819;8154.266116049584;8203.384746143944;8334.12491688364;8548.829023419621;7372.778816635509;7374.078240219973;7477.588732619541;7478.775636730907;7484.700611975678;4884.804607815648;5149.819756308511;5192.402873669576;5296.894062118813;5452.127659574449;5308.548773354154;5322.733863306742;5334.3865455473115;5393.083175860192;5550 07:02:08 INFO - PID 18659 | |4;prototype.html;370.1837448426219;385.5508332792297;387.56979752474746;392.54660866698936;394.1152113505181;5577.69322687252;5626.803061892834;5724.971375143124;5742.138679198112;5745.6839873806975;5458.61789674723;5547.0585295146675;5554.666719996793;5580.079286917654;5582.413846546105;4203.978980105103;4208.915821683565;4212.936805947913;4216.304309788897;4225.366195070733;4115.603253457057;4186.623203911648;4197.7901104944785;4219.662427005847;4228.577142285778;4148.149629325996;4154.459920210368;4157.272477316457;4158.168366326731;4186.853460128896;4147.087640719052;4172.645325147381;4177.206330797138;4177.49870015597;4182.53992060873;3592.6227746086547;3633.6911362534215;3647.0335361129323;3659.8277963122064;3665;5458.4814442627885;5469.398366179717;5471.534919531845;5487.9298536785345;5547.972260138714;4902.926456103126;4905.4358748744;4912.312276281324;4912.7297998610065;4918.114739346916;5733;5916.674582897939;5917.378675239124;5956.851078723023;5976.372480889531;4083.4283200351974;4086.1827634473225;4089.1003979124544;4097.631213190827;4099.7745124018165;6076.240469941257;6279.403456671609;6299.0866324382705;6305.432511073979;6373.362663733636;4118.217538667644;4140.523839758406;4162.128131589194;4174.478190226222;4177.289860723684;4206.558311377261;4228.1966426378885;4234.449521562177;4248.468941382327;4250.851220207278;4785.2582849657665;4798.376211092535;4879.853604391874;4895;4896.926546101811;5914.112883067574;5931.436513531207;5933.525317974551;5939.544811521205;5944.3164036136395;1442.1058943455125;1461.7295800276984;1465.2673663168416;1468.948586799457;1470.2501724120561;925.1497005988024;960.8750862387984;964.1563631822156;981.8821741390936;983.5524836199512;5123.052235336475;5145.331106956071;5160.845174644766;5166.405863325691;5168.3797944246935;6118.388161183846;6130.233720784902;6178.783742568989;6181.289151747516;6194.5354098442795;5041.193409054534;5123.437351607796;5212.166053431432;5271.130263506555;5273.789048438096;3302.8183449910484;3304.9173770655925;3323.6011678598725;3347.9330413391594;3350.2294472271515;5711.343195532484;5742.569307301969;5764.365919748824;5781.918509336635;5806.622569532967;6381.361863813581;6413.486921046305;6418.19772528434;6442.420182183626;6449.677516124175;5598.916016259841;5732.2230108666445;5744.965906136852;5784.1902133701315;5789.53683705311;6162.722677479614;6169.475594574512;6220.533459990428;6222.595531290452;6257.5932564383165;5909.556783241188;6092.543059270661;6094.512439004958;6126.877462450637;6157.0605259343165;5743.62666426681;5776.393478684846;5785.132230165341;5785.508231800176;5796.913046304225;4138.751674899516;4173.290540608044;4188.476440444944;4200.91598168041;4211.789410529523;6135;6256.374362563707;6259.405356491126;6296.181496405438;6318.304986451395;5959.106134079922;5971.7611295547695;5992.700364981646;6021.832140429355;6022.668753218615;5781.508571771446;5940.346561878277;5997.970010149921;6012.669303188367;6024.608400453956;5748.137779333133;5785.508231800176;5787.855303617275;5796.855078623068;5807.332156802022;6006.819795406145;6055.333913269625;6058.787942421994;6062.605930614673;6071.969640151771;5678.829635110953;5856.795012174553;5872.442117998783;5903.7048147593305;5922.289325280822 07:02:08 INFO - PID 18659 | |5;yui.html;695.9025736396909;718.669412070448;729.6607077708866;741.1883987034196;751.2712668711348;12374.319412432313;13212.735745285088;13291.800622990639;15198.468053618126;15636.296366663499;14923.925380373083;15105.244737763123;15313.081215127073;15366.308516116773;15437.305321260543;879.7140929198005;893.4237416866117;893.9329550283722;895.6014573514789;897.33148804141;890.1676932068505;890.692711014699;896.4576431259093;897.1253028297391;900.009989012088;934.6915517879117;938.7934654376027;942.4957647658504;942.604106275366;945.012461977232;912.4935660708304;920.3695468604028;923.1184219070772;924.2605915267759;924.7503174142977;684.5037347922766;686.2485578291762;686.2828344380085;689.9517033807585;689.9689513971883;13363.866361336359;13403.396847141901;13502.257375844325;13542.322883855768;13703.862961370358;13935.512257071056;14127.364268607835;14193.806393561366;14391.78412323816;14425.639359016004;11668.474918628683;11856.347900865449;11895.881041189565;11930.343831089287;11953.043756499459;2828.179827849921;2828.6747024092288;2853.9857300713365;2858.5283428234316;2862.3130448692373;68846.65576672084;68947;69632.651836741;69933.3006669932;70648;10043.497825108716;10150.543225554868;10152.137068349126;10174.135198508062;10242.385456872611;18896.622067558572;19065.42803715891;20370.694439583418;20485.18059277642;20667.483312916997;5982.162497250389;6000.759969601254;6102.633841969496;6122.724477398528;6125.081237814275;2692.5826496893014;2754.1599812057516;2765.9031933882216;2769.6399468069426;2778.3609769752666;3411.2324726936736;3497.45789402643;3510.4909788081095;3516.9120771980906;3517.56030496188;673.2426020726682;673.3636713305976;674.2919934069306;681.111149949311;681.7716065118142;506.4606194402949;507.04675210604563;510.9080365534239;549.1405949688724;551.4210079416597;8778.91221087781;9773.902260977442;9967.651132210338;10008.249381296286;10090.032443673414;543.6466296907042;544.7004147718739;546.4972225552422;550.6008144095499;559.5244042563869;4044.5348784890116;4299.097189590158;4354.760488173118;4378.890527736832;4463.174312752087;65763;66749;66872.33127668759;66950.27094039303;68214.3178568208;59138.40861591415;59597.10604340938;59884.401155987885;59918.700406497686;60082;53297.46702533003;53710.462895371325;54006.459935400926;54387.728061360234;54401.183982239505;9847.212223021997;10027.298089133983;10033.949830251095;10053.246006549683;10240.18078553699;27309.863450683413;27352.316192095357;28283.292917677223;28387.148385548466;29069;33550.83224583862;33963.3207335847;34608.65391346054;34737;35529.822350888084;13629.591112266648;13826.792598110835;13985.230812305013;14008.229547374993;14023.158610483404;14432.42270309176;14478;14506.492272770402;14810.777838332218;15001;14071.718565628425;14355.856441435451;14406.927965360106;14428.927855360656;14493.855061449673;14151.221682807132;14423.42306307736;14516.782248266496;14558.708825823212;14874.925625371803;13868.514601988882;13931.233782142079;14219.21794301282;14363.353649086026;14383.065100768417;9828.361156525089;10213.489325533843;10295.588176473157;10398.948005259925;10588.523516441932;11132.944335278271;11659.475323610288;11726.648200553997;11783.293002419883;11862.169648124549 07:02:08 INFO - PID 18659 | __end_tp_report 07:02:08 INFO - PID 18659 | __start_cc_report 07:02:08 INFO - PID 18659 | _x_x_mozilla_cycle_collect,363 07:02:08 INFO - PID 18659 | __end_cc_report 07:02:08 INFO - PID 18659 | __startTimestamp1493992928599__endTimestamp 07:02:08 INFO - PID 18659 | 07:02:08 INFO - PID 18659 | ------- Summary: start ------- 07:02:08 INFO - PID 18659 | Number of tests: 6 07:02:08 INFO - PID 18659 | 07:02:08 INFO - PID 18659 | [#0] dojo.html Cycles:165 Average:5328.44 Median:5458.84 stddev:631.40 (11.6%) stddev-sans-first:598.17 07:02:08 INFO - PID 18659 | Values: 2679.7 2692.3 2707.6 2726.9 2737.9 5299.7 5304.8 5331.7 5340.4 5382.7 5347.2 5418.7 5435.2 5436.9 5536.8 4744.7 4801.9 4833.4 4847.4 4892.1 4878.7 4886.1 4889.2 4894.8 4899.0 4721.7 4748.5 4781.7 4809.3 4867.8 4768.3 4771.5 4807.0 4810.3 4820.5 4696.4 4723.7 4748.2 4763.5 4797.5 5291.5 5321.2 5341.4 5360.5 5370.0 5790.4 5791.2 5791.9 5883.4 5892.2 5880.6 5903.1 5906.0 5910.1 5911.9 5379.4 5388.1 5392.6 5397.3 5411.3 5823.4 5891.4 5934.6 5947.6 5955.0 5652.7 5719.5 5725.4 5726.8 5729.8 5773.8 5798.4 5830.5 5844.4 5870.4 5763.7 5777.2 5807.7 5817.1 5826.5 5784.2 5812.6 5826.0 5837.3 5865.6 4986.2 4991.0 4993.9 5001.4 5035.8 4125.5 4197.9 4220.7 4269.7 4287.1 4967.1 4999.7 5007.3 5007.8 5023.6 5847.8 5848.1 5934.3 5955.9 5956.5 4976.6 5043.8 5047.7 5052.1 5061.9 5228.6 5253.5 5262.5 5279.7 5300.3 5404.9 5410.8 5413.9 5416.0 5477.9 5738.5 5793.0 5802.2 5896.1 5901.6 5410.7 5431.2 5451.7 5479.2 5502.3 5714.1 5722.4 5723.6 5728.9 5742.7 5765.1 5854.5 5866.9 5868.5 5869.4 5650.4 5677.3 5681.7 5685.0 5686.2 5644.6 5671.0 5672.3 5675.1 5676.0 5413.5 5458.8 5510.1 5515.8 5524.6 5660.6 5701.2 5710.0 5716.9 5720.0 5508.3 5510.1 5561.3 5576.8 5597.0 07:02:08 INFO - PID 18659 | 07:02:08 INFO - PID 18659 | [#1] ext.html Cycles:180 Average:31442.09 Median:30566.19 stddev:43723.76 (143.0%) stddev-sans-first:43785.61 07:02:08 INFO - PID 18659 | Values: 732.1 750.3 1039.6 1054.9 1135.8 30209.4 32657.5 32896.8 32969.2 33060.0 30877.4 31138.9 31205.7 31205.8 31471.2 6381.1 6384.5 6415.5 6432.0 6974.7 7075.9 7135.8 7191.9 7211.0 7212.1 7158.0 7182.4 7202.5 7209.9 7224.7 7095.7 7173.9 7184.5 7216.1 7219.9 7039.0 7092.9 7093.4 7099.3 7107.4 33091.7 33093.0 33150.5 33349.7 33548.0 3125.8 3159.7 3162.3 3164.4 3170.0 24857.4 24869.0 24916.3 25069.1 25166.9 2651.5 2670.4 2701.4 2717.2 2724.7 150932.0 151030.2 151256.0 151299.0 151879.2 38749.8 40662.0 40663.6 41725.6 42309.0 41710.4 41812.2 41861.2 41884.0 41943.0 12745.9 12888.8 12941.6 12972.4 12978.9 10324.6 10330.8 10340.9 10363.5 10375.1 12660.7 12804.8 12845.6 12896.8 12926.9 5237.9 5285.3 5288.0 5322.4 5371.7 878.3 906.2 919.5 931.2 958.4 20593.8 22185.3 26016.7 27218.7 27261.7 969.9 982.4 986.4 997.9 1005.7 11526.9 11835.9 11896.8 12024.8 12105.1 189397.0 190606.3 190795.0 191011.0 191060.0 41558.8 41715.4 41725.8 41860.0 41980.4 1204.6 1231.8 1242.7 1243.7 1251.4 20687.7 20986.3 21602.1 21672.3 21689.8 30607.4 30768.8 30854.5 30866.2 30902.7 162835.0 163712.0 164208.0 164678.0 165089.2 29073.1 29967.3 29985.2 30730.2 31276.5 36017.5 36513.1 36516.6 36553.6 36954.6 27847.9 28346.7 28789.7 29036.0 29589.4 27614.7 28087.2 28197.4 29371.4 29400.9 30460.8 30486.5 30525.0 30815.0 30940.5 26225.3 26995.2 27031.6 27264.5 28609.0 21467.0 23004.8 23043.3 23112.9 23382.5 07:02:08 INFO - PID 18659 | 07:02:08 INFO - PID 18659 | [#2] jquery.html Cycles:180 Average:25114.78 Median:39512.91 stddev:63043.18 (159.6%) stddev-sans-first:63192.72 07:02:08 INFO - PID 18659 | Values: 398.7 415.2 418.3 422.3 432.3 14317.7 17472.0 17878.2 18182.2 18196.7 18105.2 18262.5 18271.3 18351.7 18412.4 5395.8 5441.8 5645.1 5661.5 5683.9 5527.4 5623.4 5628.0 5629.3 5640.1 5430.7 5496.0 5539.3 5557.3 5560.1 5434.9 5436.3 5450.3 5455.7 5464.7 4845.2 4863.5 4956.9 4981.9 4986.9 20645.7 20902.1 21129.4 21587.9 21690.1 1635.3 1635.4 1664.4 1672.0 1673.5 14406.1 14739.6 14902.0 14943.9 15064.6 2124.8 2141.3 2176.9 2186.0 2189.4 79597.0 79847.0 79864.6 80837.0 80983.2 10692.2 10842.5 10934.9 11097.3 11174.4 14536.9 14980.9 15003.5 15019.8 15023.1 7846.6 7890.2 7973.9 8139.1 8150.6 7311.9 7397.2 7522.2 7610.1 7634.0 6718.3 6814.4 6867.7 6889.8 6965.9 1973.6 1979.7 1984.5 1985.8 2163.9 837.2 851.4 891.7 895.6 899.3 16545.5 17360.7 17410.7 17588.6 17650.8 891.6 894.3 906.3 911.8 922.0 8959.2 9433.3 9543.9 9648.7 9668.6 370180.0 379162.0 380229.0 381700.0 389780.0 78845.6 79191.6 79655.6 80688.2 81275.6 1075.5 1094.2 1097.3 1106.3 1109.3 17267.7 17391.4 18089.4 18187.5 18452.3 39461.6 39564.2 40017.0 40421.4 42006.2 49060.5 49095.5 49196.5 49394.8 52255.0 8064.9 8066.6 8383.1 8453.4 8618.1 12458.7 12519.3 12564.8 12623.5 12950.4 10790.9 10949.6 10986.7 11019.4 11131.9 10592.1 10652.5 10704.0 10741.8 10769.7 10969.1 11030.4 11212.0 11388.9 11545.5 7978.9 8218.4 8243.5 8368.8 8392.5 10607.8 10816.7 10870.5 11471.0 11505.5 07:02:08 INFO - PID 18659 | 07:02:08 INFO - PID 18659 | [#3] mootools.html Cycles:180 Average:6346.50 Median:3757.57 stddev:4094.51 (109.0%) stddev-sans-first:4088.09 07:02:08 INFO - PID 18659 | Values: 1251.1 1299.5 1311.5 1321.8 1330.0 9818.0 10314.6 10316.6 10389.1 10611.2 10425.0 10543.4 10577.8 10606.1 10612.4 2255.4 2282.5 2292.0 2297.4 2297.9 2218.9 2269.8 2280.2 2280.7 2282.9 2197.6 2219.2 2242.6 2244.5 2277.7 2145.1 2194.6 2205.7 2208.2 2208.9 2100.8 2153.6 2167.5 2233.1 2234.4 10094.3 10173.0 10271.6 10279.3 10304.3 5618.3 5829.9 5832.0 5832.3 5846.9 3214.5 3408.7 3499.2 3506.1 3511.4 1021.9 1028.8 1030.1 1034.4 1042.8 14810.7 14941.7 15058.2 15112.6 15154.4 4672.6 4747.8 4925.8 5059.5 5061.6 10261.4 10297.4 10301.5 10301.9 10306.5 5427.0 5470.4 5475.1 5482.0 5499.0 5007.8 5050.3 5079.9 5315.9 5345.9 3721.8 3865.3 3867.8 3948.2 3967.2 1159.6 1170.4 1170.7 1184.1 1184.6 691.4 701.3 702.3 710.6 721.0 5187.9 5275.7 5279.0 5340.3 5427.1 825.4 840.7 844.3 846.2 852.0 3740.4 3774.7 3864.6 3939.8 4205.2 13642.3 13860.6 14023.9 14117.6 14119.6 12941.0 13621.7 13704.5 13885.4 14018.1 7563.6 7732.4 7748.6 7769.1 7792.3 5574.9 5712.9 5975.6 6169.9 6313.3 11925.4 11955.1 12220.6 12238.8 12292.0 12050.5 12111.5 12470.9 12512.0 12527.8 8224.7 8553.1 8653.4 8669.7 8675.4 9480.8 9508.4 9514.3 9520.1 9521.0 7885.0 7960.9 7965.8 8111.3 8243.3 7901.8 8154.3 8203.4 8334.1 8548.8 7372.8 7374.1 7477.6 7478.8 7484.7 4884.8 5149.8 5192.4 5296.9 5452.1 5308.5 5322.7 5334.4 5393.1 5550.0 07:02:08 INFO - PID 18659 | 07:02:08 INFO - PID 18659 | [#4] prototype.html Cycles:180 Average:4891.70 Median:5590.66 stddev:1474.63 (26.4%) stddev-sans-first:1439.18 07:02:08 INFO - PID 18659 | Values: 370.2 385.6 387.6 392.5 394.1 5577.7 5626.8 5725.0 5742.1 5745.7 5458.6 5547.1 5554.7 5580.1 5582.4 4204.0 4208.9 4212.9 4216.3 4225.4 4115.6 4186.6 4197.8 4219.7 4228.6 4148.1 4154.5 4157.3 4158.2 4186.9 4147.1 4172.6 4177.2 4177.5 4182.5 3592.6 3633.7 3647.0 3659.8 3665.0 5458.5 5469.4 5471.5 5487.9 5548.0 4902.9 4905.4 4912.3 4912.7 4918.1 5733.0 5916.7 5917.4 5956.9 5976.4 4083.4 4086.2 4089.1 4097.6 4099.8 6076.2 6279.4 6299.1 6305.4 6373.4 4118.2 4140.5 4162.1 4174.5 4177.3 4206.6 4228.2 4234.4 4248.5 4250.9 4785.3 4798.4 4879.9 4895.0 4896.9 5914.1 5931.4 5933.5 5939.5 5944.3 1442.1 1461.7 1465.3 1468.9 1470.3 925.1 960.9 964.2 981.9 983.6 5123.1 5145.3 5160.8 5166.4 5168.4 6118.4 6130.2 6178.8 6181.3 6194.5 5041.2 5123.4 5212.2 5271.1 5273.8 3302.8 3304.9 3323.6 3347.9 3350.2 5711.3 5742.6 5764.4 5781.9 5806.6 6381.4 6413.5 6418.2 6442.4 6449.7 5598.9 5732.2 5745.0 5784.2 5789.5 6162.7 6169.5 6220.5 6222.6 6257.6 5909.6 6092.5 6094.5 6126.9 6157.1 5743.6 5776.4 5785.1 5785.5 5796.9 4138.8 4173.3 4188.5 4200.9 4211.8 6135.0 6256.4 6259.4 6296.2 6318.3 5959.1 5971.8 5992.7 6021.8 6022.7 5781.5 5940.3 5998.0 6012.7 6024.6 5748.1 5785.5 5787.9 5796.9 5807.3 6006.8 6055.3 6058.8 6062.6 6072.0 5678.8 5856.8 5872.4 5903.7 5922.3 07:02:08 INFO - PID 18659 | 07:02:08 INFO - PID 18659 | [#5] yui.html Cycles:180 Average:15306.79 Median:33757.08 stddev:18571.06 (55.0%) stddev-sans-first:18590.74 07:02:08 INFO - PID 18659 | Values: 695.9 718.7 729.7 741.2 751.3 12374.3 13212.7 13291.8 15198.5 15636.3 14923.9 15105.2 15313.1 15366.3 15437.3 879.7 893.4 893.9 895.6 897.3 890.2 890.7 896.5 897.1 900.0 934.7 938.8 942.5 942.6 945.0 912.5 920.4 923.1 924.3 924.8 684.5 686.2 686.3 690.0 690.0 13363.9 13403.4 13502.3 13542.3 13703.9 13935.5 14127.4 14193.8 14391.8 14425.6 11668.5 11856.3 11895.9 11930.3 11953.0 2828.2 2828.7 2854.0 2858.5 2862.3 68846.7 68947.0 69632.7 69933.3 70648.0 10043.5 10150.5 10152.1 10174.1 10242.4 18896.6 19065.4 20370.7 20485.2 20667.5 5982.2 6000.8 6102.6 6122.7 6125.1 2692.6 2754.2 2765.9 2769.6 2778.4 3411.2 3497.5 3510.5 3516.9 3517.6 673.2 673.4 674.3 681.1 681.8 506.5 507.0 510.9 549.1 551.4 8778.9 9773.9 9967.7 10008.2 10090.0 543.6 544.7 546.5 550.6 559.5 4044.5 4299.1 4354.8 4378.9 4463.2 65763.0 66749.0 66872.3 66950.3 68214.3 59138.4 59597.1 59884.4 59918.7 60082.0 53297.5 53710.5 54006.5 54387.7 54401.2 9847.2 10027.3 10033.9 10053.2 10240.2 27309.9 27352.3 28283.3 28387.1 29069.0 33550.8 33963.3 34608.7 34737.0 35529.8 13629.6 13826.8 13985.2 14008.2 14023.2 14432.4 14478.0 14506.5 14810.8 15001.0 14071.7 14355.9 14406.9 14428.9 14493.9 14151.2 14423.4 14516.8 14558.7 14874.9 13868.5 13931.2 14219.2 14363.4 14383.1 9828.4 10213.5 10295.6 10398.9 10588.5 11132.9 11659.5 11726.6 11783.3 11862.2 07:02:08 INFO - PID 18659 | -------- Summary: end -------- 07:02:08 INFO - PID 18659 | 07:02:09 INFO - TEST-INFO | 18659: exit 0 07:02:09 INFO - TEST-OK | dromaeo_css | took 1119663ms 07:02:09 INFO - TEST-START | kraken 07:02:09 INFO - operating with platform_type : linux_ 07:02:09 INFO - Initialising browser for kraken test... 07:02:09 INFO - TEST-INFO | started process 19081 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzHv3O8/profile http://localhost:54929/getInfo.html) 07:02:13 INFO - PID 19081 | __metrics Screen width/height:1600/1200 07:02:13 INFO - PID 19081 | colorDepth:24 07:02:13 INFO - PID 19081 | Browser inner width/height: 1024/695 07:02:13 INFO - PID 19081 | __metrics 07:02:15 INFO - TEST-INFO | 19081: exit 0 07:02:15 INFO - Browser initialized. 07:02:15 INFO - Running cycle 1/1 for kraken test... 07:02:15 INFO - TEST-INFO | started process 19261 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzHv3O8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:02:27 INFO - PID 19261 | RSS: Main: 160845824 07:02:27 INFO - PID 19261 | 07:02:30 INFO - PID 19261 | Cycle 1(1): loaded http://localhost:54929/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54929/tests/kraken/driver.html?testName=audio-beat-detection) 07:02:31 INFO - PID 19261 | RSS: Main: 166100992 07:02:31 INFO - PID 19261 | 07:02:33 INFO - PID 19261 | Cycle 1(1): loaded http://localhost:54929/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54929/tests/kraken/driver.html?testName=audio-dft) 07:02:34 INFO - PID 19261 | RSS: Main: 164442112 07:02:34 INFO - PID 19261 | 07:02:37 INFO - PID 19261 | Cycle 1(1): loaded http://localhost:54929/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54929/tests/kraken/driver.html?testName=audio-fft) 07:02:38 INFO - PID 19261 | RSS: Main: 160948224 07:02:38 INFO - PID 19261 | 07:02:40 INFO - PID 19261 | Cycle 1(1): loaded http://localhost:54929/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54929/tests/kraken/driver.html?testName=audio-oscillator) 07:02:40 INFO - PID 19261 | RSS: Main: 161746944 07:02:40 INFO - PID 19261 | 07:02:42 INFO - PID 19261 | Cycle 1(1): loaded http://localhost:54929/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54929/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:02:43 INFO - PID 19261 | RSS: Main: 161812480 07:02:43 INFO - PID 19261 | 07:02:46 INFO - PID 19261 | Cycle 1(1): loaded http://localhost:54929/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54929/tests/kraken/driver.html?testName=imaging-darkroom) 07:02:47 INFO - PID 19261 | RSS: Main: 167567360 07:02:47 INFO - PID 19261 | 07:02:50 INFO - PID 19261 | Cycle 1(1): loaded http://localhost:54929/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54929/tests/kraken/driver.html?testName=imaging-desaturate) 07:02:51 INFO - PID 19261 | RSS: Main: 165330944 07:02:51 INFO - PID 19261 | 07:02:54 INFO - PID 19261 | Cycle 1(1): loaded http://localhost:54929/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54929/tests/kraken/driver.html?testName=json-parse-financial) 07:02:55 INFO - PID 19261 | RSS: Main: 166146048 07:02:55 INFO - PID 19261 | 07:02:56 INFO - PID 19261 | Cycle 1(1): loaded http://localhost:54929/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54929/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:02:57 INFO - PID 19261 | RSS: Main: 166449152 07:02:57 INFO - PID 19261 | 07:02:59 INFO - PID 19261 | Cycle 1(1): loaded http://localhost:54929/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54929/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:02:59 INFO - PID 19261 | RSS: Main: 166420480 07:02:59 INFO - PID 19261 | 07:03:01 INFO - PID 19261 | Cycle 1(1): loaded http://localhost:54929/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54929/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:03:02 INFO - PID 19261 | RSS: Main: 166232064 07:03:02 INFO - PID 19261 | 07:03:05 INFO - PID 19261 | Cycle 1(1): loaded http://localhost:54929/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54929/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:03:05 INFO - PID 19261 | RSS: Main: 166658048 07:03:05 INFO - PID 19261 | 07:03:09 INFO - PID 19261 | Cycle 1(1): loaded http://localhost:54929/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54929/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:03:09 INFO - PID 19261 | RSS: Main: 166649856 07:03:09 INFO - PID 19261 | 07:03:11 INFO - PID 19261 | Cycle 1(1): loaded http://localhost:54929/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54929/tests/kraken/driver.html?testName=ai-astar) 07:03:11 INFO - PID 19261 | RSS: Main: 168521728 07:03:11 INFO - PID 19261 | 07:03:11 INFO - PID 19261 | __start_tp_report 07:03:11 INFO - PID 19261 | _x_x_mozilla_page_load 07:03:11 INFO - PID 19261 | _x_x_mozilla_page_load_details 07:03:11 INFO - PID 19261 | |i|pagename|runs| 07:03:11 INFO - PID 19261 | |0;ai-astar;105;113;111;112;112;111;112;111;112;112 07:03:11 INFO - PID 19261 | |1;audio-beat-detection;155;125;127;172;125;127;128;128;150;126 07:03:11 INFO - PID 19261 | |2;audio-dft;164;164;163;163;170;166;177;167;163;163 07:03:11 INFO - PID 19261 | |3;audio-fft;75;75;77;112;75;76;76;76;100;75 07:03:11 INFO - PID 19261 | |4;audio-oscillator;84;84;101;84;85;84;100;84;83;103 07:03:11 INFO - PID 19261 | |5;imaging-gaussian-blur;114;114;114;115;114;114;114;115;114;113 07:03:11 INFO - PID 19261 | |6;imaging-darkroom;151;150;149;153;150;150;152;151;150;150 07:03:11 INFO - PID 19261 | |7;imaging-desaturate;95;95;95;94;95;95;95;94;95;95 07:03:11 INFO - PID 19261 | |8;json-parse-financial;56;54;54;55;55;56;57;55;57;55 07:03:11 INFO - PID 19261 | |9;json-stringify-tinderbox;55;55;57;55;56;55;56;55;56;56 07:03:11 INFO - PID 19261 | |10;stanford-crypto-aes;81;90;83;82;80;80;81;82;80;87 07:03:11 INFO - PID 19261 | |11;stanford-crypto-ccm;129;133;136;131;141;131;132;133;181;136 07:03:11 INFO - PID 19261 | |12;stanford-crypto-pbkdf2;186;187;198;194;195;203;193;190;193;197 07:03:11 INFO - PID 19261 | |13;stanford-crypto-sha256-iterative;74;75;77;70;71;77;71;71;77;70 07:03:11 INFO - PID 19261 | __end_tp_report 07:03:11 INFO - PID 19261 | __start_cc_report 07:03:11 INFO - PID 19261 | _x_x_mozilla_cycle_collect,825 07:03:11 INFO - PID 19261 | __end_cc_report 07:03:11 INFO - PID 19261 | __startTimestamp1493992991778__endTimestamp 07:03:11 INFO - PID 19261 | 07:03:11 INFO - PID 19261 | ------- Summary: start ------- 07:03:11 INFO - PID 19261 | Number of tests: 14 07:03:11 INFO - PID 19261 | 07:03:11 INFO - PID 19261 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.23 (2.0%) stddev-sans-first:0.67 07:03:11 INFO - PID 19261 | Values: 105.0 113.0 111.0 112.0 112.0 111.0 112.0 111.0 112.0 112.0 07:03:11 INFO - PID 19261 | 07:03:11 INFO - PID 19261 | [#1] audio-beat-detection Cycles:10 Average:136.30 Median:128.00 stddev:16.61 (13.0%) stddev-sans-first:16.18 07:03:11 INFO - PID 19261 | Values: 155.0 125.0 127.0 172.0 125.0 127.0 128.0 128.0 150.0 126.0 07:03:11 INFO - PID 19261 | 07:03:11 INFO - PID 19261 | [#2] audio-dft Cycles:10 Average:166.00 Median:165.00 stddev:4.50 (2.7%) stddev-sans-first:4.71 07:03:11 INFO - PID 19261 | Values: 164.0 164.0 163.0 163.0 170.0 166.0 177.0 167.0 163.0 163.0 07:03:11 INFO - PID 19261 | 07:03:11 INFO - PID 19261 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.50 stddev:13.13 (17.4%) stddev-sans-first:13.70 07:03:11 INFO - PID 19261 | Values: 75.0 75.0 77.0 112.0 75.0 76.0 76.0 76.0 100.0 75.0 07:03:11 INFO - PID 19261 | 07:03:11 INFO - PID 19261 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:84.00 stddev:8.42 (10.0%) stddev-sans-first:8.71 07:03:11 INFO - PID 19261 | Values: 84.0 84.0 101.0 84.0 85.0 84.0 100.0 84.0 83.0 103.0 07:03:11 INFO - PID 19261 | 07:03:11 INFO - PID 19261 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 07:03:11 INFO - PID 19261 | Values: 114.0 114.0 114.0 115.0 114.0 114.0 114.0 115.0 114.0 113.0 07:03:11 INFO - PID 19261 | 07:03:11 INFO - PID 19261 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:150.50 stddev:1.17 (0.8%) stddev-sans-first:1.24 07:03:11 INFO - PID 19261 | Values: 151.0 150.0 149.0 153.0 150.0 150.0 152.0 151.0 150.0 150.0 07:03:11 INFO - PID 19261 | 07:03:11 INFO - PID 19261 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:03:11 INFO - PID 19261 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 07:03:11 INFO - PID 19261 | 07:03:11 INFO - PID 19261 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:1.07 (1.9%) stddev-sans-first:1.12 07:03:11 INFO - PID 19261 | Values: 56.0 54.0 54.0 55.0 55.0 56.0 57.0 55.0 57.0 55.0 07:03:11 INFO - PID 19261 | 07:03:11 INFO - PID 19261 | [#9] json-stringify-tinderbox Cycles:10 Average:55.60 Median:56.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 07:03:11 INFO - PID 19261 | Values: 55.0 55.0 57.0 55.0 56.0 55.0 56.0 55.0 56.0 56.0 07:03:11 INFO - PID 19261 | 07:03:11 INFO - PID 19261 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.00 stddev:3.34 (4.1%) stddev-sans-first:3.49 07:03:11 INFO - PID 19261 | Values: 81.0 90.0 83.0 82.0 80.0 80.0 81.0 82.0 80.0 87.0 07:03:11 INFO - PID 19261 | 07:03:11 INFO - PID 19261 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:134.50 stddev:15.38 (11.4%) stddev-sans-first:15.95 07:03:11 INFO - PID 19261 | Values: 129.0 133.0 136.0 131.0 141.0 131.0 132.0 133.0 181.0 136.0 07:03:11 INFO - PID 19261 | 07:03:11 INFO - PID 19261 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.60 Median:194.50 stddev:5.13 (2.6%) stddev-sans-first:4.64 07:03:11 INFO - PID 19261 | Values: 186.0 187.0 198.0 194.0 195.0 203.0 193.0 190.0 193.0 197.0 07:03:11 INFO - PID 19261 | 07:03:11 INFO - PID 19261 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:74.50 stddev:3.02 (4.1%) stddev-sans-first:3.19 07:03:11 INFO - PID 19261 | Values: 74.0 75.0 77.0 70.0 71.0 77.0 71.0 71.0 77.0 70.0 07:03:11 INFO - PID 19261 | -------- Summary: end -------- 07:03:11 INFO - PID 19261 | 07:03:12 INFO - TEST-INFO | 19261: exit 0 07:03:13 INFO - TEST-OK | kraken | took 63643ms 07:03:13 INFO - SUITE-END | took 1183s 07:03:13 INFO - Completed test suite (00:19:43) 07:03:13 INFO - javascript benchmark 07:03:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6792.645874057645, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2679.67843858737, 2692.30000199948, 2707.634469346639, 2726.8772905219253, 2737.876795544201, 5299.682019078858, 5304.840854774353, 5331.7334133293325, 5340.412554618999, 5382.730863456826, 5347.197920311955, 5418.729063546826, 5435.239066530679, 5436.864078398042, 5536.75084621192, 4744.691595046311, 4801.90396192076, 4833.3958255218095, 4847.418309802829, 4892.094962431944, 4878.731669758162, 4886.1204983103025, 4889.168841296988, 4894.755262236892, 4898.995705880304, 4721.740304283263, 4748.477667456577, 4781.665283430161, 4809.278608208761, 4867.756612169377, 4768.260919557474, 4771.475137734847, 4806.975965120187, 4810.254410566367, 4820.493848145929, 4696.412948381452, 4723.669343145981, 4748.169070412664, 4763.476017638057, 4797.544233297831, 5291.4708529147165, 5321.201819727034, 5341.43914888935, 5360.463953604647, 5370.033393989081, 5790.420957904218, 5791.189233507313, 5791.8552036199435, 5883.411658834125, 5892.204552385416, 5880.5883588148845, 5903.0555111182, 5906.025505791539, 5910.083936989773, 5911.852203694899, 5379.354477462652, 5388.057090009311, 5392.595555333366, 5397.271368365299, 5411.269478620415, 5823.417658234227, 5891.351951285355, 5934.643921364732, 5947.5539334550085, 5954.970225148846, 5652.74562644682, 5719.542436605062, 5725.398833122462, 5726.77092916287, 5729.7708091676695, 5773.797917072882, 5798.391168927286, 5830.533557315404, 5844.357120716718, 5870.412958704095, 5763.7118144093465, 5777.191193232867, 5807.738651760681, 5817.127430885316, 5826.533877289807, 5784.248047753849, 5812.622179558315, 5826.0, 5837.270341207349, 5865.648061116347, 4986.152354099811, 4990.950090499121, 4993.875153121128, 5001.44984051754, 5035.84892453227, 4125.484314460692, 4197.9370309445385, 4220.746755194698, 4269.743815371087, 4287.142571485715, 4967.105920934194, 4999.700017998932, 5007.298978143063, 5007.799688012438, 5023.648344615842, 5847.8245652630485, 5848.064309710426, 5934.3175534814045, 5955.851103722442, 5956.493698035629, 4976.62675299354, 5043.823466178666, 5047.747612619354, 5052.065367906949, 5061.8734531637, 5228.607854410934, 5253.50091741284, 5262.526372626482, 5279.709615971082, 5300.337457817773, 5404.891902162013, 5410.783568657288, 5413.945860541423, 5415.972920135532, 5477.863053423696, 5738.540916726735, 5792.9710351447975, 5802.245708058094, 5896.086106653475, 5901.557383196192, 5410.702411367255, 5431.185322201702, 5451.7001564912725, 5479.150731636602, 5502.339719233718, 5714.142878568248, 5722.370539240597, 5723.599348045597, 5728.942710572841, 5742.712864356849, 5765.077587585966, 5854.531637468907, 5866.882662346815, 5868.501177399798, 5869.413058694096, 5650.378458369494, 5677.290338707661, 5681.687507187145, 5684.971575142098, 5686.175504551734, 5644.604877658525, 5671.035923892866, 5672.290963629546, 5675.091985282335, 5675.971620141873, 5413.53984911287, 5458.836234912959, 5510.063289240758, 5515.834524964257, 5524.558035357242, 5660.632058916157, 5701.173329867063, 5709.9714501427225, 5716.857078573069, 5719.970405326914, 5508.338999320107, 5510.1459273812625, 5561.277033985556, 5576.804811831566, 5597.0], "value": 5280.887818534115, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.103173612325, 750.2984709296808, 1039.6049501189548, 1054.8839627640964, 1135.7955567997758, 30209.395812083745, 32657.51013734796, 32896.835515822415, 32969.17577060575, 33060.0, 30877.38245235094, 31138.862087755493, 31205.687943120563, 31205.84397078017, 31471.21321966952, 6381.074744162093, 6384.5211609129265, 6415.486761059127, 6431.967840160793, 6974.721011159548, 7075.893861592081, 7135.8216044598785, 7191.856162876739, 7210.963945180293, 7212.134543854719, 7157.964210178942, 7182.389496892744, 7202.53183543068, 7209.855802883939, 7224.7110115595315, 7095.7161713531395, 7173.89239161413, 7184.497085204038, 7216.134063912312, 7219.8917016244795, 7039.0, 7092.858142837166, 7093.432525398008, 7099.254578269259, 7107.360337569644, 33091.6690833091, 33093.0, 33150.502742458884, 33349.6665033349, 33548.0, 3125.8124512529093, 3159.7314228290625, 3162.304293055524, 3164.4462219111565, 3169.9683003169903, 24857.378565535826, 24869.0, 24916.252512424657, 25069.122580709587, 25166.874165629055, 2651.469706058777, 2670.3991601889616, 2701.405690748032, 2717.2120085175275, 2724.6730392352847, 150932.0, 151030.24484877614, 151256.0, 151299.0, 151879.24060379626, 38749.80625096913, 40662.0, 40663.59336406598, 41725.58274417217, 42309.0, 41710.37434438486, 41812.163756724694, 41861.1627767449, 41884.0, 41943.0, 12745.936270318589, 12888.80666789999, 12941.611751647277, 12972.416241268977, 12978.870211297955, 10324.638637647646, 10330.845037324447, 10340.896591034143, 10363.533640986174, 10375.118114960313, 12660.683482913, 12804.80792788109, 12845.614631561068, 12896.80654790179, 12926.870731292754, 5237.869053273698, 5285.286486324297, 5287.9735601321745, 5322.414534401213, 5371.677699338053, 878.2754227762122, 906.2297047509564, 919.5218486387041, 931.1573026411108, 958.4393130018877, 20593.794062059187, 22185.334439966828, 26016.73983260143, 27218.72781272162, 27261.727382726316, 969.8545218217324, 982.3909176310733, 986.3982970388057, 997.945113018791, 1005.7133716890651, 11526.88473115275, 11835.940820296015, 11896.762064758655, 12024.819627705592, 12105.09211809118, 189397.0, 190606.26815380022, 190795.0, 191011.0, 191060.0, 41558.79220603938, 41715.37426938598, 41725.79137104295, 41860.0, 41980.37029444561, 1204.6145233525363, 1231.8460192475761, 1242.6706922665321, 1243.6828608704902, 1251.380566619511, 20687.68968465444, 20986.265480708713, 21602.13591456324, 21672.34982950514, 21689.783102169407, 30607.387852243275, 30768.84615576908, 30854.53718194184, 30866.228344291572, 30902.690973089982, 162835.0, 163712.0, 164208.0, 164678.0, 165089.17455412645, 29073.12780616585, 29967.250818728833, 29985.15141061683, 30730.231744206572, 31276.530852036783, 36017.459738103425, 36513.08717281983, 36516.63483365239, 36553.63446365502, 36954.6304536962, 27847.86076069607, 28346.71653283523, 28789.712102878704, 29036.0, 29589.408211835213, 27614.723852762017, 28087.157385278475, 28197.43605127927, 29371.412571748016, 29400.852995734884, 30460.84769576138, 30486.542701859933, 30525.0, 30815.0, 30940.53589196119, 26225.329111151674, 26995.190144295702, 27031.594526082517, 27264.454710906066, 28609.0, 21467.0, 23004.769952300932, 23043.308700739006, 23112.884435577715, 23382.53234935326], "value": 14788.380430790521, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.73683368976447, 415.2069547164914, 418.27638185938326, 422.282120395328, 432.33636368174837, 14317.713645727104, 17472.0, 17878.195481203344, 18182.181801818933, 18196.727049094257, 18105.185266663, 18262.543436414097, 18271.269149234016, 18351.724724129148, 18412.35556755514, 5395.81114660987, 5441.782328706847, 5645.096784514479, 5661.490465858072, 5683.914741278884, 5527.419620939803, 5623.381428042912, 5628.0, 5629.268195134627, 5640.097584386499, 5430.681704760947, 5496.0, 5539.335279766434, 5557.3331200256025, 5560.138178582326, 5434.91847622284, 5436.293281873351, 5450.291462109901, 5455.727213639322, 5464.6994415307145, 4845.152098382769, 4863.465018847924, 4956.8760780980765, 4981.900361992776, 4986.850394488171, 20645.72896981346, 20902.059407326706, 21129.366119016453, 21587.920603969895, 21690.132394704193, 1635.255958538862, 1635.3540351561066, 1664.4340924085748, 1672.046933248049, 1673.5481420016526, 14406.135631862122, 14739.631509212248, 14902.0, 14943.850561494462, 15064.623384415368, 2124.8406369522195, 2141.3361857824125, 2176.92380766674, 2185.9562808743894, 2189.408859607897, 79597.0, 79847.0, 79864.60067699624, 80837.0, 80983.19016809815, 10692.198085143646, 10842.512086956105, 10934.945325273322, 11097.278676885977, 11174.441277936234, 14536.854631453762, 14980.850191498164, 15003.474878379204, 15019.849801502063, 15023.09861408319, 7846.568438735924, 7890.171531989058, 7973.880391794128, 8139.110615731449, 8150.551719655476, 7311.853762924712, 7397.223291554417, 7522.172561018284, 7610.086789585285, 7634.0, 6718.294579069225, 6814.352636499525, 6867.690953907087, 6889.793306200822, 6965.930340696629, 1973.6447439461035, 1979.683250679913, 1984.474114359696, 1985.7716362618196, 2163.9026243818753, 837.1703641691166, 851.4040171879709, 891.6656253904786, 895.6462197431978, 899.3120262998812, 16545.50363489097, 17360.739588906177, 17410.65178696419, 17588.560285992953, 17650.823491765175, 891.5765011619429, 894.3203165594196, 906.2659246010752, 911.7583840282331, 921.9815603687889, 8959.23846473044, 9433.29250306216, 9543.9045609543, 9648.71053868385, 9668.613255469843, 370180.0, 379162.0, 380229.0, 381700.0, 389780.0, 78845.60577197078, 79191.60404197942, 79655.60172199101, 80688.19311806925, 81275.5936220315, 1075.4622688655672, 1094.2121672395863, 1097.3251450358132, 1106.330669944688, 1109.2512554026, 17267.65464690674, 17391.391301304393, 18089.36687215941, 18187.45437636873, 18452.26190952347, 39461.605383945796, 39564.20871582495, 40017.0, 40421.393679095425, 42006.15987680291, 49060.509394905595, 49095.50904491052, 49196.508034920626, 49394.75302623464, 52255.0, 8064.919350806417, 8066.556339401389, 8383.119772423808, 8453.365997550085, 8618.052014278299, 12458.688532786753, 12519.311437871005, 12564.811527826907, 12623.495060197489, 12950.417231224807, 10790.89209107899, 10949.56201751921, 10986.725331866768, 11019.449027548751, 11131.944340278247, 10592.099671528007, 10652.520636571218, 10704.0, 10741.785164296827, 10769.676909692722, 10969.067629251604, 11030.44847757625, 11212.0, 11388.886111139114, 11545.480453379787, 7978.920210797818, 8218.383621228311, 8243.505389676639, 8368.790780230544, 8392.538410387488, 10607.840882386616, 10816.729581760204, 10870.549147754396, 11470.967612914877, 11505.482253298454], "value": 8891.449212422032, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1251.1117106854135, 1299.4802079168333, 1311.475409836065, 1321.7752981993058, 1329.9933500332497, 9818.0, 10314.638987635435, 10316.58733650654, 10389.116925061378, 10611.204159688015, 10425.0, 10543.41848722692, 10577.841332380001, 10606.098481629051, 10612.416317102556, 2255.4023183856293, 2282.47503074293, 2291.9770802291932, 2297.3797074789795, 2297.9195728149516, 2218.866867987926, 2269.841111122222, 2280.2361208994926, 2280.6579013147993, 2282.897269622871, 2197.571473562656, 2219.223271854854, 2242.618754811686, 2244.4837687331924, 2277.6697378880053, 2145.1419432227076, 2194.550117225973, 2205.680176374433, 2208.182972300251, 2208.9005994730355, 2100.810927016576, 2153.569286142762, 2167.4581354661336, 2233.106757297078, 2234.4302202938147, 10094.29339946204, 10173.033561811617, 10271.589136434608, 10279.280450368477, 10304.330218535772, 5618.269624948772, 5829.88340233193, 5831.970840145772, 5832.300123985106, 5846.912296315559, 3214.4696125139326, 3408.727301815849, 3499.212677147647, 3506.0533655913014, 3511.3855075361707, 1021.918246540275, 1028.7890982348677, 1030.0986636692894, 1034.3586976074882, 1042.796654652343, 14810.703785924221, 14941.70116597662, 15058.171800550965, 15112.622184445367, 15154.393824247018, 4672.602828759525, 4747.786349614206, 4925.827596034122, 5059.494050594911, 5061.5950723942, 10261.435621040915, 10297.433641149659, 10301.53643086063, 10301.9484902575, 10306.484675766182, 5426.972865135649, 5470.398256191816, 5475.123980163155, 5482.0406428874785, 5499.037668408093, 5007.799688012438, 5050.318207042076, 5079.8984020319385, 5315.893682126336, 5345.946540534623, 3721.776693398405, 3865.304245235828, 3867.845286188577, 3948.2103579284258, 3967.2462232175794, 1159.565163063851, 1170.3504554972071, 1170.6780635325183, 1184.0705046538426, 1184.620921305174, 691.4330249195611, 701.2916953876621, 702.3433090060707, 710.5878590417545, 721.0158134146957, 5187.870303242374, 5275.657082289639, 5278.973605132027, 5340.332458442695, 5427.050266203478, 825.3603457320625, 840.7351684219574, 844.3161039557978, 846.2003406780657, 851.974440766778, 3740.401535754321, 3774.735768496179, 3864.574896761354, 3939.842406303716, 4205.222033923734, 13642.317884105754, 13860.584182474542, 14023.85976140246, 14117.576472705836, 14119.576412707429, 12941.0, 13621.727565448833, 13704.45182192721, 13885.37515811791, 14018.088824226392, 7563.584002879785, 7732.4200684948855, 7748.612569371621, 7769.067711874612, 7792.337651299589, 5574.944250557604, 5712.885742285214, 5975.611585246945, 6169.876602468015, 6313.337099604475, 11925.403729813648, 11955.103367247317, 12220.572279970158, 12238.816417753562, 12292.0, 12050.51797928073, 12111.515539378326, 12470.875291246972, 12512.0, 12527.812082818582, 8224.671013159406, 8553.144685531397, 8653.35099867525, 8669.653213871374, 8675.392722509363, 9480.814888184386, 9508.429494230368, 9514.286428518028, 9520.095590918852, 9521.0, 7885.0, 7960.920390796249, 7965.800854978672, 8111.269985701315, 8243.25810677042, 7901.841963160819, 8154.266116049584, 8203.384746143944, 8334.12491688364, 8548.829023419621, 7372.778816635509, 7374.078240219973, 7477.588732619541, 7478.775636730907, 7484.700611975678, 4884.804607815648, 5149.819756308511, 5192.402873669576, 5296.894062118813, 5452.127659574449, 5308.548773354154, 5322.733863306742, 5334.3865455473115, 5393.083175860192, 5550.0], "value": 4779.467379861861, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.1837448426219, 385.5508332792297, 387.56979752474746, 392.54660866698936, 394.1152113505181, 5577.69322687252, 5626.803061892834, 5724.971375143124, 5742.138679198112, 5745.6839873806975, 5458.61789674723, 5547.0585295146675, 5554.666719996793, 5580.079286917654, 5582.413846546105, 4203.978980105103, 4208.915821683565, 4212.936805947913, 4216.304309788897, 4225.366195070733, 4115.603253457057, 4186.623203911648, 4197.7901104944785, 4219.662427005847, 4228.577142285778, 4148.149629325996, 4154.459920210368, 4157.272477316457, 4158.168366326731, 4186.853460128896, 4147.087640719052, 4172.645325147381, 4177.206330797138, 4177.49870015597, 4182.53992060873, 3592.6227746086547, 3633.6911362534215, 3647.0335361129323, 3659.8277963122064, 3665.0, 5458.4814442627885, 5469.398366179717, 5471.534919531845, 5487.9298536785345, 5547.972260138714, 4902.926456103126, 4905.4358748744, 4912.312276281324, 4912.7297998610065, 4918.114739346916, 5733.0, 5916.674582897939, 5917.378675239124, 5956.851078723023, 5976.372480889531, 4083.4283200351974, 4086.1827634473225, 4089.1003979124544, 4097.631213190827, 4099.7745124018165, 6076.240469941257, 6279.403456671609, 6299.0866324382705, 6305.432511073979, 6373.362663733636, 4118.217538667644, 4140.523839758406, 4162.128131589194, 4174.478190226222, 4177.289860723684, 4206.558311377261, 4228.1966426378885, 4234.449521562177, 4248.468941382327, 4250.851220207278, 4785.2582849657665, 4798.376211092535, 4879.853604391874, 4895.0, 4896.926546101811, 5914.112883067574, 5931.436513531207, 5933.525317974551, 5939.544811521205, 5944.3164036136395, 1442.1058943455125, 1461.7295800276984, 1465.2673663168416, 1468.948586799457, 1470.2501724120561, 925.1497005988024, 960.8750862387984, 964.1563631822156, 981.8821741390936, 983.5524836199512, 5123.052235336475, 5145.331106956071, 5160.845174644766, 5166.405863325691, 5168.3797944246935, 6118.388161183846, 6130.233720784902, 6178.783742568989, 6181.289151747516, 6194.5354098442795, 5041.193409054534, 5123.437351607796, 5212.166053431432, 5271.130263506555, 5273.789048438096, 3302.8183449910484, 3304.9173770655925, 3323.6011678598725, 3347.9330413391594, 3350.2294472271515, 5711.343195532484, 5742.569307301969, 5764.365919748824, 5781.918509336635, 5806.622569532967, 6381.361863813581, 6413.486921046305, 6418.19772528434, 6442.420182183626, 6449.677516124175, 5598.916016259841, 5732.2230108666445, 5744.965906136852, 5784.1902133701315, 5789.53683705311, 6162.722677479614, 6169.475594574512, 6220.533459990428, 6222.595531290452, 6257.5932564383165, 5909.556783241188, 6092.543059270661, 6094.512439004958, 6126.877462450637, 6157.0605259343165, 5743.62666426681, 5776.393478684846, 5785.132230165341, 5785.508231800176, 5796.913046304225, 4138.751674899516, 4173.290540608044, 4188.476440444944, 4200.91598168041, 4211.789410529523, 6135.0, 6256.374362563707, 6259.405356491126, 6296.181496405438, 6318.304986451395, 5959.106134079922, 5971.7611295547695, 5992.700364981646, 6021.832140429355, 6022.668753218615, 5781.508571771446, 5940.346561878277, 5997.970010149921, 6012.669303188367, 6024.608400453956, 5748.137779333133, 5785.508231800176, 5787.855303617275, 5796.855078623068, 5807.332156802022, 6006.819795406145, 6055.333913269625, 6058.787942421994, 6062.605930614673, 6071.969640151771, 5678.829635110953, 5856.795012174553, 5872.442117998783, 5903.7048147593305, 5922.289325280822], "value": 4432.774976311122, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.9025736396909, 718.669412070448, 729.6607077708866, 741.1883987034196, 751.2712668711348, 12374.319412432313, 13212.735745285088, 13291.800622990639, 15198.468053618126, 15636.296366663499, 14923.925380373083, 15105.244737763123, 15313.081215127073, 15366.308516116773, 15437.305321260543, 879.7140929198005, 893.4237416866117, 893.9329550283722, 895.6014573514789, 897.33148804141, 890.1676932068505, 890.692711014699, 896.4576431259093, 897.1253028297391, 900.009989012088, 934.6915517879117, 938.7934654376027, 942.4957647658504, 942.604106275366, 945.012461977232, 912.4935660708304, 920.3695468604028, 923.1184219070772, 924.2605915267759, 924.7503174142977, 684.5037347922766, 686.2485578291762, 686.2828344380085, 689.9517033807585, 689.9689513971883, 13363.866361336359, 13403.396847141901, 13502.257375844325, 13542.322883855768, 13703.862961370358, 13935.512257071056, 14127.364268607835, 14193.806393561366, 14391.78412323816, 14425.639359016004, 11668.474918628683, 11856.347900865449, 11895.881041189565, 11930.343831089287, 11953.043756499459, 2828.179827849921, 2828.6747024092288, 2853.9857300713365, 2858.5283428234316, 2862.3130448692373, 68846.65576672084, 68947.0, 69632.651836741, 69933.3006669932, 70648.0, 10043.497825108716, 10150.543225554868, 10152.137068349126, 10174.135198508062, 10242.385456872611, 18896.622067558572, 19065.42803715891, 20370.694439583418, 20485.18059277642, 20667.483312916997, 5982.162497250389, 6000.759969601254, 6102.633841969496, 6122.724477398528, 6125.081237814275, 2692.5826496893014, 2754.1599812057516, 2765.9031933882216, 2769.6399468069426, 2778.3609769752666, 3411.2324726936736, 3497.45789402643, 3510.4909788081095, 3516.9120771980906, 3517.56030496188, 673.2426020726682, 673.3636713305976, 674.2919934069306, 681.111149949311, 681.7716065118142, 506.4606194402949, 507.04675210604563, 510.9080365534239, 549.1405949688724, 551.4210079416597, 8778.91221087781, 9773.902260977442, 9967.651132210338, 10008.249381296286, 10090.032443673414, 543.6466296907042, 544.7004147718739, 546.4972225552422, 550.6008144095499, 559.5244042563869, 4044.5348784890116, 4299.097189590158, 4354.760488173118, 4378.890527736832, 4463.174312752087, 65763.0, 66749.0, 66872.33127668759, 66950.27094039303, 68214.3178568208, 59138.40861591415, 59597.10604340938, 59884.401155987885, 59918.700406497686, 60082.0, 53297.46702533003, 53710.462895371325, 54006.459935400926, 54387.728061360234, 54401.183982239505, 9847.212223021997, 10027.298089133983, 10033.949830251095, 10053.246006549683, 10240.18078553699, 27309.863450683413, 27352.316192095357, 28283.292917677223, 28387.148385548466, 29069.0, 33550.83224583862, 33963.3207335847, 34608.65391346054, 34737.0, 35529.822350888084, 13629.591112266648, 13826.792598110835, 13985.230812305013, 14008.229547374993, 14023.158610483404, 14432.42270309176, 14478.0, 14506.492272770402, 14810.777838332218, 15001.0, 14071.718565628425, 14355.856441435451, 14406.927965360106, 14428.927855360656, 14493.855061449673, 14151.221682807132, 14423.42306307736, 14516.782248266496, 14558.708825823212, 14874.925625371803, 13868.514601988882, 13931.233782142079, 14219.21794301282, 14363.353649086026, 14383.065100768417, 9828.361156525089, 10213.489325533843, 10295.588176473157, 10398.948005259925, 10588.523516441932, 11132.944335278271, 11659.475323610288, 11726.648200553997, 11783.293002419883, 11862.169648124549], "value": 6676.484311294694, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 111.0, 112.0, 112.0, 111.0, 112.0, 111.0, 112.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 125.0, 127.0, 172.0, 125.0, 127.0, 128.0, 128.0, 150.0, 126.0], "value": 136.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 163.0, 163.0, 170.0, 166.0, 177.0, 167.0, 163.0, 163.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 112.0, 75.0, 76.0, 76.0, 76.0, 100.0, 75.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 101.0, 84.0, 85.0, 84.0, 100.0, 84.0, 83.0, 103.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 115.0, 114.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 149.0, 153.0, 150.0, 150.0, 152.0, 151.0, 150.0, 150.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 55.0, 55.0, 56.0, 57.0, 55.0, 57.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 57.0, 55.0, 56.0, 55.0, 56.0, 55.0, 56.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 90.0, 83.0, 82.0, 80.0, 80.0, 81.0, 82.0, 80.0, 87.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 133.0, 136.0, 131.0, 141.0, 131.0, 132.0, 133.0, 181.0, 136.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 187.0, 198.0, 194.0, 195.0, 203.0, 193.0, 190.0, 193.0, 197.0], "value": 193.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 70.0, 71.0, 77.0, 71.0, 71.0, 77.0, 70.0], "value": 73.3, "unit": "score"}]}]} 07:03:13 INFO - Return code: 0 07:03:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:03:13 INFO - # TBPL SUCCESS # 07:03:13 INFO - Running post-action listener: _resource_record_post_action 07:03:13 INFO - [mozharness: 2017-05-05 14:03:13.598567Z] Finished run-tests step (success) 07:03:13 INFO - Running post-run listener: _resource_record_post_run 07:03:13 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 346124288; Read time: 176; Write time: 227576 07:03:13 INFO - TinderboxPrint: CPU usage
13.3% 07:03:13 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 176 07:03:13 INFO - TinderboxPrint: I/O write bytes / time
346,124,288 / 227,576 07:03:13 INFO - TinderboxPrint: CPU idle
8,297.4 (86.7%) 07:03:13 INFO - TinderboxPrint: CPU user
1,215.2 (12.7%) 07:03:13 INFO - TinderboxPrint: Swap in / out
0 / 0 07:03:13 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 97406976; Read time: 0; Write time: 82352 07:03:13 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 248147968; Read time: 164; Write time: 145192 07:03:14 INFO - Running post-run listener: _upload_blobber_files 07:03:14 INFO - Blob upload gear active. 07:03:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:03:14 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 07:03:14 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'] 07:03:14 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 07:03:14 INFO - (blobuploader) - INFO - Open directory for files ... 07:03:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:03:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:03:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:03:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:03:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:03:15 INFO - (blobuploader) - INFO - Done attempting. 07:03:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:03:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:03:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:03:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:03:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:03:16 INFO - (blobuploader) - INFO - Done attempting. 07:03:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:03:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:03:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:03:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:03:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:03:19 INFO - (blobuploader) - INFO - Done attempting. 07:03:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:03:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:03:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:03:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:03:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:03:21 INFO - (blobuploader) - INFO - Done attempting. 07:03:21 INFO - (blobuploader) - INFO - Iteration through files over. 07:03:21 INFO - Return code: 0 07:03:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:03:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:03:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d1f4470372da8a704ffb4aad0a3b3b5cd94ea62a63915035fe8297a9fc00d48edbf7da0f2593de00ef15e7a48e0395045dbcc91a46dcf670f5189f7c746e0d7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef52b67fc997c555cdf8ea5336c47639a94d0adfc7d1fd257de1017fc1ef5ecb3df10b2cd925770039e4552fa04d889f76b21fb90b5c8f8466c538cdf4eb686d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f1fe6a776367f2ef145bb60d16b2c149a360297fc2a08df2302ce0d81186e1f5426108058e0adc4e2d9119b6a381bffee41f14afa61e12ebaab6dc80be4ec4d9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b67a24d3f661fbbb705fa688e0ec4018d699f7d0aa775e73ce281055fb4bf7bde53391166aa9e4a26b3ae4d85e5908ca5d95abb3f4c8d2228ded67c850de54c9"} 07:03:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:03:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:03:21 INFO - Contents: 07:03:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d1f4470372da8a704ffb4aad0a3b3b5cd94ea62a63915035fe8297a9fc00d48edbf7da0f2593de00ef15e7a48e0395045dbcc91a46dcf670f5189f7c746e0d7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef52b67fc997c555cdf8ea5336c47639a94d0adfc7d1fd257de1017fc1ef5ecb3df10b2cd925770039e4552fa04d889f76b21fb90b5c8f8466c538cdf4eb686d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f1fe6a776367f2ef145bb60d16b2c149a360297fc2a08df2302ce0d81186e1f5426108058e0adc4e2d9119b6a381bffee41f14afa61e12ebaab6dc80be4ec4d9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b67a24d3f661fbbb705fa688e0ec4018d699f7d0aa775e73ce281055fb4bf7bde53391166aa9e4a26b3ae4d85e5908ca5d95abb3f4c8d2228ded67c850de54c9"} 07:03:21 INFO - Running post-run listener: copy_logs_to_upload_dir 07:03:21 INFO - Copying logs to upload dir... 07:03:21 INFO - mkdir: /builds/slave/test/build/upload/logs 07:03:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.209481 ========= master_lag: -0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-05-05 07:03:20.623570) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 07:03:20.628550) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d1f4470372da8a704ffb4aad0a3b3b5cd94ea62a63915035fe8297a9fc00d48edbf7da0f2593de00ef15e7a48e0395045dbcc91a46dcf670f5189f7c746e0d7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef52b67fc997c555cdf8ea5336c47639a94d0adfc7d1fd257de1017fc1ef5ecb3df10b2cd925770039e4552fa04d889f76b21fb90b5c8f8466c538cdf4eb686d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f1fe6a776367f2ef145bb60d16b2c149a360297fc2a08df2302ce0d81186e1f5426108058e0adc4e2d9119b6a381bffee41f14afa61e12ebaab6dc80be4ec4d9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b67a24d3f661fbbb705fa688e0ec4018d699f7d0aa775e73ce281055fb4bf7bde53391166aa9e4a26b3ae4d85e5908ca5d95abb3f4c8d2228ded67c850de54c9"} build_url:https://queue.taskcluster.net/v1/task/Kv1P-eslQbm4klZWpzN4LQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011353 build_url: 'https://queue.taskcluster.net/v1/task/Kv1P-eslQbm4klZWpzN4LQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d1f4470372da8a704ffb4aad0a3b3b5cd94ea62a63915035fe8297a9fc00d48edbf7da0f2593de00ef15e7a48e0395045dbcc91a46dcf670f5189f7c746e0d7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef52b67fc997c555cdf8ea5336c47639a94d0adfc7d1fd257de1017fc1ef5ecb3df10b2cd925770039e4552fa04d889f76b21fb90b5c8f8466c538cdf4eb686d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f1fe6a776367f2ef145bb60d16b2c149a360297fc2a08df2302ce0d81186e1f5426108058e0adc4e2d9119b6a381bffee41f14afa61e12ebaab6dc80be4ec4d9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b67a24d3f661fbbb705fa688e0ec4018d699f7d0aa775e73ce281055fb4bf7bde53391166aa9e4a26b3ae4d85e5908ca5d95abb3f4c8d2228ded67c850de54c9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 07:03:20.656852) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:03:20.657206) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1493991406.198111-311340171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004621 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:03:20.736919) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 07:03:20.739012) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 07:03:20.739406) ========= ========= Total master_lag: 0.08 =========